builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1469509994.37 results: success (0) buildid: 20160725203026 builduid: 2b87fc9b155e4445804412d751ffaebf revision: 94968a940273882150fc98556d4abf961b287ad8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:14.368981) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:14.369466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:14.369834) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:14.387273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:14.387895) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 22:13:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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.8M=0s 2016-07-25 22:13:14 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:14.526223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:14.526746) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019259 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:14.581144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:14.581526) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 94968a940273882150fc98556d4abf961b287ad8 --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 94968a940273882150fc98556d4abf961b287ad8 --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=5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 22:13:14,890 truncating revision to first 12 chars 2016-07-25 22:13:14,891 Setting DEBUG logging. 2016-07-25 22:13:14,891 attempt 1/10 2016-07-25 22:13:14,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/94968a940273?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 22:13:15,329 unpacking tar archive at: fx-team-94968a940273/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772204 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:15.369446) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:15.370088) ========= script_repo_revision: 94968a940273882150fc98556d4abf961b287ad8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:15.370859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:15.371407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 22:13:15.383828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-25 22:13:15.384530) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:13:15 INFO - MultiFileLogger online at 20160725 22:13:15 in /builds/slave/test 22:13:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:13:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:13:15 INFO - {'append_to_log': False, 22:13:15 INFO - 'base_work_dir': '/builds/slave/test', 22:13:15 INFO - 'blob_upload_branch': 'Fx-Team', 22:13:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:13:15 INFO - 'branch': 'Fx-Team', 22:13:15 INFO - 'buildbot_json_path': 'buildprops.json', 22:13:15 INFO - 'config_files': ('talos/linux_config.py',), 22:13:15 INFO - 'default_actions': ('clobber', 22:13:15 INFO - 'read-buildbot-config', 22:13:15 INFO - 'download-and-extract', 22:13:15 INFO - 'populate-webroot', 22:13:15 INFO - 'create-virtualenv', 22:13:15 INFO - 'install', 22:13:15 INFO - 'run-tests'), 22:13:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:13:15 INFO - 'download_minidump_stackwalk': True, 22:13:15 INFO - 'download_symbols': 'ondemand', 22:13:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:13:15 INFO - 'tooltool.py': '/tools/tooltool.py', 22:13:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:13:15 INFO - '/tools/misc-python/virtualenv.py')}, 22:13:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:13:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:13:15 INFO - 'installer_path': 'installer.exe', 22:13:15 INFO - 'log_level': 'info', 22:13:15 INFO - 'log_name': 'talos', 22:13:15 INFO - 'log_to_console': True, 22:13:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:13:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:13:15 INFO - 'opt_config_files': (), 22:13:15 INFO - 'pip_index': False, 22:13:15 INFO - 'sps_profile': False, 22:13:15 INFO - 'sps_profile_interval': 0, 22:13:15 INFO - 'suite': 'dromaeojs-e10s', 22:13:15 INFO - 'system_bits': '32', 22:13:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:13:15 INFO - 'title': 'talos-linux64-ix-011', 22:13:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:13:15 INFO - 'use_talos_json': True, 22:13:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:13:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:13:15 INFO - 'work_dir': 'build'} 22:13:15 INFO - [mozharness: 2016-07-26 05:13:15.786433Z] Running clobber step. 22:13:15 INFO - Running pre-action listener: _resource_record_pre_action 22:13:15 INFO - Running main action method: clobber 22:13:15 INFO - rmtree: /builds/slave/test/build 22:13:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:13:16 INFO - Running post-action listener: _resource_record_post_action 22:13:16 INFO - [mozharness: 2016-07-26 05:13:16.263509Z] Finished clobber step (success) 22:13:16 INFO - [mozharness: 2016-07-26 05:13:16.263610Z] Running read-buildbot-config step. 22:13:16 INFO - Running pre-action listener: _resource_record_pre_action 22:13:16 INFO - Running main action method: read_buildbot_config 22:13:16 INFO - Using buildbot properties: 22:13:16 INFO - { 22:13:16 INFO - "project": "", 22:13:16 INFO - "product": "firefox", 22:13:16 INFO - "script_repo_revision": "production", 22:13:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:13:16 INFO - "repository": "", 22:13:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:13:16 INFO - "buildid": "20160725203026", 22:13:16 INFO - "pgo_build": "True", 22:13:16 INFO - "basedir": "/builds/slave/test", 22:13:16 INFO - "buildnumber": 638, 22:13:16 INFO - "slavename": "talos-linux64-ix-011", 22:13:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:13:16 INFO - "platform": "ubuntu64_hw", 22:13:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:13:16 INFO - "branch": "fx-team", 22:13:16 INFO - "repo_path": "integration/fx-team", 22:13:16 INFO - "revision": "94968a940273882150fc98556d4abf961b287ad8", 22:13:16 INFO - "stage_platform": "linux64-pgo", 22:13:16 INFO - "builduid": "2b87fc9b155e4445804412d751ffaebf", 22:13:16 INFO - "slavebuilddir": "test" 22:13:16 INFO - } 22:13:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:13:16 INFO - Running post-action listener: _resource_record_post_action 22:13:16 INFO - [mozharness: 2016-07-26 05:13:16.266028Z] Finished read-buildbot-config step (success) 22:13:16 INFO - [mozharness: 2016-07-26 05:13:16.266118Z] Running download-and-extract step. 22:13:16 INFO - Running pre-action listener: _resource_record_pre_action 22:13:16 INFO - Running main action method: download_and_extract 22:13:16 INFO - mkdir: /builds/slave/test/build/tests 22:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:16 INFO - https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:13:16 INFO - Downloaded 1361 bytes. 22:13:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:13:16 INFO - Using the following test package requirements: 22:13:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:13:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:13:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:16 INFO - u'jsshell-linux-x86_64.zip'], 22:13:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:13:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:13:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:13:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:13:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:13:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:16 INFO - https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:17 INFO - Downloaded 24311872 bytes. 22:13:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:13:19 INFO - Return code: 0 22:13:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:13:19 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')]} 22:13:19 INFO - https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:21 INFO - Downloaded 24311872 bytes. 22:13:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:13:23 INFO - Return code: 0 22:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:23 INFO - https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:13:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:13:24 INFO - Downloaded 14403248 bytes. 22:13:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:13:24 INFO - Return code: 0 22:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:24 INFO - https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:13:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:13:25 INFO - Downloaded 60891209 bytes. 22:13:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:25 INFO - mkdir: /builds/slave/test/properties 22:13:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:13:25 INFO - Writing to file /builds/slave/test/properties/build_url 22:13:25 INFO - Contents: 22:13:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:26 INFO - Running post-action listener: _resource_record_post_action 22:13:26 INFO - Running post-action listener: set_extra_try_arguments 22:13:26 INFO - [mozharness: 2016-07-26 05:13:26.479970Z] Finished download-and-extract step (success) 22:13:26 INFO - [mozharness: 2016-07-26 05:13:26.480294Z] Running populate-webroot step. 22:13:26 INFO - Running pre-action listener: _resource_record_pre_action 22:13:26 INFO - Running main action method: populate_webroot 22:13:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:13:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:13:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:13:26 INFO - '--tppagecycles', 22:13:26 INFO - '7'], 22:13:26 INFO - 'tests': ['tsvgm']}}, 22:13:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:13:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:13:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:13:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:13:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:26 INFO - 'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:26 INFO - 'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['damp', 'tps']}, 22:13:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:26 INFO - 'tests': ['damp', 'tps']}, 22:13:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['dromaeo_dom']}, 22:13:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:13:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['basic_compositor_video']}, 22:13:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:13:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['a11yr', 22:13:26 INFO - 'ts_paint', 22:13:26 INFO - 'tpaint', 22:13:26 INFO - 'sessionrestore', 22:13:26 INFO - 'sessionrestore_no_auto_restore', 22:13:26 INFO - 'tabpaint']}, 22:13:26 INFO - 'other-e10s': {'tests': ['a11yr', 22:13:26 INFO - 'ts_paint', 22:13:26 INFO - 'tpaint', 22:13:26 INFO - 'sessionrestore', 22:13:26 INFO - 'sessionrestore_no_auto_restore', 22:13:26 INFO - 'tabpaint']}, 22:13:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:13:26 INFO - 'ts_paint', 22:13:26 INFO - 'tpaint', 22:13:26 INFO - 'sessionrestore', 22:13:26 INFO - 'sessionrestore_no_auto_restore', 22:13:26 INFO - 'tabpaint']}, 22:13:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:13:26 INFO - 'ts_paint', 22:13:26 INFO - 'tpaint', 22:13:26 INFO - 'sessionrestore', 22:13:26 INFO - 'sessionrestore_no_auto_restore', 22:13:26 INFO - 'tabpaint']}, 22:13:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['a11yr', 22:13:26 INFO - 'ts_paint', 22:13:26 INFO - 'tpaint', 22:13:26 INFO - 'sessionrestore', 22:13:26 INFO - 'sessionrestore_no_auto_restore', 22:13:26 INFO - 'tabpaint']}, 22:13:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['a11yr', 22:13:26 INFO - 'ts_paint', 22:13:26 INFO - 'tpaint', 22:13:26 INFO - 'sessionrestore', 22:13:26 INFO - 'sessionrestore_no_auto_restore', 22:13:26 INFO - 'tabpaint']}, 22:13:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['tsvgx', 22:13:26 INFO - 'tsvgr_opacity', 22:13:26 INFO - 'tart', 22:13:26 INFO - 'tscrollx', 22:13:26 INFO - 'cart']}, 22:13:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:13:26 INFO - 'tsvgr_opacity', 22:13:26 INFO - 'tart', 22:13:26 INFO - 'tscrollx', 22:13:26 INFO - 'cart']}, 22:13:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:26 INFO - 'talos_options': ['--disable-e10s'], 22:13:26 INFO - 'tests': ['tp5o']}, 22:13:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:26 INFO - 'tests': ['tp5o']}, 22:13:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:26 INFO - 'talos_options': ['--disable-e10s', 22:13:26 INFO - '--xperf_path', 22:13:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:26 INFO - 'tests': ['tp5n']}, 22:13:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:26 INFO - 'talos_options': ['--xperf_path', 22:13:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:26 INFO - 'tests': ['tp5n']}}, 22:13:26 INFO - 'talos.zip': {'path': '', 22:13:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:13:26 INFO - Running post-action listener: _resource_record_post_action 22:13:26 INFO - [mozharness: 2016-07-26 05:13:26.496420Z] Finished populate-webroot step (success) 22:13:26 INFO - [mozharness: 2016-07-26 05:13:26.496509Z] Running create-virtualenv step. 22:13:26 INFO - Running pre-action listener: _resource_record_pre_action 22:13:26 INFO - Running main action method: create_virtualenv 22:13:26 INFO - Creating virtualenv /builds/slave/test/build/venv 22:13:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:13:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:13:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:13:26 INFO - Using real prefix '/usr' 22:13:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:13:27 INFO - Installing distribute.............................................................................................................................................................................................done. 22:13:29 INFO - Installing pip.................done. 22:13:29 INFO - Return code: 0 22:13:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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')]} 22:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:13:29 INFO - Using env: {'DISPLAY': ':0', 22:13:29 INFO - 'HOME': '/home/cltbld', 22:13:29 INFO - 'LANG': 'en_US.UTF-8', 22:13:29 INFO - 'LANGUAGE': 'en_US:en', 22:13:29 INFO - 'LOGNAME': 'cltbld', 22:13:29 INFO - 'MAIL': '/var/mail/cltbld', 22:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:29 INFO - 'MOZ_NO_REMOTE': '1', 22:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:29 INFO - 'NO_EM_RESTART': '1', 22:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:29 INFO - 'PWD': '/builds/slave/test', 22:13:29 INFO - 'SHELL': '/bin/bash', 22:13:29 INFO - 'SHLVL': '1', 22:13:29 INFO - 'TERM': 'linux', 22:13:29 INFO - 'TMOUT': '86400', 22:13:29 INFO - 'USER': 'cltbld', 22:13:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:29 INFO - '_': '/tools/buildbot/bin/python'} 22:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:13:29 INFO - Cleaning up... 22:13:29 INFO - Return code: 0 22:13:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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')]} 22:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:13:29 INFO - Using env: {'DISPLAY': ':0', 22:13:29 INFO - 'HOME': '/home/cltbld', 22:13:29 INFO - 'LANG': 'en_US.UTF-8', 22:13:29 INFO - 'LANGUAGE': 'en_US:en', 22:13:29 INFO - 'LOGNAME': 'cltbld', 22:13:29 INFO - 'MAIL': '/var/mail/cltbld', 22:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:29 INFO - 'MOZ_NO_REMOTE': '1', 22:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:29 INFO - 'NO_EM_RESTART': '1', 22:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:29 INFO - 'PWD': '/builds/slave/test', 22:13:29 INFO - 'SHELL': '/bin/bash', 22:13:29 INFO - 'SHLVL': '1', 22:13:29 INFO - 'TERM': 'linux', 22:13:29 INFO - 'TMOUT': '86400', 22:13:29 INFO - 'USER': 'cltbld', 22:13:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:29 INFO - '_': '/tools/buildbot/bin/python'} 22:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:29 INFO - Downloading/unpacking psutil>=3.1.1 22:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:13:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:31 INFO - Installing collected packages: psutil 22:13:31 INFO - Running setup.py install for psutil 22:13:31 INFO - building 'psutil._psutil_linux' extension 22:13:31 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 22:13:31 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 22:13:31 INFO - building 'psutil._psutil_posix' extension 22:13:31 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 22:13:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:32 INFO - Successfully installed psutil 22:13:32 INFO - Cleaning up... 22:13:32 INFO - Return code: 0 22:13:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:13:32 INFO - Using env: {'DISPLAY': ':0', 22:13:32 INFO - 'HOME': '/home/cltbld', 22:13:32 INFO - 'LANG': 'en_US.UTF-8', 22:13:32 INFO - 'LANGUAGE': 'en_US:en', 22:13:32 INFO - 'LOGNAME': 'cltbld', 22:13:32 INFO - 'MAIL': '/var/mail/cltbld', 22:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:32 INFO - 'MOZ_NO_REMOTE': '1', 22:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:32 INFO - 'NO_EM_RESTART': '1', 22:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:32 INFO - 'PWD': '/builds/slave/test', 22:13:32 INFO - 'SHELL': '/bin/bash', 22:13:32 INFO - 'SHLVL': '1', 22:13:32 INFO - 'TERM': 'linux', 22:13:32 INFO - 'TMOUT': '86400', 22:13:32 INFO - 'USER': 'cltbld', 22:13:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:32 INFO - '_': '/tools/buildbot/bin/python'} 22:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:13:34 INFO - Installing collected packages: mozsystemmonitor 22:13:34 INFO - Running setup.py install for mozsystemmonitor 22:13:34 INFO - Successfully installed mozsystemmonitor 22:13:34 INFO - Cleaning up... 22:13:34 INFO - Return code: 0 22:13:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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')]} 22:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:13:34 INFO - Using env: {'DISPLAY': ':0', 22:13:34 INFO - 'HOME': '/home/cltbld', 22:13:34 INFO - 'LANG': 'en_US.UTF-8', 22:13:34 INFO - 'LANGUAGE': 'en_US:en', 22:13:34 INFO - 'LOGNAME': 'cltbld', 22:13:34 INFO - 'MAIL': '/var/mail/cltbld', 22:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:34 INFO - 'MOZ_NO_REMOTE': '1', 22:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:34 INFO - 'NO_EM_RESTART': '1', 22:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:34 INFO - 'PWD': '/builds/slave/test', 22:13:34 INFO - 'SHELL': '/bin/bash', 22:13:34 INFO - 'SHLVL': '1', 22:13:34 INFO - 'TERM': 'linux', 22:13:34 INFO - 'TMOUT': '86400', 22:13:34 INFO - 'USER': 'cltbld', 22:13:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:34 INFO - '_': '/tools/buildbot/bin/python'} 22:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:34 INFO - Downloading/unpacking jsonschema==2.5.1 22:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:13:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:36 INFO - Downloading functools32-3.2.3-2.tar.gz 22:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:13:36 INFO - warning: no files found matching '*.txt' 22:13:36 INFO - no previously-included directories found matching 'build' 22:13:36 INFO - no previously-included directories found matching 'dist' 22:13:36 INFO - no previously-included directories found matching '.git*' 22:13:36 INFO - Installing collected packages: jsonschema, functools32 22:13:36 INFO - Running setup.py install for functools32 22:13:36 INFO - warning: no files found matching '*.txt' 22:13:37 INFO - no previously-included directories found matching 'build' 22:13:37 INFO - no previously-included directories found matching 'dist' 22:13:37 INFO - no previously-included directories found matching '.git*' 22:13:37 INFO - Successfully installed jsonschema functools32 22:13:37 INFO - Cleaning up... 22:13:37 INFO - Return code: 0 22:13:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:13:37 INFO - Using env: {'DISPLAY': ':0', 22:13:37 INFO - 'HOME': '/home/cltbld', 22:13:37 INFO - 'LANG': 'en_US.UTF-8', 22:13:37 INFO - 'LANGUAGE': 'en_US:en', 22:13:37 INFO - 'LOGNAME': 'cltbld', 22:13:37 INFO - 'MAIL': '/var/mail/cltbld', 22:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:37 INFO - 'MOZ_NO_REMOTE': '1', 22:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:37 INFO - 'NO_EM_RESTART': '1', 22:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:37 INFO - 'PWD': '/builds/slave/test', 22:13:37 INFO - 'SHELL': '/bin/bash', 22:13:37 INFO - 'SHLVL': '1', 22:13:37 INFO - 'TERM': 'linux', 22:13:37 INFO - 'TMOUT': '86400', 22:13:37 INFO - 'USER': 'cltbld', 22:13:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:37 INFO - '_': '/tools/buildbot/bin/python'} 22:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:13:37 INFO - Cleaning up... 22:13:37 INFO - Return code: 0 22:13:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:13:37 INFO - Using env: {'DISPLAY': ':0', 22:13:37 INFO - 'HOME': '/home/cltbld', 22:13:37 INFO - 'LANG': 'en_US.UTF-8', 22:13:37 INFO - 'LANGUAGE': 'en_US:en', 22:13:37 INFO - 'LOGNAME': 'cltbld', 22:13:37 INFO - 'MAIL': '/var/mail/cltbld', 22:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:37 INFO - 'MOZ_NO_REMOTE': '1', 22:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:37 INFO - 'NO_EM_RESTART': '1', 22:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:37 INFO - 'PWD': '/builds/slave/test', 22:13:37 INFO - 'SHELL': '/bin/bash', 22:13:37 INFO - 'SHLVL': '1', 22:13:37 INFO - 'TERM': 'linux', 22:13:37 INFO - 'TMOUT': '86400', 22:13:37 INFO - 'USER': 'cltbld', 22:13:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:37 INFO - '_': '/tools/buildbot/bin/python'} 22:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:37 INFO - Downloading/unpacking blobuploader==1.2.4 22:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:39 INFO - Downloading blobuploader-1.2.4.tar.gz 22:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:13:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:13:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:40 INFO - Downloading docopt-0.6.1.tar.gz 22:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:13:40 INFO - Installing collected packages: blobuploader, requests, docopt 22:13:40 INFO - Running setup.py install for blobuploader 22:13:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:13:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:13:40 INFO - Running setup.py install for requests 22:13:40 INFO - Running setup.py install for docopt 22:13:40 INFO - Successfully installed blobuploader requests docopt 22:13:40 INFO - Cleaning up... 22:13:40 INFO - Return code: 0 22:13:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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')]} 22:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:40 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 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13:40 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 22:13:40 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 22:13:40 INFO - Using env: {'DISPLAY': ':0', 22:13:40 INFO - 'HOME': '/home/cltbld', 22:13:40 INFO - 'LANG': 'en_US.UTF-8', 22:13:40 INFO - 'LANGUAGE': 'en_US:en', 22:13:40 INFO - 'LOGNAME': 'cltbld', 22:13:40 INFO - 'MAIL': '/var/mail/cltbld', 22:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:40 INFO - 'MOZ_NO_REMOTE': '1', 22:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:40 INFO - 'NO_EM_RESTART': '1', 22:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:40 INFO - 'PWD': '/builds/slave/test', 22:13:40 INFO - 'SHELL': '/bin/bash', 22:13:40 INFO - 'SHLVL': '1', 22:13:40 INFO - 'TERM': 'linux', 22:13:40 INFO - 'TMOUT': '86400', 22:13:40 INFO - 'USER': 'cltbld', 22:13:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:40 INFO - '_': '/tools/buildbot/bin/python'} 22:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:41 INFO - Running setup.py (path:/tmp/pip-CYD9c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:41 INFO - Running setup.py (path:/tmp/pip-norSjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:41 INFO - Running setup.py (path:/tmp/pip-f0jyTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:41 INFO - Running setup.py (path:/tmp/pip-1SxDaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:41 INFO - Running setup.py (path:/tmp/pip-PSpr4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:41 INFO - Running setup.py (path:/tmp/pip-z_mYqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:41 INFO - Running setup.py (path:/tmp/pip-ztu6AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:41 INFO - Running setup.py (path:/tmp/pip-mZoOzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:41 INFO - Running setup.py (path:/tmp/pip-1D9qaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:41 INFO - Running setup.py (path:/tmp/pip-5yNZ06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:41 INFO - Running setup.py (path:/tmp/pip-aczC1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:41 INFO - Running setup.py (path:/tmp/pip-svihCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:41 INFO - Running setup.py (path:/tmp/pip-7LHt7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:41 INFO - Running setup.py (path:/tmp/pip-va5FCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:42 INFO - Running setup.py (path:/tmp/pip-tjaXVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:42 INFO - Running setup.py (path:/tmp/pip-Stj0sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:42 INFO - Running setup.py (path:/tmp/pip-R7jQEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:42 INFO - Running setup.py install for manifestparser 22:13:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:13:42 INFO - Running setup.py install for mozcrash 22:13:42 INFO - Running setup.py install for mozdebug 22:13:42 INFO - Running setup.py install for mozdevice 22:13:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:13:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:13:42 INFO - Running setup.py install for mozfile 22:13:42 INFO - Running setup.py install for mozhttpd 22:13:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:13:42 INFO - Running setup.py install for mozinfo 22:13:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:13:42 INFO - Running setup.py install for mozInstall 22:13:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Running setup.py install for mozleak 22:13:43 INFO - Running setup.py install for mozlog 22:13:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Running setup.py install for moznetwork 22:13:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Running setup.py install for mozprocess 22:13:43 INFO - Running setup.py install for mozprofile 22:13:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Running setup.py install for mozrunner 22:13:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:13:43 INFO - Running setup.py install for mozscreenshot 22:13:43 INFO - Running setup.py install for moztest 22:13:43 INFO - Running setup.py install for mozversion 22:13:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:13:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:44 INFO - Cleaning up... 22:13:44 INFO - Return code: 0 22:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:44 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 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13:44 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 22:13:44 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 22:13:44 INFO - Using env: {'DISPLAY': ':0', 22:13:44 INFO - 'HOME': '/home/cltbld', 22:13:44 INFO - 'LANG': 'en_US.UTF-8', 22:13:44 INFO - 'LANGUAGE': 'en_US:en', 22:13:44 INFO - 'LOGNAME': 'cltbld', 22:13:44 INFO - 'MAIL': '/var/mail/cltbld', 22:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:44 INFO - 'MOZ_NO_REMOTE': '1', 22:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:44 INFO - 'NO_EM_RESTART': '1', 22:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:44 INFO - 'PWD': '/builds/slave/test', 22:13:44 INFO - 'SHELL': '/bin/bash', 22:13:44 INFO - 'SHLVL': '1', 22:13:44 INFO - 'TERM': 'linux', 22:13:44 INFO - 'TMOUT': '86400', 22:13:44 INFO - 'USER': 'cltbld', 22:13:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:44 INFO - '_': '/tools/buildbot/bin/python'} 22:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:44 INFO - Running setup.py (path:/tmp/pip-zhaoes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:44 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:44 INFO - Running setup.py (path:/tmp/pip-KE_hwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:44 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:44 INFO - Running setup.py (path:/tmp/pip-34CYZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:44 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:44 INFO - Running setup.py (path:/tmp/pip-NOsnNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:44 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:44 INFO - Running setup.py (path:/tmp/pip-JC2W87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:44 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:44 INFO - Running setup.py (path:/tmp/pip-JA2M0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:44 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:44 INFO - Running setup.py (path:/tmp/pip-Rg0eoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:44 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:44 INFO - Running setup.py (path:/tmp/pip-pub66r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:44 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:44 INFO - Running setup.py (path:/tmp/pip-W5EKLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:44 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:44 INFO - Running setup.py (path:/tmp/pip-fFAvs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 22:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:45 INFO - Running setup.py (path:/tmp/pip-A7eRys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:45 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)) 22:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:45 INFO - Running setup.py (path:/tmp/pip-Iu0aYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 22:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:45 INFO - Running setup.py (path:/tmp/pip-8yNCwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:45 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)) 22:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:45 INFO - Running setup.py (path:/tmp/pip-caipyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 22:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:45 INFO - Running setup.py (path:/tmp/pip-AUmKBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:45 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)) 22:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:45 INFO - Running setup.py (path:/tmp/pip-S0buYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:45 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)) 22:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:45 INFO - Running setup.py (path:/tmp/pip-zQX7qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:45 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)) 22:13:45 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)) 22:13:45 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)) 22:13:45 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)) 22:13:45 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)) 22:13:45 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)) 22:13:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:13:45 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 22:13:45 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 22:13:45 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 22:13:45 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 22:13:45 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 22:13:45 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 22:13:47 INFO - Downloading blessings-1.6.tar.gz 22:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:13:47 INFO - Installing collected packages: blessings 22:13:47 INFO - Running setup.py install for blessings 22:13:47 INFO - Successfully installed blessings 22:13:47 INFO - Cleaning up... 22:13:47 INFO - Return code: 0 22:13:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:13:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:47 INFO - Reading from file tmpfile_stdout 22:13:47 INFO - Current package versions: 22:13:47 INFO - argparse == 1.2.1 22:13:47 INFO - blessings == 1.6 22:13:47 INFO - blobuploader == 1.2.4 22:13:47 INFO - docopt == 0.6.1 22:13:47 INFO - functools32 == 3.2.3-2 22:13:47 INFO - jsonschema == 2.5.1 22:13:47 INFO - manifestparser == 1.1 22:13:47 INFO - mozInstall == 1.12 22:13:47 INFO - mozcrash == 0.17 22:13:47 INFO - mozdebug == 0.1 22:13:47 INFO - mozdevice == 0.48 22:13:47 INFO - mozfile == 1.2 22:13:47 INFO - mozhttpd == 0.7 22:13:47 INFO - mozinfo == 0.9 22:13:47 INFO - mozleak == 0.1 22:13:47 INFO - mozlog == 3.3 22:13:47 INFO - moznetwork == 0.27 22:13:47 INFO - mozprocess == 0.23 22:13:47 INFO - mozprofile == 0.28 22:13:47 INFO - mozrunner == 6.12 22:13:47 INFO - mozscreenshot == 0.1 22:13:47 INFO - mozsystemmonitor == 0.3 22:13:47 INFO - moztest == 0.7 22:13:47 INFO - mozversion == 1.4 22:13:47 INFO - psutil == 3.1.1 22:13:47 INFO - requests == 1.2.3 22:13:47 INFO - wsgiref == 0.1.2 22:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:47 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 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13:47 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 22:13:47 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 22:13:47 INFO - Using env: {'DISPLAY': ':0', 22:13:47 INFO - 'HOME': '/home/cltbld', 22:13:47 INFO - 'LANG': 'en_US.UTF-8', 22:13:47 INFO - 'LANGUAGE': 'en_US:en', 22:13:47 INFO - 'LOGNAME': 'cltbld', 22:13:47 INFO - 'MAIL': '/var/mail/cltbld', 22:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:47 INFO - 'MOZ_NO_REMOTE': '1', 22:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:47 INFO - 'NO_EM_RESTART': '1', 22:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:47 INFO - 'PWD': '/builds/slave/test', 22:13:47 INFO - 'SHELL': '/bin/bash', 22:13:47 INFO - 'SHLVL': '1', 22:13:47 INFO - 'TERM': 'linux', 22:13:47 INFO - 'TMOUT': '86400', 22:13:47 INFO - 'USER': 'cltbld', 22:13:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:47 INFO - '_': '/tools/buildbot/bin/python'} 22:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:48 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)) 22:13:48 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)) 22:13:48 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)) 22:13:48 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)) 22:13:48 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)) 22:13:48 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)) 22:13:48 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)) 22:13:48 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)) 22:13:48 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)) 22:13:48 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)) 22:13:48 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)) 22:13:48 INFO - Cleaning up... 22:13:48 INFO - Return code: 0 22:13:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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')]} 22:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', '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 22:13: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', 'jsonschema'] in /builds/slave/test/build 22:13: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 jsonschema 22:13:48 INFO - Using env: {'DISPLAY': ':0', 22:13:48 INFO - 'HOME': '/home/cltbld', 22:13:48 INFO - 'LANG': 'en_US.UTF-8', 22:13:48 INFO - 'LANGUAGE': 'en_US:en', 22:13:48 INFO - 'LOGNAME': 'cltbld', 22:13:48 INFO - 'MAIL': '/var/mail/cltbld', 22:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:48 INFO - 'MOZ_NO_REMOTE': '1', 22:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:48 INFO - 'NO_EM_RESTART': '1', 22:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:48 INFO - 'PWD': '/builds/slave/test', 22:13:48 INFO - 'SHELL': '/bin/bash', 22:13:48 INFO - 'SHLVL': '1', 22:13:48 INFO - 'TERM': 'linux', 22:13:48 INFO - 'TMOUT': '86400', 22:13:48 INFO - 'USER': 'cltbld', 22:13:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:48 INFO - '_': '/tools/buildbot/bin/python'} 22:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:13:48 INFO - Cleaning up... 22:13:48 INFO - Return code: 0 22:13:48 INFO - Running post-action listener: _resource_record_post_action 22:13:48 INFO - Running post-action listener: _start_resource_monitoring 22:13:48 INFO - Starting resource monitoring. 22:13:48 INFO - [mozharness: 2016-07-26 05:13:48.343170Z] Finished create-virtualenv step (success) 22:13:48 INFO - [mozharness: 2016-07-26 05:13:48.343652Z] Running install step. 22:13:48 INFO - Running pre-action listener: _resource_record_pre_action 22:13:48 INFO - Running main action method: install 22:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:48 INFO - Reading from file tmpfile_stdout 22:13:48 INFO - Detecting whether we're running mozinstall >=1.0... 22:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:13:48 INFO - Reading from file tmpfile_stdout 22:13:48 INFO - Output received: 22:13:48 INFO - Usage: mozinstall [options] installer 22:13:48 INFO - Options: 22:13:48 INFO - -h, --help show this help message and exit 22:13:48 INFO - -d DEST, --destination=DEST 22:13:48 INFO - Directory to install application into. [default: 22:13:48 INFO - "/builds/slave/test"] 22:13:48 INFO - --app=APP Application being installed. [default: firefox] 22:13:48 INFO - mkdir: /builds/slave/test/build/application 22:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:14:08 INFO - Reading from file tmpfile_stdout 22:14:08 INFO - Output received: 22:14:08 INFO - /builds/slave/test/build/application/firefox/firefox 22:14:08 INFO - Running post-action listener: _resource_record_post_action 22:14:08 INFO - [mozharness: 2016-07-26 05:14:08.341401Z] Finished install step (success) 22:14:08 INFO - [mozharness: 2016-07-26 05:14:08.341681Z] Running run-tests step. 22:14:08 INFO - Running pre-action listener: _resource_record_pre_action 22:14:08 INFO - Running main action method: run_tests 22:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:14:08 INFO - Python 2.7.3 22:14:08 INFO - Return code: 0 22:14:08 INFO - grabbing minidump binary from tooltool 22:14:08 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')]} 22:14:08 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 0x237f3b0>, '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 0x23802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2380740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:14:08 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 22:14:08 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 22:14:08 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 22:14:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:14:08 INFO - Return code: 0 22:14:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:14:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:14:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:14:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:14:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 22:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 22:14:08 INFO - Using env: {'DISPLAY': ':0', 22:14:08 INFO - 'HOME': '/home/cltbld', 22:14:08 INFO - 'LANG': 'en_US.UTF-8', 22:14:08 INFO - 'LANGUAGE': 'en_US:en', 22:14:08 INFO - 'LOGNAME': 'cltbld', 22:14:08 INFO - 'MAIL': '/var/mail/cltbld', 22:14:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:14:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:08 INFO - 'MOZ_NO_REMOTE': '1', 22:14:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:08 INFO - 'NO_EM_RESTART': '1', 22:14:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:08 INFO - 'PWD': '/builds/slave/test', 22:14:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:14:08 INFO - 'SHELL': '/bin/bash', 22:14:08 INFO - 'SHLVL': '1', 22:14:08 INFO - 'TERM': 'linux', 22:14:08 INFO - 'TMOUT': '86400', 22:14:08 INFO - 'USER': 'cltbld', 22:14:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900', 22:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:08 INFO - '_': '/tools/buildbot/bin/python'} 22:14:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 22:14:08 INFO - mozversion application_buildid: 20160725203026 22:14:08 INFO - mozversion application_changeset: 94968a940273882150fc98556d4abf961b287ad8 22:14:08 INFO - mozversion application_display_name: Nightly 22:14:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:14:08 INFO - mozversion application_name: Firefox 22:14:08 INFO - mozversion application_remotingname: firefox 22:14:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:14:08 INFO - mozversion application_vendor: Mozilla 22:14:08 INFO - mozversion application_version: 50.0a1 22:14:08 INFO - mozversion platform_buildid: 20160725203026 22:14:08 INFO - mozversion platform_changeset: 94968a940273882150fc98556d4abf961b287ad8 22:14:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:14:08 INFO - mozversion platform_version: 50.0a1 22:14:08 INFO - using testdate: 1469510048 22:14:08 INFO - actual date: 1469510048 22:14:08 INFO - starting webserver on 'localhost:33654' 22:14:08 INFO - SUITE-START | Running 2 tests 22:14:08 INFO - TEST-START | dromaeo_css 22:14:08 INFO - operating with platform_type : linux_ 22:14:08 INFO - Initialising browser for dromaeo_css test... 22:14:08 INFO - TEST-INFO | started process 22467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboyOAO/profile http://localhost:33654/getInfo.html) 22:14:12 INFO - PROCESS | 22467 | JavaScript error: , line 0: uncaught exception: undefined 22:14:13 INFO - PROCESS | 22467 | __metrics Screen width/height:1600/1200 22:14:13 INFO - PROCESS | 22467 | colorDepth:24 22:14:13 INFO - PROCESS | 22467 | Browser inner width/height: 1024/697 22:14:13 INFO - PROCESS | 22467 | __metrics 22:14:14 ERROR - PROCESS | 22467 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 22:14:15 INFO - TEST-INFO | 22467: exit 0 22:14:15 INFO - Browser initialized. 22:14:15 INFO - Running cycle 1/1 for dromaeo_css test... 22:14:15 INFO - TEST-INFO | started process 22586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboyOAO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:27 INFO - PROCESS | 22586 | RSS: Main: 164757504 22:14:27 INFO - PROCESS | 22586 | 22:15:16 INFO - PROCESS | 22586 | 1469510116928 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] 22:17:25 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:33654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33654/tests/dromaeo/cssquery-ext.html) 22:17:26 INFO - PROCESS | 22586 | RSS: Main: 169345024 22:17:26 INFO - PROCESS | 22586 | 22:20:28 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:33654/tests/dromaeo/cssquery-ext.html (next: http://localhost:33654/tests/dromaeo/cssquery-jquery.html) 22:20:29 INFO - PROCESS | 22586 | RSS: Main: 165871616 22:20:29 INFO - PROCESS | 22586 | 22:23:30 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:33654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33654/tests/dromaeo/cssquery-mootools.html) 22:23:31 INFO - PROCESS | 22586 | RSS: Main: 171216896 22:23:31 INFO - PROCESS | 22586 | 22:26:33 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:33654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33654/tests/dromaeo/cssquery-prototype.html) 22:26:33 INFO - PROCESS | 22586 | RSS: Main: 165433344 22:26:33 INFO - PROCESS | 22586 | 22:29:36 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:33654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33654/tests/dromaeo/cssquery-yui.html) 22:29:37 INFO - PROCESS | 22586 | RSS: Main: 167481344 22:29:37 INFO - PROCESS | 22586 | 22:32:40 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:33654/tests/dromaeo/cssquery-yui.html (next: http://localhost:33654/tests/dromaeo/cssquery-dojo.html) 22:32:40 INFO - PROCESS | 22586 | RSS: Main: 170872832 22:32:40 INFO - PROCESS | 22586 | 22:32:40 INFO - PROCESS | 22586 | __start_tp_report 22:32:40 INFO - PROCESS | 22586 | _x_x_mozilla_page_load 22:32:40 INFO - PROCESS | 22586 | _x_x_mozilla_page_load_details 22:32:40 INFO - PROCESS | 22586 | |i|pagename|runs| 22:32:40 INFO - PROCESS | 22586 | |0;dojo.html;3117.4700300948834;3144.5754823098882;3158.478850989587;3171.429142754304;3176.047185844246;5462.426445223254;5494.670319780816;5513.365962914266;5530.723463826813;5576.219329293892;5533.723313834303;5555.388907220203;5582.665040097587;5584.7207639617955;5634.943650563493;4928.728919909412;5029.270755740416;5081.644284900059;5098.490150984909;5276.577873770108;5184.2223666450145;5216.165413533835;5224.686518808865;5277.70972596507;5278.445763194867;4973.403191617011;5029.673071250394;5058.671186372892;5061.063703214881;5080;5041.899162016739;5060.493950604947;5068.619853511002;5073.771680274396;5085.415177254626;4994.500549945013;5026.145555255615;5026.84919452417;5044.823431179928;5050.621203409759;5428.592855535811;5451.073317536028;5588.776448942038;5592.636478628917;5600.943990560083;6058.1518587397795;6058.606190597597;6058.787942422038;6060.272767267912;6093.634381937098;6069.211002569682;6099.969500152515;6104.420080092428;6105.633661980251;6109.236345456818;5485.067538518461;5626.971865140648;5653.745581448845;5667.4615911488345;5696.658200507983;6183.0107182850525;6185.969070154711;6188.907166392508;6195.845103872349;6198.597091189148;5960.791372302036;5971.28344598651;5973.55198360116;5974.2830860297045;6016.157737916695;5835.153902684087;5890.734916928663;5924.377940316291;5946.881062378815;5972.731227094791;5789;5908.05471124618;5961.940380596226;5974.074018527135;5980.401959804072;5962.940370596325;5965.403459654;6001.669908155093;6011.218541589566;6018.277806663228;4403.691741578059;4537.274036154199;4538.614217791459;4540.137373899015;4588.49526552079;3977.482927219443;4015.1166743316426;4022.3162062449455;4032.2338755636333;4076.775777332216;5694.97152514243;5700.686462244534;5708.828735137952;5721.828345149569;5741.052726300197;5763.2507773989955;6033.155358249848;6047.485963693048;6048.334683184846;6069.119977603223;5614.550835933197;5644.3508996465935;5661.915071273934;5715.428457154335;5768.423157684282;5127.692338459704;5136.9743151284;5138.460461651547;5144.819931302386;5155.639105262596;6006.879862402728;6099.725512351954;6154.630722156685;6196.0705894116245;6199.597026193283;5942.346341902387;5951.018082016592;5994.520438365008;6048.546359023003;6077.574569780073;6157.1072194532435;6159.23009623797;6169.753209871555;6171.753129874754;6188.195534580475;5732.799352022659;5883.117532370179;5925.170476133431;5928.199693041557;5931;6014.72933717975;6019.608725432833;6047.969760151171;6097.75608975636;6126;5892.351841297368;5893.941060589339;5913.615614985012;5922.289325280822;5931.466168044896;5721.284839395075;5917.733701983335;5932.49573786233;5939.584229104094;5946.464818166386;5698.287714035746;5739.225204597493;5748.712564371848;5767.250257466502;5802.1296805479515;5810.477057064884;5844.444777746107;5854.765809367577;5868.061110222515;5868.794592189253;5439.5920305978;5678.403767604342;5722.284714410699;5748.971255143865;5767.625104368202 22:32:40 INFO - PROCESS | 22586 | |1;ext.html;549.895170485894;573.2633565867859;585.853536615846;597.6892016151601;625.5589809184526;40519.59480405195;43895.12209755803;44090.11819763603;44114.117717645626;44136.55863441368;44541.55458445415;44888.326675099815;44946.32580511295;45071.32393014107;45287.77356113215;8822.823543529126;8940.552972351388;8955.104489551059;8963.551822408886;9008.639654413815;8867.600957956874;8985.505797181153;8985.730428087169;8991.820163596723;9044.8643270351;9006.549672516381;9060.320475964329;9068;9082.137196966278;9097.727068187965;8913.732588022369;8972.282217422591;8984.865227021568;8990.10098990099;9031.638734450615;8805.64777408903;8904.332175086894;8917.42036767608;8933.687320943736;8945.329100317502;42524.36213456801;42748;42788.78605606983;42850.142997140196;42896.78551607222;3590.335787879251;3648.2885837261742;4088.1823635273063;4223.070924396628;4224.577542245782;33764.83117584421;34039.31921361559;34226.82886585551;34333;34407;4425.468943726742;4438.866833994985;4562.977185114053;4687.273472611717;4694.342792009087;372289;373425;375084;375636.1218193919;375788;55596.444035559936;55677.44322556723;55769;56032;56032.439675603535;64599.67700161469;64781.67609161924;64952.675236623516;65189.348106519275;65349;16303.918480407521;16658.000519968842;16664.50006499807;16694.24875880564;16723.08023058719;12785;12792.16850904707;12886.548970785978;12976.740465190644;12986.545470908473;16490.58773530671;18134.09329533518;18245.54386140357;18267.08664566793;18324;6169.475594574422;6176.7838125665385;6225.470834978987;6308.211473565804;6338.334474880164;899.9370044096981;967.2503809547657;995.7759504111517;1080.3679847289425;1092.530212008828;33223;33228.3354332912;33686.49470257948;33708;33962.32075358479;1043.5669197283194;1053.9209559283083;1085.1264731890747;1101.7741363020561;1110.013076592906;17248.482545523653;17250.65498690044;17348.219330130174;17375.82624173742;17399.304027838745;555797;556398;557804;558574;562663;60910.781784364066;60939.39060609426;61375.693121535;61497.38502615006;61610.38389616046;1324.2716505921705;1368.842583102936;1384.9653758656113;1385.1896640465238;1390.5619729785085;31556.52665209978;34386;35245.47131792974;35257.47113793346;35386.29227415489;52897.206541901134;53280.467195327554;53340.46659533355;53590.732046339515;53635.463645363045;392343;396097;396787;397301;397554;25247.97024357089;25668.229953101436;25671.10151144701;25901.22296331113;25978.61032084558;50550;51357.22964155615;52039;52074.47925520696;52114.21828672497;42619;42624.360634591125;44613.77693111644;44785.328220077376;45458.54541454543;43603.781981089895;44310.11379772451;44397;44467.38294335154;45615.54384456113;36862.44706329353;41003.58996409998;41855.16289674128;42011.36982945319;42318.78840605901;36581.45127823031;38898;39548.802255988536;39746.60253397429;39911.800440997606;29118.248131629003;29808.70191298146;29821.10536683903;30077.849610751808;30123.397532049676 22:32:40 INFO - PROCESS | 22586 | |2;jquery.html;383.4631515877771;390.2234553239054;393.893648714847;405.18962075848304;409;18360.724589131158;19833.504162395948;20119.798802011974;20123.29568465104;20310.6953395699;18950.62098758024;19125;19130.713039304388;19153.904230478827;19223.23107075719;5305.867353316159;5764.106563482656;5963.254593175853;6006.21919150512;6023.6988150592515;5906.114082887559;5980.581359304851;6000.489958353545;6004.3395226525045;6004.819855404323;5592.944070559303;5800.9129863052085;5871.178035075071;5898.469137777599;5976.641401515902;5879.3826648202175;5890.587658863859;5891.263592050994;5902.852428689274;6079.574429789916;5677.971610141923;5686.2039314496005;5697.430256974311;5723.9141412878425;5742.7415766290615;13698;13873.930630346884;21262.893685531475;21966.231181908555;21988.450288742748;2222.4777177363308;2260.9547809043893;2291.5682422856107;2307.3193407944696;2821.1818572613915;9882.243370306667;10015.298929074968;10099.848502272473;10582.629607963761;10630.840537391945;1962.3622322745023;2021.161218094489;2027.5944811037853;2036.775954644988;2086.374087773662;78664.60667696683;79539.60230198812;81147.18852811455;81645.18354816435;81784.59107704423;10397.168226541859;10506.844247132809;10655.786884262272;10674.519646615921;11011.064059554867;14746.926265368818;14778.556643300719;14784.560547509756;14810.481633142788;14836.70326593462;7611.20082391352;7795.922040779633;7843.607819608997;7997.200279971957;8022.79943001418;7408.518446300973;7563.810904727426;7611.2769286917655;7753.457257991887;7816.101148367897;4274.871753847327;4316.805743741539;4330.913381732347;4382.123575284956;4583.220852455091;1777.5956993974614;1854.573448106943;1861.5625328047897;1892.9337473188373;1910;941.5904081724472;1001.8747656542932;1020.4999550220339;1031.7575369788094;1059.4914441068177;19318.840290127235;19686;19836.60326793456;20050.398488045383;20293.79706202919;987.2644879564771;996.5067291690659;997.6607953295915;1003.4130033930087;1019.2457581389718;10528.526216320284;10914.890851091546;10968.506417211245;11007.449627518752;11028.172887033505;482385;485946;495072;504753;510067;90765.54617226872;93402;93434;95364;95936.52031739937;996.4071377530358;1017.5014243020867;1069.337011053152;1070.7216123807866;1074.033369967036;17463.214155363294;17884.91057544756;17905.641887161924;18139.727904081712;18378.72431913549;43173.56826431696;43774;44558.55441445674;45528.772356138004;45802.77098614485;60347;62085;62157;62457.375426246974;63154;6757.797266082025;7540.886886696594;8343.874841877256;8455.74632761018;8593.140685931357;12066.939665301617;12733.236005839679;13149.934250328688;13168.209907405586;13266;11204;11271.830922536004;11301.208915375844;11410.372429516125;11667.941660291644;11286.266392684449;11361.772764544829;11564.595239166589;11687.590934317599;11860.466279017637;11271.887281127412;11281.887181128084;11897.167198296036;12149.392530373623;12230.75538489243;8428.957855210685;8443.95778021106;8494.923342722761;8627.094155113622;8629.09394513592;11267.943660281646;11506.827397588875;11523.711907202387;11647.30116193031;12146.635600931986 22:32:40 INFO - PROCESS | 22586 | |3;mootools.html;1495.8878084143691;1520.7034628247493;1676.6479039401734;1763.8765286429955;1786.9285228590866;7855.60721963901;8401.747947561567;8630.91369086309;9293.860592091116;9354.81290374193;8486;8647;8765.60554775035;8767.51778652174;8783.516906570136;2330.8135349172067;2366.4557151855083;2372.122314743547;2392.055138220402;2401.7958473529684;2328.69726935499;2349.9295021149305;2363.2555744940287;2379.1553998330605;2379.845310054841;2345.9061637534564;2351.823613229015;2358.174638876388;2375.9168429104984;2379.6192609182535;2244.541048318606;2253.0199363276947;2254.391314345126;2259.175400978639;2308.226744040748;2225.554889022202;2255.221948427806;2264.1509433962265;2273.545290941818;2281.9657705134437;8875.644974201025;8890.110988901122;8896.599653015564;8942.016378198394;8944.642214311485;5179.119549676527;5306.8407947761625;5320.308359913225;5332.466753324676;5347.037533244014;3240.173755692307;3313.7797675557435;3458.7924724516356;3463.705585025276;3470.7049900758466;1086.0770819650288;1123.0790751583704;1137.0448822988646;1142.7428828513519;1153.5270539078938;12309.630711078593;12482.251064936132;12499.625011249676;12524.624261272085;12559.686007849785;4405.118976204772;4580.473245576802;4696.647751418657;4731.4795372509;4756.738379389098;10660.520276587416;10668.786624267472;10675.519601617945;10698.51856666452;10714.142868570496;5301.443348448434;5393.487618676298;5398.001369746609;5401.027814993339;5412.025835349675;4339.826406943687;4731.645126615517;4827.927581086286;4848;4931.802727890916;3930.194310166466;3990.541087774885;3992.0818211811447;4070.1452694933805;4082.8772087676125;1215.8966487848631;1261.5962891874512;1262.4255963536568;1272.0396100943728;1272.974540509203;923.6397804856111;994.1549682769588;999.2655398282257;1010.939343639384;1013.366645846346;5969.224000879858;6078.057901025348;6161.784337548164;6179.258488981351;6268.279147897959;458.16613762951107;458.17985805408614;466.1074043207288;473.92417213245716;478.51430797740323;4155.293600087993;4212.094399704079;4232.174725928415;4271.957280427156;4386.824527018884;10750.78498430027;11146.888531114586;11184.161187910777;11225.045871101049;11281.774364512828;11057.944710276397;11106.833397499044;11131.944340278247;11179.4969226385;11187;7861.764147075597;8104.797380065427;8359.665613375519;8359.791005224917;8415.70545030921;6033.668148251888;6120.8775824484155;6263.843403914939;6296;6339.936600633934;10259.897401026194;10336.948315258376;10349.741256468347;10362.948185259327;10476.947615261875;9825.361351512129;10268.897311026794;10274.589016439259;10364.844527331945;10392.948035259775;7246.96376518114;7763.417743669134;7995.800104997422;8041.155678653658;8145.918540814516;8701.43440676354;8813.911860881566;8818.735437936872;8827.514486703292;8860.734177974671;7633.465657403928;7816.335611473089;7865.016872890888;7938;8064;7667.156612772702;7841.607919604111;7845.254700803414;7874.72438464651;7875.291223789886;6818;6980.860382792417;6989.965050174716;7003.509754317352;7019.403350715246;4973.104841128486;5187.844364669066;5230.555402790806;5231.790728370823;5549.195366671729;5066.620003499678;5073.467285934924;5112.9744351278005;5177.92233116496;5404.891902161856 22:32:40 INFO - PROCESS | 22586 | |4;prototype.html;310.62414478481037;323.116276982453;323.15011519703177;323.2081400568606;330.3920785754212;5515.889682206353;5571.582131340156;5665.206871038053;5762.42375762424;5825.825225243249;5548.58385621078;5578.553715702744;5597.468240517144;5606.635568688032;5623.437656234374;4353.542877997812;4359.498657654362;4362.323839804835;4364.694471387004;4372.300431930892;4093.8127942896526;4278.6363159131515;4328.805203765823;4346.608805207531;4370.847020354288;4241.724287921275;4276.615104640582;4296.720713153651;4300.849470268541;4302.13957208558;4280.57194280571;4306.181825453154;4307.332363483665;4327.285997810358;4344.956550434518;3547.0954906498937;3757.1170774867883;3764.887053388403;3774.584795672474;3800.20195758891;5452;5453.4273901240595;5453.700046497441;5459.153831156177;5473.562115030788;4880.829170979035;4886.558465252759;4893.951060489385;4904.754762261909;4910.926336104962;5578.30271216098;5825.621334613236;5829.446202610745;5838.38696936824;5852.268466441695;4084.6732261419015;4094.4267802507675;4099.959000409987;4109.465769449952;4136.58634136587;6163.599366041193;6205.6897155142515;6220.595661282002;6220.782272620482;6264.123022776815;4052.5744796796503;4174.290370636999;4174.415581818487;4217.325227963511;4222.514410842792;4220.53574106848;4222.619964203236;4224.556421575752;4227.661787057028;4229.492460904711;4889.951100489021;4894.510548945148;4896.4124305083615;4903.485134060944;4903.950960490421;5872.706364681749;5972.25346831646;5977.432143946318;6018.472241658514;6047.546434017467;1443.328852083765;1466.779983002558;1468.08978433372;1484.1762821634097;1485.1831492678984;905.4974489158581;931.7344556801279;935.6865450074165;950.7195377363694;957.698325027614;5049.293098966147;5062.696238225718;5106.514881086291;5115.641905066684;5169.612279079084;5423.674579525241;5446.537044351275;5454.863628409322;5531.755355045083;5536.944630553643;4965.925511117336;5068.189089745623;5100.537030098663;5124.974375128175;5161.303224064778;2817.9714404242713;2833.2633515286175;2892.6673432555103;2910.286979689947;2910.563415487694;5512.91730624041;5513.917291240635;5524.696141712164;5556.222128901957;5559.555235581225;5265.605079619044;5478.9316083363365;5487.640314664733;5490.670559766427;5518.558515318765;5482.588805839578;5512.228288039678;5520.23988005997;5554.583406244547;5563.471470210405;5186.858891043964;5402.864928376822;5412.404635490014;5438.042304770201;5452.0731475648445;5253.529011876681;5331.440908364085;5347.144456886879;5374.408815030265;5433.809816656398;5499.835004949858;5530.755579994469;5533.944660553343;5590.2453168821685;5638.956792993309;4048.39274108886;4055.6552693020244;4130.731502452331;4153.210889930903;4161.396597493407;6071.241094863142;6080.939190608037;6098.573099882966;6116.204893364013;6148.846278842886;5688.947544704243;5880.26496687914;5906.763729450774;5919.91120133207;5974.1934838796205;5781.508571771446;5801.767929282782;5854.648721076749;5868.94131058684;5893.850699113803;5836.124581312837;5846.970765146317;5849.502792262705;5873.911891321548;5878.970605146947;5667.574931880208;5974.701264936649;5983;6039.849003774941;6048.727807248596;5923.555733319932;5936.436038576501;5954.528870518686;5966.403359663999;5980.863635909163 22:32:40 INFO - PROCESS | 22586 | |5;yui.html;726.6366816591704;754.4530215593692;757.1860250231002;773.4817672159652;859.8323326951245;15966.28151733172;16201.270942807572;16810.411635592758;16816.41142560009;16842.24209910554;15421.84578154221;15547.68904621907;15555.455559055436;15585.688286234268;15588.298526566303;656.0520048529852;787.4409169489669;789.7078081109997;799.2207597592359;808.4098608016152;816.6570040582969;819.2217393476192;819.2585709932521;820.7906983719173;821.2362502872327;868.0711638546758;868.3096937934325;871.6339137562239;871.9651213951435;873.7597160780805;859.1236938322938;865.1651156633878;866.4887716247413;868.8436081505326;870.5386145342978;634.3561285295428;635.4439865118022;635.7552342348183;636.0205283862846;638.4222278837659;15207.467738629095;15238.542843714706;15242.542723718307;15258.00822946516;15273.923630381889;15174.772378414333;15522.5343239703;15537.223138843012;15735.92132039344;15778.526644200692;12386.380680965916;12410.81383779244;12467.314297713621;12519.3740312984;12567.245965242024;3840.462335273064;3969.0672691917375;4021.1354558769713;4070.8575199867864;4150.501939767217;78975.60512197402;79395.60302198453;80181.59909200417;80941.99999999942;81102.59448702777;11331.886681133083;11395.544178232778;11412.144089193343;11567.595134170264;11966.760664786829;19871.801281986995;19949.700754488695;20002.499937501678;20030.098645560985;20083;8239.70037453176;8328.042275138316;8479.19447652472;8502.914970850212;8503.574821258911;4894.730789806524;4929.408470983505;4957.752112394366;5000.174971129795;5123.948760512421;3493.6681015303507;3543.450765131409;3601.441776524643;3602.5316708827686;3603.9279214416088;670.1622971285892;671.6708812681751;677.6679427080695;680.3876511140014;691.5712258399824;594.7112468051681;701.2846896165984;734.372111844376;738.660216300497;755.5051441305953;9988.300818942604;10086.49567521621;10146.239032072477;10181.898181018243;10316.48417579118;627.9309275979639;633.4900405173787;691.3163318517087;736.2306389822648;794.2018271636967;4772.308015337826;5034.6727462715535;5059.038782631288;5151.150060240018;5175.353080864892;117772.41113794377;119417;120648.39675801565;120983;121196;78307;106508.46745766222;106747.4662626682;107425.4628726867;108106.45946770215;56372.71813640987;56448;87413.56293218747;89676.10323896808;90990.54504727566;9370.083039246245;9641.37331073478;9661.13049825519;9837.311388203043;9840.311178217456;49000;51808.48191518037;52888;52986.2052069227;53270.66823329293;69298;75858;80692.59653701694;81471;83837.58081209555;12310.692232694255;12341.259524428562;12483.750324993267;12520.937395312965;12857.485700571873;13651.590452286448;13913.791293130409;13998.650033749238;14045.438182472586;14522;12922.00465315984;12969.480067601227;13020.8046879295;13137;13144.474221031052;13036.739265214832;13135.474581017035;13139.737205256033;13161.473541058633;13375.197488150352;12793.765997158172;13141.474341026253;13321.66241370446;13385.66535836612;13408.396622151831;10405.115565176742;11050.281731687415;11140.16448766362;11150.832737509107;11195.2723073;10755.462226888782;11430.542778288775;11464.541418343506;11545.711357216136;11706.941465292619 22:32:40 INFO - PROCESS | 22586 | __end_tp_report 22:32:40 INFO - PROCESS | 22586 | __start_cc_report 22:32:40 INFO - PROCESS | 22586 | _x_x_mozilla_cycle_collect,341 22:32:40 INFO - PROCESS | 22586 | __end_cc_report 22:32:40 INFO - PROCESS | 22586 | __startTimestamp1469511160267__endTimestamp 22:32:40 INFO - PROCESS | 22586 | 22:32:40 INFO - PROCESS | 22586 | ------- Summary: start ------- 22:32:40 INFO - PROCESS | 22586 | Number of tests: 6 22:32:40 INFO - PROCESS | 22586 | 22:32:40 INFO - PROCESS | 22586 | [#0] dojo.html Cycles:165 Average:5558.02 Median:5748.97 stddev:654.19 (11.4%) stddev-sans-first:627.55 22:32:40 INFO - PROCESS | 22586 | Values: 3117.5 3144.6 3158.5 3171.4 3176.0 5462.4 5494.7 5513.4 5530.7 5576.2 5533.7 5555.4 5582.7 5584.7 5634.9 4928.7 5029.3 5081.6 5098.5 5276.6 5184.2 5216.2 5224.7 5277.7 5278.4 4973.4 5029.7 5058.7 5061.1 5080.0 5041.9 5060.5 5068.6 5073.8 5085.4 4994.5 5026.1 5026.8 5044.8 5050.6 5428.6 5451.1 5588.8 5592.6 5600.9 6058.2 6058.6 6058.8 6060.3 6093.6 6069.2 6100.0 6104.4 6105.6 6109.2 5485.1 5627.0 5653.7 5667.5 5696.7 6183.0 6186.0 6188.9 6195.8 6198.6 5960.8 5971.3 5973.6 5974.3 6016.2 5835.2 5890.7 5924.4 5946.9 5972.7 5789.0 5908.1 5961.9 5974.1 5980.4 5962.9 5965.4 6001.7 6011.2 6018.3 4403.7 4537.3 4538.6 4540.1 4588.5 3977.5 4015.1 4022.3 4032.2 4076.8 5695.0 5700.7 5708.8 5721.8 5741.1 5763.3 6033.2 6047.5 6048.3 6069.1 5614.6 5644.4 5661.9 5715.4 5768.4 5127.7 5137.0 5138.5 5144.8 5155.6 6006.9 6099.7 6154.6 6196.1 6199.6 5942.3 5951.0 5994.5 6048.5 6077.6 6157.1 6159.2 6169.8 6171.8 6188.2 5732.8 5883.1 5925.2 5928.2 5931.0 6014.7 6019.6 6048.0 6097.8 6126.0 5892.4 5893.9 5913.6 5922.3 5931.5 5721.3 5917.7 5932.5 5939.6 5946.5 5698.3 5739.2 5748.7 5767.3 5802.1 5810.5 5844.4 5854.8 5868.1 5868.8 5439.6 5678.4 5722.3 5749.0 5767.6 22:32:40 INFO - PROCESS | 22586 | 22:32:40 INFO - PROCESS | 22586 | [#1] ext.html Cycles:180 Average:61138.58 Median:43749.45 stddev:119371.18 (272.9%) stddev-sans-first:119619.36 22:32:40 INFO - PROCESS | 22586 | Values: 549.9 573.3 585.9 597.7 625.6 40519.6 43895.1 44090.1 44114.1 44136.6 44541.6 44888.3 44946.3 45071.3 45287.8 8822.8 8940.6 8955.1 8963.6 9008.6 8867.6 8985.5 8985.7 8991.8 9044.9 9006.5 9060.3 9068.0 9082.1 9097.7 8913.7 8972.3 8984.9 8990.1 9031.6 8805.6 8904.3 8917.4 8933.7 8945.3 42524.4 42748.0 42788.8 42850.1 42896.8 3590.3 3648.3 4088.2 4223.1 4224.6 33764.8 34039.3 34226.8 34333.0 34407.0 4425.5 4438.9 4563.0 4687.3 4694.3 372289.0 373425.0 375084.0 375636.1 375788.0 55596.4 55677.4 55769.0 56032.0 56032.4 64599.7 64781.7 64952.7 65189.3 65349.0 16303.9 16658.0 16664.5 16694.2 16723.1 12785.0 12792.2 12886.5 12976.7 12986.5 16490.6 18134.1 18245.5 18267.1 18324.0 6169.5 6176.8 6225.5 6308.2 6338.3 899.9 967.3 995.8 1080.4 1092.5 33223.0 33228.3 33686.5 33708.0 33962.3 1043.6 1053.9 1085.1 1101.8 1110.0 17248.5 17250.7 17348.2 17375.8 17399.3 555797.0 556398.0 557804.0 558574.0 562663.0 60910.8 60939.4 61375.7 61497.4 61610.4 1324.3 1368.8 1385.0 1385.2 1390.6 31556.5 34386.0 35245.5 35257.5 35386.3 52897.2 53280.5 53340.5 53590.7 53635.5 392343.0 396097.0 396787.0 397301.0 397554.0 25248.0 25668.2 25671.1 25901.2 25978.6 50550.0 51357.2 52039.0 52074.5 52114.2 42619.0 42624.4 44613.8 44785.3 45458.5 43603.8 44310.1 44397.0 44467.4 45615.5 36862.4 41003.6 41855.2 42011.4 42318.8 36581.5 38898.0 39548.8 39746.6 39911.8 29118.2 29808.7 29821.1 30077.8 30123.4 22:32:40 INFO - PROCESS | 22586 | 22:32:40 INFO - PROCESS | 22586 | [#2] jquery.html Cycles:180 Average:29246.17 Median:2276.26 stddev:81819.89 (3594.5%) stddev-sans-first:82020.72 22:32:40 INFO - PROCESS | 22586 | Values: 383.5 390.2 393.9 405.2 409.0 18360.7 19833.5 20119.8 20123.3 20310.7 18950.6 19125.0 19130.7 19153.9 19223.2 5305.9 5764.1 5963.3 6006.2 6023.7 5906.1 5980.6 6000.5 6004.3 6004.8 5592.9 5800.9 5871.2 5898.5 5976.6 5879.4 5890.6 5891.3 5902.9 6079.6 5678.0 5686.2 5697.4 5723.9 5742.7 13698.0 13873.9 21262.9 21966.2 21988.5 2222.5 2261.0 2291.6 2307.3 2821.2 9882.2 10015.3 10099.8 10582.6 10630.8 1962.4 2021.2 2027.6 2036.8 2086.4 78664.6 79539.6 81147.2 81645.2 81784.6 10397.2 10506.8 10655.8 10674.5 11011.1 14746.9 14778.6 14784.6 14810.5 14836.7 7611.2 7795.9 7843.6 7997.2 8022.8 7408.5 7563.8 7611.3 7753.5 7816.1 4274.9 4316.8 4330.9 4382.1 4583.2 1777.6 1854.6 1861.6 1892.9 1910.0 941.6 1001.9 1020.5 1031.8 1059.5 19318.8 19686.0 19836.6 20050.4 20293.8 987.3 996.5 997.7 1003.4 1019.2 10528.5 10914.9 10968.5 11007.4 11028.2 482385.0 485946.0 495072.0 504753.0 510067.0 90765.5 93402.0 93434.0 95364.0 95936.5 996.4 1017.5 1069.3 1070.7 1074.0 17463.2 17884.9 17905.6 18139.7 18378.7 43173.6 43774.0 44558.6 45528.8 45802.8 60347.0 62085.0 62157.0 62457.4 63154.0 6757.8 7540.9 8343.9 8455.7 8593.1 12066.9 12733.2 13149.9 13168.2 13266.0 11204.0 11271.8 11301.2 11410.4 11667.9 11286.3 11361.8 11564.6 11687.6 11860.5 11271.9 11281.9 11897.2 12149.4 12230.8 8429.0 8444.0 8494.9 8627.1 8629.1 11267.9 11506.8 11523.7 11647.3 12146.6 22:32:40 INFO - PROCESS | 22586 | 22:32:40 INFO - PROCESS | 22586 | [#3] mootools.html Cycles:180 Average:5871.22 Median:2523.29 stddev:3377.22 (133.8%) stddev-sans-first:3370.69 22:32:40 INFO - PROCESS | 22586 | Values: 1495.9 1520.7 1676.6 1763.9 1786.9 7855.6 8401.7 8630.9 9293.9 9354.8 8486.0 8647.0 8765.6 8767.5 8783.5 2330.8 2366.5 2372.1 2392.1 2401.8 2328.7 2349.9 2363.3 2379.2 2379.8 2345.9 2351.8 2358.2 2375.9 2379.6 2244.5 2253.0 2254.4 2259.2 2308.2 2225.6 2255.2 2264.2 2273.5 2282.0 8875.6 8890.1 8896.6 8942.0 8944.6 5179.1 5306.8 5320.3 5332.5 5347.0 3240.2 3313.8 3458.8 3463.7 3470.7 1086.1 1123.1 1137.0 1142.7 1153.5 12309.6 12482.3 12499.6 12524.6 12559.7 4405.1 4580.5 4696.6 4731.5 4756.7 10660.5 10668.8 10675.5 10698.5 10714.1 5301.4 5393.5 5398.0 5401.0 5412.0 4339.8 4731.6 4827.9 4848.0 4931.8 3930.2 3990.5 3992.1 4070.1 4082.9 1215.9 1261.6 1262.4 1272.0 1273.0 923.6 994.2 999.3 1010.9 1013.4 5969.2 6078.1 6161.8 6179.3 6268.3 458.2 458.2 466.1 473.9 478.5 4155.3 4212.1 4232.2 4272.0 4386.8 10750.8 11146.9 11184.2 11225.0 11281.8 11057.9 11106.8 11131.9 11179.5 11187.0 7861.8 8104.8 8359.7 8359.8 8415.7 6033.7 6120.9 6263.8 6296.0 6339.9 10259.9 10336.9 10349.7 10362.9 10476.9 9825.4 10268.9 10274.6 10364.8 10392.9 7247.0 7763.4 7995.8 8041.2 8145.9 8701.4 8813.9 8818.7 8827.5 8860.7 7633.5 7816.3 7865.0 7938.0 8064.0 7667.2 7841.6 7845.3 7874.7 7875.3 6818.0 6980.9 6990.0 7003.5 7019.4 4973.1 5187.8 5230.6 5231.8 5549.2 5066.6 5073.5 5113.0 5177.9 5404.9 22:32:40 INFO - PROCESS | 22586 | 22:32:40 INFO - PROCESS | 22586 | [#4] prototype.html Cycles:180 Average:4769.32 Median:5442.29 stddev:1407.06 (25.9%) stddev-sans-first:1370.63 22:32:40 INFO - PROCESS | 22586 | Values: 310.6 323.1 323.2 323.2 330.4 5515.9 5571.6 5665.2 5762.4 5825.8 5548.6 5578.6 5597.5 5606.6 5623.4 4353.5 4359.5 4362.3 4364.7 4372.3 4093.8 4278.6 4328.8 4346.6 4370.8 4241.7 4276.6 4296.7 4300.8 4302.1 4280.6 4306.2 4307.3 4327.3 4345.0 3547.1 3757.1 3764.9 3774.6 3800.2 5452.0 5453.4 5453.7 5459.2 5473.6 4880.8 4886.6 4894.0 4904.8 4910.9 5578.3 5825.6 5829.4 5838.4 5852.3 4084.7 4094.4 4100.0 4109.5 4136.6 6163.6 6205.7 6220.6 6220.8 6264.1 4052.6 4174.3 4174.4 4217.3 4222.5 4220.5 4222.6 4224.6 4227.7 4229.5 4890.0 4894.5 4896.4 4903.5 4904.0 5872.7 5972.3 5977.4 6018.5 6047.5 1443.3 1466.8 1468.1 1484.2 1485.2 905.5 931.7 935.7 950.7 957.7 5049.3 5062.7 5106.5 5115.6 5169.6 5423.7 5446.5 5454.9 5531.8 5536.9 4965.9 5068.2 5100.5 5125.0 5161.3 2818.0 2833.3 2892.7 2910.3 2910.6 5512.9 5513.9 5524.7 5556.2 5559.6 5265.6 5478.9 5487.6 5490.7 5518.6 5482.6 5512.2 5520.2 5554.6 5563.5 5186.9 5402.9 5412.4 5438.0 5452.1 5253.5 5331.4 5347.1 5374.4 5433.8 5499.8 5530.8 5533.9 5590.2 5639.0 4048.4 4055.7 4130.7 4153.2 4161.4 6071.2 6080.9 6098.6 6116.2 6148.8 5688.9 5880.3 5906.8 5919.9 5974.2 5781.5 5801.8 5854.6 5868.9 5893.9 5836.1 5847.0 5849.5 5873.9 5879.0 5667.6 5974.7 5983.0 6039.8 6048.7 5923.6 5936.4 5954.5 5966.4 5980.9 22:32:40 INFO - PROCESS | 22586 | 22:32:40 INFO - PROCESS | 22586 | [#5] yui.html Cycles:180 Average:20993.13 Median:4046.00 stddev:30564.63 (755.4%) stddev-sans-first:30612.49 22:32:40 INFO - PROCESS | 22586 | Values: 726.6 754.5 757.2 773.5 859.8 15966.3 16201.3 16810.4 16816.4 16842.2 15421.8 15547.7 15555.5 15585.7 15588.3 656.1 787.4 789.7 799.2 808.4 816.7 819.2 819.3 820.8 821.2 868.1 868.3 871.6 872.0 873.8 859.1 865.2 866.5 868.8 870.5 634.4 635.4 635.8 636.0 638.4 15207.5 15238.5 15242.5 15258.0 15273.9 15174.8 15522.5 15537.2 15735.9 15778.5 12386.4 12410.8 12467.3 12519.4 12567.2 3840.5 3969.1 4021.1 4070.9 4150.5 78975.6 79395.6 80181.6 80942.0 81102.6 11331.9 11395.5 11412.1 11567.6 11966.8 19871.8 19949.7 20002.5 20030.1 20083.0 8239.7 8328.0 8479.2 8502.9 8503.6 4894.7 4929.4 4957.8 5000.2 5123.9 3493.7 3543.5 3601.4 3602.5 3603.9 670.2 671.7 677.7 680.4 691.6 594.7 701.3 734.4 738.7 755.5 9988.3 10086.5 10146.2 10181.9 10316.5 627.9 633.5 691.3 736.2 794.2 4772.3 5034.7 5059.0 5151.2 5175.4 117772.4 119417.0 120648.4 120983.0 121196.0 78307.0 106508.5 106747.5 107425.5 108106.5 56372.7 56448.0 87413.6 89676.1 90990.5 9370.1 9641.4 9661.1 9837.3 9840.3 49000.0 51808.5 52888.0 52986.2 53270.7 69298.0 75858.0 80692.6 81471.0 83837.6 12310.7 12341.3 12483.8 12520.9 12857.5 13651.6 13913.8 13998.7 14045.4 14522.0 12922.0 12969.5 13020.8 13137.0 13144.5 13036.7 13135.5 13139.7 13161.5 13375.2 12793.8 13141.5 13321.7 13385.7 13408.4 10405.1 11050.3 11140.2 11150.8 11195.3 10755.5 11430.5 11464.5 11545.7 11706.9 22:32:40 INFO - PROCESS | 22586 | -------- Summary: end -------- 22:32:40 INFO - PROCESS | 22586 | 22:32:41 INFO - TEST-INFO | 22586: exit 0 22:32:41 INFO - TEST-OK | dromaeo_css | took 1112435ms 22:32:41 INFO - TEST-START | kraken 22:32:41 INFO - operating with platform_type : linux_ 22:32:41 INFO - Initialising browser for kraken test... 22:32:41 INFO - TEST-INFO | started process 22832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwEbNRd/profile http://localhost:33654/getInfo.html) 22:32:44 INFO - PROCESS | 22832 | JavaScript error: , line 0: uncaught exception: undefined 22:32:46 INFO - PROCESS | 22832 | __metrics Screen width/height:1600/1200 22:32:46 INFO - PROCESS | 22832 | colorDepth:24 22:32:46 INFO - PROCESS | 22832 | Browser inner width/height: 1024/697 22:32:46 INFO - PROCESS | 22832 | __metrics 22:32:47 ERROR - PROCESS | 22832 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 22:32:47 INFO - TEST-INFO | 22832: exit 0 22:32:47 INFO - Browser initialized. 22:32:47 INFO - Running cycle 1/1 for kraken test... 22:32:47 INFO - TEST-INFO | started process 22951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwEbNRd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:59 INFO - PROCESS | 22951 | RSS: Main: 164618240 22:32:59 INFO - PROCESS | 22951 | 22:33:02 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33654/tests/kraken/driver.html?testName=audio-beat-detection) 22:33:03 INFO - PROCESS | 22951 | RSS: Main: 169852928 22:33:03 INFO - PROCESS | 22951 | 22:33:05 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33654/tests/kraken/driver.html?testName=audio-dft) 22:33:06 INFO - PROCESS | 22951 | RSS: Main: 169189376 22:33:06 INFO - PROCESS | 22951 | 22:33:09 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33654/tests/kraken/driver.html?testName=audio-fft) 22:33:10 INFO - PROCESS | 22951 | RSS: Main: 165240832 22:33:10 INFO - PROCESS | 22951 | 22:33:12 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33654/tests/kraken/driver.html?testName=audio-oscillator) 22:33:12 INFO - PROCESS | 22951 | RSS: Main: 166559744 22:33:12 INFO - PROCESS | 22951 | 22:33:14 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:33:15 INFO - PROCESS | 22951 | RSS: Main: 166510592 22:33:15 INFO - PROCESS | 22951 | 22:33:18 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33654/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:19 INFO - PROCESS | 22951 | RSS: Main: 166277120 22:33:19 INFO - PROCESS | 22951 | 22:33:22 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33654/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:23 INFO - PROCESS | 22951 | RSS: Main: 167346176 22:33:23 INFO - PROCESS | 22951 | 22:33:26 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33654/tests/kraken/driver.html?testName=json-parse-financial) 22:33:26 INFO - PROCESS | 22951 | RSS: Main: 167690240 22:33:26 INFO - PROCESS | 22951 | 22:33:28 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:33:28 INFO - PROCESS | 22951 | RSS: Main: 166842368 22:33:28 INFO - PROCESS | 22951 | 22:33:30 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33654/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:33:31 INFO - PROCESS | 22951 | RSS: Main: 167297024 22:33:31 INFO - PROCESS | 22951 | 22:33:33 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:33:34 INFO - PROCESS | 22951 | RSS: Main: 167337984 22:33:34 INFO - PROCESS | 22951 | 22:33:36 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:33:37 INFO - PROCESS | 22951 | RSS: Main: 167460864 22:33:37 INFO - PROCESS | 22951 | 22:33:39 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:33:40 INFO - PROCESS | 22951 | RSS: Main: 167751680 22:33:40 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | Cycle 1(1): loaded http://localhost:33654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33654/tests/kraken/driver.html?testName=ai-astar) 22:33:42 INFO - PROCESS | 22951 | RSS: Main: 168529920 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | __start_tp_report 22:33:42 INFO - PROCESS | 22951 | _x_x_mozilla_page_load 22:33:42 INFO - PROCESS | 22951 | _x_x_mozilla_page_load_details 22:33:42 INFO - PROCESS | 22951 | |i|pagename|runs| 22:33:42 INFO - PROCESS | 22951 | |0;ai-astar;102;111;106;112;112;113;113;112;111;111 22:33:42 INFO - PROCESS | 22951 | |1;audio-beat-detection;145;117;150;180;119;147;151;120;192;120 22:33:42 INFO - PROCESS | 22951 | |2;audio-dft;162;162;163;164;162;169;167;162;162;165 22:33:42 INFO - PROCESS | 22951 | |3;audio-fft;75;83;74;174;76;76;74;75;160;76 22:33:42 INFO - PROCESS | 22951 | |4;audio-oscillator;83;84;163;84;86;84;146;84;84;153 22:33:42 INFO - PROCESS | 22951 | |5;imaging-gaussian-blur;118;117;117;118;118;117;117;117;118;120 22:33:42 INFO - PROCESS | 22951 | |6;imaging-darkroom;147;147;146;147;148;146;146;146;147;146 22:33:42 INFO - PROCESS | 22951 | |7;imaging-desaturate;96;97;95;96;95;96;96;96;96;95 22:33:42 INFO - PROCESS | 22951 | |8;json-parse-financial;54;56;53;52;53;53;56;53;52;53 22:33:42 INFO - PROCESS | 22951 | |9;json-stringify-tinderbox;62;62;62;62;63;63;62;62;62;62 22:33:42 INFO - PROCESS | 22951 | |10;stanford-crypto-aes;77;80;83;76;77;79;76;76;79;76 22:33:42 INFO - PROCESS | 22951 | |11;stanford-crypto-ccm;134;125;124;122;128;123;121;129;163;127 22:33:42 INFO - PROCESS | 22951 | |12;stanford-crypto-pbkdf2;159;159;159;156;161;160;156;158;159;156 22:33:42 INFO - PROCESS | 22951 | |13;stanford-crypto-sha256-iterative;66;64;65;63;64;65;64;66;63;67 22:33:42 INFO - PROCESS | 22951 | __end_tp_report 22:33:42 INFO - PROCESS | 22951 | __start_cc_report 22:33:42 INFO - PROCESS | 22951 | _x_x_mozilla_cycle_collect,868 22:33:42 INFO - PROCESS | 22951 | __end_cc_report 22:33:42 INFO - PROCESS | 22951 | __startTimestamp1469511222505__endTimestamp 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | ------- Summary: start ------- 22:33:42 INFO - PROCESS | 22951 | Number of tests: 14 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.53 (3.2%) stddev-sans-first:2.11 22:33:42 INFO - PROCESS | 22951 | Values: 102.0 111.0 106.0 112.0 112.0 113.0 113.0 112.0 111.0 111.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:148.50 stddev:26.25 (17.7%) stddev-sans-first:27.84 22:33:42 INFO - PROCESS | 22951 | Values: 145.0 117.0 150.0 180.0 119.0 147.0 151.0 120.0 192.0 120.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.49 (1.5%) stddev-sans-first:2.55 22:33:42 INFO - PROCESS | 22951 | Values: 162.0 162.0 163.0 164.0 162.0 169.0 167.0 162.0 162.0 165.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:38.54 (51.1%) stddev-sans-first:40.24 22:33:42 INFO - PROCESS | 22951 | Values: 75.0 83.0 74.0 174.0 76.0 76.0 74.0 75.0 160.0 76.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:84.00 stddev:33.99 (40.5%) stddev-sans-first:35.10 22:33:42 INFO - PROCESS | 22951 | Values: 83.0 84.0 163.0 84.0 86.0 84.0 146.0 84.0 84.0 153.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 22:33:42 INFO - PROCESS | 22951 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 120.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 22:33:42 INFO - PROCESS | 22951 | Values: 147.0 147.0 146.0 147.0 148.0 146.0 146.0 146.0 147.0 146.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 22:33:42 INFO - PROCESS | 22951 | Values: 96.0 97.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:1.43 (2.7%) stddev-sans-first:1.51 22:33:42 INFO - PROCESS | 22951 | Values: 54.0 56.0 53.0 52.0 53.0 53.0 56.0 53.0 52.0 53.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 22:33:42 INFO - PROCESS | 22951 | Values: 62.0 62.0 62.0 62.0 63.0 63.0 62.0 62.0 62.0 62.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:2.33 (3.0%) stddev-sans-first:2.45 22:33:42 INFO - PROCESS | 22951 | Values: 77.0 80.0 83.0 76.0 77.0 79.0 76.0 76.0 79.0 76.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:127.50 stddev:12.35 (9.7%) stddev-sans-first:12.99 22:33:42 INFO - PROCESS | 22951 | Values: 134.0 125.0 124.0 122.0 128.0 123.0 121.0 129.0 163.0 127.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.00 stddev:1.77 (1.1%) stddev-sans-first:1.86 22:33:42 INFO - PROCESS | 22951 | Values: 159.0 159.0 159.0 156.0 161.0 160.0 156.0 158.0 159.0 156.0 22:33:42 INFO - PROCESS | 22951 | 22:33:42 INFO - PROCESS | 22951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.34 (2.1%) stddev-sans-first:1.33 22:33:42 INFO - PROCESS | 22951 | Values: 66.0 64.0 65.0 63.0 64.0 65.0 64.0 66.0 63.0 67.0 22:33:42 INFO - PROCESS | 22951 | -------- Summary: end -------- 22:33:42 INFO - PROCESS | 22951 | 22:33:43 INFO - TEST-INFO | 22951: exit 0 22:33:43 INFO - TEST-OK | kraken | took 62480ms 22:33:43 INFO - SUITE-END | took 1174s 22:33:43 INFO - Completed test suite (00:19:35) 22:33:43 INFO - javascript benchmark 22:33:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7347.453571554013, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.4700300948834, 3144.5754823098882, 3158.478850989587, 3171.429142754304, 3176.047185844246, 5462.426445223254, 5494.670319780816, 5513.365962914266, 5530.723463826813, 5576.219329293892, 5533.723313834303, 5555.388907220203, 5582.665040097587, 5584.7207639617955, 5634.943650563493, 4928.728919909412, 5029.270755740416, 5081.644284900059, 5098.490150984909, 5276.577873770108, 5184.2223666450145, 5216.165413533835, 5224.686518808865, 5277.70972596507, 5278.445763194867, 4973.403191617011, 5029.673071250394, 5058.671186372892, 5061.063703214881, 5080.0, 5041.899162016739, 5060.493950604947, 5068.619853511002, 5073.771680274396, 5085.415177254626, 4994.500549945013, 5026.145555255615, 5026.84919452417, 5044.823431179928, 5050.621203409759, 5428.592855535811, 5451.073317536028, 5588.776448942038, 5592.636478628917, 5600.943990560083, 6058.1518587397795, 6058.606190597597, 6058.787942422038, 6060.272767267912, 6093.634381937098, 6069.211002569682, 6099.969500152515, 6104.420080092428, 6105.633661980251, 6109.236345456818, 5485.067538518461, 5626.971865140648, 5653.745581448845, 5667.4615911488345, 5696.658200507983, 6183.0107182850525, 6185.969070154711, 6188.907166392508, 6195.845103872349, 6198.597091189148, 5960.791372302036, 5971.28344598651, 5973.55198360116, 5974.2830860297045, 6016.157737916695, 5835.153902684087, 5890.734916928663, 5924.377940316291, 5946.881062378815, 5972.731227094791, 5789.0, 5908.05471124618, 5961.940380596226, 5974.074018527135, 5980.401959804072, 5962.940370596325, 5965.403459654, 6001.669908155093, 6011.218541589566, 6018.277806663228, 4403.691741578059, 4537.274036154199, 4538.614217791459, 4540.137373899015, 4588.49526552079, 3977.482927219443, 4015.1166743316426, 4022.3162062449455, 4032.2338755636333, 4076.775777332216, 5694.97152514243, 5700.686462244534, 5708.828735137952, 5721.828345149569, 5741.052726300197, 5763.2507773989955, 6033.155358249848, 6047.485963693048, 6048.334683184846, 6069.119977603223, 5614.550835933197, 5644.3508996465935, 5661.915071273934, 5715.428457154335, 5768.423157684282, 5127.692338459704, 5136.9743151284, 5138.460461651547, 5144.819931302386, 5155.639105262596, 6006.879862402728, 6099.725512351954, 6154.630722156685, 6196.0705894116245, 6199.597026193283, 5942.346341902387, 5951.018082016592, 5994.520438365008, 6048.546359023003, 6077.574569780073, 6157.1072194532435, 6159.23009623797, 6169.753209871555, 6171.753129874754, 6188.195534580475, 5732.799352022659, 5883.117532370179, 5925.170476133431, 5928.199693041557, 5931.0, 6014.72933717975, 6019.608725432833, 6047.969760151171, 6097.75608975636, 6126.0, 5892.351841297368, 5893.941060589339, 5913.615614985012, 5922.289325280822, 5931.466168044896, 5721.284839395075, 5917.733701983335, 5932.49573786233, 5939.584229104094, 5946.464818166386, 5698.287714035746, 5739.225204597493, 5748.712564371848, 5767.250257466502, 5802.1296805479515, 5810.477057064884, 5844.444777746107, 5854.765809367577, 5868.061110222515, 5868.794592189253, 5439.5920305978, 5678.403767604342, 5722.284714410699, 5748.971255143865, 5767.625104368202], "value": 5511.775710970728, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.895170485894, 573.2633565867859, 585.853536615846, 597.6892016151601, 625.5589809184526, 40519.59480405195, 43895.12209755803, 44090.11819763603, 44114.117717645626, 44136.55863441368, 44541.55458445415, 44888.326675099815, 44946.32580511295, 45071.32393014107, 45287.77356113215, 8822.823543529126, 8940.552972351388, 8955.104489551059, 8963.551822408886, 9008.639654413815, 8867.600957956874, 8985.505797181153, 8985.730428087169, 8991.820163596723, 9044.8643270351, 9006.549672516381, 9060.320475964329, 9068.0, 9082.137196966278, 9097.727068187965, 8913.732588022369, 8972.282217422591, 8984.865227021568, 8990.10098990099, 9031.638734450615, 8805.64777408903, 8904.332175086894, 8917.42036767608, 8933.687320943736, 8945.329100317502, 42524.36213456801, 42748.0, 42788.78605606983, 42850.142997140196, 42896.78551607222, 3590.335787879251, 3648.2885837261742, 4088.1823635273063, 4223.070924396628, 4224.577542245782, 33764.83117584421, 34039.31921361559, 34226.82886585551, 34333.0, 34407.0, 4425.468943726742, 4438.866833994985, 4562.977185114053, 4687.273472611717, 4694.342792009087, 372289.0, 373425.0, 375084.0, 375636.1218193919, 375788.0, 55596.444035559936, 55677.44322556723, 55769.0, 56032.0, 56032.439675603535, 64599.67700161469, 64781.67609161924, 64952.675236623516, 65189.348106519275, 65349.0, 16303.918480407521, 16658.000519968842, 16664.50006499807, 16694.24875880564, 16723.08023058719, 12785.0, 12792.16850904707, 12886.548970785978, 12976.740465190644, 12986.545470908473, 16490.58773530671, 18134.09329533518, 18245.54386140357, 18267.08664566793, 18324.0, 6169.475594574422, 6176.7838125665385, 6225.470834978987, 6308.211473565804, 6338.334474880164, 899.9370044096981, 967.2503809547657, 995.7759504111517, 1080.3679847289425, 1092.530212008828, 33223.0, 33228.3354332912, 33686.49470257948, 33708.0, 33962.32075358479, 1043.5669197283194, 1053.9209559283083, 1085.1264731890747, 1101.7741363020561, 1110.013076592906, 17248.482545523653, 17250.65498690044, 17348.219330130174, 17375.82624173742, 17399.304027838745, 555797.0, 556398.0, 557804.0, 558574.0, 562663.0, 60910.781784364066, 60939.39060609426, 61375.693121535, 61497.38502615006, 61610.38389616046, 1324.2716505921705, 1368.842583102936, 1384.9653758656113, 1385.1896640465238, 1390.5619729785085, 31556.52665209978, 34386.0, 35245.47131792974, 35257.47113793346, 35386.29227415489, 52897.206541901134, 53280.467195327554, 53340.46659533355, 53590.732046339515, 53635.463645363045, 392343.0, 396097.0, 396787.0, 397301.0, 397554.0, 25247.97024357089, 25668.229953101436, 25671.10151144701, 25901.22296331113, 25978.61032084558, 50550.0, 51357.22964155615, 52039.0, 52074.47925520696, 52114.21828672497, 42619.0, 42624.360634591125, 44613.77693111644, 44785.328220077376, 45458.54541454543, 43603.781981089895, 44310.11379772451, 44397.0, 44467.38294335154, 45615.54384456113, 36862.44706329353, 41003.58996409998, 41855.16289674128, 42011.36982945319, 42318.78840605901, 36581.45127823031, 38898.0, 39548.802255988536, 39746.60253397429, 39911.800440997606, 29118.248131629003, 29808.70191298146, 29821.10536683903, 30077.849610751808, 30123.397532049676], "value": 20441.675090711033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.4631515877771, 390.2234553239054, 393.893648714847, 405.18962075848304, 409.0, 18360.724589131158, 19833.504162395948, 20119.798802011974, 20123.29568465104, 20310.6953395699, 18950.62098758024, 19125.0, 19130.713039304388, 19153.904230478827, 19223.23107075719, 5305.867353316159, 5764.106563482656, 5963.254593175853, 6006.21919150512, 6023.6988150592515, 5906.114082887559, 5980.581359304851, 6000.489958353545, 6004.3395226525045, 6004.819855404323, 5592.944070559303, 5800.9129863052085, 5871.178035075071, 5898.469137777599, 5976.641401515902, 5879.3826648202175, 5890.587658863859, 5891.263592050994, 5902.852428689274, 6079.574429789916, 5677.971610141923, 5686.2039314496005, 5697.430256974311, 5723.9141412878425, 5742.7415766290615, 13698.0, 13873.930630346884, 21262.893685531475, 21966.231181908555, 21988.450288742748, 2222.4777177363308, 2260.9547809043893, 2291.5682422856107, 2307.3193407944696, 2821.1818572613915, 9882.243370306667, 10015.298929074968, 10099.848502272473, 10582.629607963761, 10630.840537391945, 1962.3622322745023, 2021.161218094489, 2027.5944811037853, 2036.775954644988, 2086.374087773662, 78664.60667696683, 79539.60230198812, 81147.18852811455, 81645.18354816435, 81784.59107704423, 10397.168226541859, 10506.844247132809, 10655.786884262272, 10674.519646615921, 11011.064059554867, 14746.926265368818, 14778.556643300719, 14784.560547509756, 14810.481633142788, 14836.70326593462, 7611.20082391352, 7795.922040779633, 7843.607819608997, 7997.200279971957, 8022.79943001418, 7408.518446300973, 7563.810904727426, 7611.2769286917655, 7753.457257991887, 7816.101148367897, 4274.871753847327, 4316.805743741539, 4330.913381732347, 4382.123575284956, 4583.220852455091, 1777.5956993974614, 1854.573448106943, 1861.5625328047897, 1892.9337473188373, 1910.0, 941.5904081724472, 1001.8747656542932, 1020.4999550220339, 1031.7575369788094, 1059.4914441068177, 19318.840290127235, 19686.0, 19836.60326793456, 20050.398488045383, 20293.79706202919, 987.2644879564771, 996.5067291690659, 997.6607953295915, 1003.4130033930087, 1019.2457581389718, 10528.526216320284, 10914.890851091546, 10968.506417211245, 11007.449627518752, 11028.172887033505, 482385.0, 485946.0, 495072.0, 504753.0, 510067.0, 90765.54617226872, 93402.0, 93434.0, 95364.0, 95936.52031739937, 996.4071377530358, 1017.5014243020867, 1069.337011053152, 1070.7216123807866, 1074.033369967036, 17463.214155363294, 17884.91057544756, 17905.641887161924, 18139.727904081712, 18378.72431913549, 43173.56826431696, 43774.0, 44558.55441445674, 45528.772356138004, 45802.77098614485, 60347.0, 62085.0, 62157.0, 62457.375426246974, 63154.0, 6757.797266082025, 7540.886886696594, 8343.874841877256, 8455.74632761018, 8593.140685931357, 12066.939665301617, 12733.236005839679, 13149.934250328688, 13168.209907405586, 13266.0, 11204.0, 11271.830922536004, 11301.208915375844, 11410.372429516125, 11667.941660291644, 11286.266392684449, 11361.772764544829, 11564.595239166589, 11687.590934317599, 11860.466279017637, 11271.887281127412, 11281.887181128084, 11897.167198296036, 12149.392530373623, 12230.75538489243, 8428.957855210685, 8443.95778021106, 8494.923342722761, 8627.094155113622, 8629.09394513592, 11267.943660281646, 11506.827397588875, 11523.711907202387, 11647.30116193031, 12146.635600931986], "value": 9192.756950803267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.8878084143691, 1520.7034628247493, 1676.6479039401734, 1763.8765286429955, 1786.9285228590866, 7855.60721963901, 8401.747947561567, 8630.91369086309, 9293.860592091116, 9354.81290374193, 8486.0, 8647.0, 8765.60554775035, 8767.51778652174, 8783.516906570136, 2330.8135349172067, 2366.4557151855083, 2372.122314743547, 2392.055138220402, 2401.7958473529684, 2328.69726935499, 2349.9295021149305, 2363.2555744940287, 2379.1553998330605, 2379.845310054841, 2345.9061637534564, 2351.823613229015, 2358.174638876388, 2375.9168429104984, 2379.6192609182535, 2244.541048318606, 2253.0199363276947, 2254.391314345126, 2259.175400978639, 2308.226744040748, 2225.554889022202, 2255.221948427806, 2264.1509433962265, 2273.545290941818, 2281.9657705134437, 8875.644974201025, 8890.110988901122, 8896.599653015564, 8942.016378198394, 8944.642214311485, 5179.119549676527, 5306.8407947761625, 5320.308359913225, 5332.466753324676, 5347.037533244014, 3240.173755692307, 3313.7797675557435, 3458.7924724516356, 3463.705585025276, 3470.7049900758466, 1086.0770819650288, 1123.0790751583704, 1137.0448822988646, 1142.7428828513519, 1153.5270539078938, 12309.630711078593, 12482.251064936132, 12499.625011249676, 12524.624261272085, 12559.686007849785, 4405.118976204772, 4580.473245576802, 4696.647751418657, 4731.4795372509, 4756.738379389098, 10660.520276587416, 10668.786624267472, 10675.519601617945, 10698.51856666452, 10714.142868570496, 5301.443348448434, 5393.487618676298, 5398.001369746609, 5401.027814993339, 5412.025835349675, 4339.826406943687, 4731.645126615517, 4827.927581086286, 4848.0, 4931.802727890916, 3930.194310166466, 3990.541087774885, 3992.0818211811447, 4070.1452694933805, 4082.8772087676125, 1215.8966487848631, 1261.5962891874512, 1262.4255963536568, 1272.0396100943728, 1272.974540509203, 923.6397804856111, 994.1549682769588, 999.2655398282257, 1010.939343639384, 1013.366645846346, 5969.224000879858, 6078.057901025348, 6161.784337548164, 6179.258488981351, 6268.279147897959, 458.16613762951107, 458.17985805408614, 466.1074043207288, 473.92417213245716, 478.51430797740323, 4155.293600087993, 4212.094399704079, 4232.174725928415, 4271.957280427156, 4386.824527018884, 10750.78498430027, 11146.888531114586, 11184.161187910777, 11225.045871101049, 11281.774364512828, 11057.944710276397, 11106.833397499044, 11131.944340278247, 11179.4969226385, 11187.0, 7861.764147075597, 8104.797380065427, 8359.665613375519, 8359.791005224917, 8415.70545030921, 6033.668148251888, 6120.8775824484155, 6263.843403914939, 6296.0, 6339.936600633934, 10259.897401026194, 10336.948315258376, 10349.741256468347, 10362.948185259327, 10476.947615261875, 9825.361351512129, 10268.897311026794, 10274.589016439259, 10364.844527331945, 10392.948035259775, 7246.96376518114, 7763.417743669134, 7995.800104997422, 8041.155678653658, 8145.918540814516, 8701.43440676354, 8813.911860881566, 8818.735437936872, 8827.514486703292, 8860.734177974671, 7633.465657403928, 7816.335611473089, 7865.016872890888, 7938.0, 8064.0, 7667.156612772702, 7841.607919604111, 7845.254700803414, 7874.72438464651, 7875.291223789886, 6818.0, 6980.860382792417, 6989.965050174716, 7003.509754317352, 7019.403350715246, 4973.104841128486, 5187.844364669066, 5230.555402790806, 5231.790728370823, 5549.195366671729, 5066.620003499678, 5073.467285934924, 5112.9744351278005, 5177.92233116496, 5404.891902161856], "value": 4609.957661180697, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.62414478481037, 323.116276982453, 323.15011519703177, 323.2081400568606, 330.3920785754212, 5515.889682206353, 5571.582131340156, 5665.206871038053, 5762.42375762424, 5825.825225243249, 5548.58385621078, 5578.553715702744, 5597.468240517144, 5606.635568688032, 5623.437656234374, 4353.542877997812, 4359.498657654362, 4362.323839804835, 4364.694471387004, 4372.300431930892, 4093.8127942896526, 4278.6363159131515, 4328.805203765823, 4346.608805207531, 4370.847020354288, 4241.724287921275, 4276.615104640582, 4296.720713153651, 4300.849470268541, 4302.13957208558, 4280.57194280571, 4306.181825453154, 4307.332363483665, 4327.285997810358, 4344.956550434518, 3547.0954906498937, 3757.1170774867883, 3764.887053388403, 3774.584795672474, 3800.20195758891, 5452.0, 5453.4273901240595, 5453.700046497441, 5459.153831156177, 5473.562115030788, 4880.829170979035, 4886.558465252759, 4893.951060489385, 4904.754762261909, 4910.926336104962, 5578.30271216098, 5825.621334613236, 5829.446202610745, 5838.38696936824, 5852.268466441695, 4084.6732261419015, 4094.4267802507675, 4099.959000409987, 4109.465769449952, 4136.58634136587, 6163.599366041193, 6205.6897155142515, 6220.595661282002, 6220.782272620482, 6264.123022776815, 4052.5744796796503, 4174.290370636999, 4174.415581818487, 4217.325227963511, 4222.514410842792, 4220.53574106848, 4222.619964203236, 4224.556421575752, 4227.661787057028, 4229.492460904711, 4889.951100489021, 4894.510548945148, 4896.4124305083615, 4903.485134060944, 4903.950960490421, 5872.706364681749, 5972.25346831646, 5977.432143946318, 6018.472241658514, 6047.546434017467, 1443.328852083765, 1466.779983002558, 1468.08978433372, 1484.1762821634097, 1485.1831492678984, 905.4974489158581, 931.7344556801279, 935.6865450074165, 950.7195377363694, 957.698325027614, 5049.293098966147, 5062.696238225718, 5106.514881086291, 5115.641905066684, 5169.612279079084, 5423.674579525241, 5446.537044351275, 5454.863628409322, 5531.755355045083, 5536.944630553643, 4965.925511117336, 5068.189089745623, 5100.537030098663, 5124.974375128175, 5161.303224064778, 2817.9714404242713, 2833.2633515286175, 2892.6673432555103, 2910.286979689947, 2910.563415487694, 5512.91730624041, 5513.917291240635, 5524.696141712164, 5556.222128901957, 5559.555235581225, 5265.605079619044, 5478.9316083363365, 5487.640314664733, 5490.670559766427, 5518.558515318765, 5482.588805839578, 5512.228288039678, 5520.23988005997, 5554.583406244547, 5563.471470210405, 5186.858891043964, 5402.864928376822, 5412.404635490014, 5438.042304770201, 5452.0731475648445, 5253.529011876681, 5331.440908364085, 5347.144456886879, 5374.408815030265, 5433.809816656398, 5499.835004949858, 5530.755579994469, 5533.944660553343, 5590.2453168821685, 5638.956792993309, 4048.39274108886, 4055.6552693020244, 4130.731502452331, 4153.210889930903, 4161.396597493407, 6071.241094863142, 6080.939190608037, 6098.573099882966, 6116.204893364013, 6148.846278842886, 5688.947544704243, 5880.26496687914, 5906.763729450774, 5919.91120133207, 5974.1934838796205, 5781.508571771446, 5801.767929282782, 5854.648721076749, 5868.94131058684, 5893.850699113803, 5836.124581312837, 5846.970765146317, 5849.502792262705, 5873.911891321548, 5878.970605146947, 5667.574931880208, 5974.701264936649, 5983.0, 6039.849003774941, 6048.727807248596, 5923.555733319932, 5936.436038576501, 5954.528870518686, 5966.403359663999, 5980.863635909163], "value": 4313.61761899219, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.6366816591704, 754.4530215593692, 757.1860250231002, 773.4817672159652, 859.8323326951245, 15966.28151733172, 16201.270942807572, 16810.411635592758, 16816.41142560009, 16842.24209910554, 15421.84578154221, 15547.68904621907, 15555.455559055436, 15585.688286234268, 15588.298526566303, 656.0520048529852, 787.4409169489669, 789.7078081109997, 799.2207597592359, 808.4098608016152, 816.6570040582969, 819.2217393476192, 819.2585709932521, 820.7906983719173, 821.2362502872327, 868.0711638546758, 868.3096937934325, 871.6339137562239, 871.9651213951435, 873.7597160780805, 859.1236938322938, 865.1651156633878, 866.4887716247413, 868.8436081505326, 870.5386145342978, 634.3561285295428, 635.4439865118022, 635.7552342348183, 636.0205283862846, 638.4222278837659, 15207.467738629095, 15238.542843714706, 15242.542723718307, 15258.00822946516, 15273.923630381889, 15174.772378414333, 15522.5343239703, 15537.223138843012, 15735.92132039344, 15778.526644200692, 12386.380680965916, 12410.81383779244, 12467.314297713621, 12519.3740312984, 12567.245965242024, 3840.462335273064, 3969.0672691917375, 4021.1354558769713, 4070.8575199867864, 4150.501939767217, 78975.60512197402, 79395.60302198453, 80181.59909200417, 80941.99999999942, 81102.59448702777, 11331.886681133083, 11395.544178232778, 11412.144089193343, 11567.595134170264, 11966.760664786829, 19871.801281986995, 19949.700754488695, 20002.499937501678, 20030.098645560985, 20083.0, 8239.70037453176, 8328.042275138316, 8479.19447652472, 8502.914970850212, 8503.574821258911, 4894.730789806524, 4929.408470983505, 4957.752112394366, 5000.174971129795, 5123.948760512421, 3493.6681015303507, 3543.450765131409, 3601.441776524643, 3602.5316708827686, 3603.9279214416088, 670.1622971285892, 671.6708812681751, 677.6679427080695, 680.3876511140014, 691.5712258399824, 594.7112468051681, 701.2846896165984, 734.372111844376, 738.660216300497, 755.5051441305953, 9988.300818942604, 10086.49567521621, 10146.239032072477, 10181.898181018243, 10316.48417579118, 627.9309275979639, 633.4900405173787, 691.3163318517087, 736.2306389822648, 794.2018271636967, 4772.308015337826, 5034.6727462715535, 5059.038782631288, 5151.150060240018, 5175.353080864892, 117772.41113794377, 119417.0, 120648.39675801565, 120983.0, 121196.0, 78307.0, 106508.46745766222, 106747.4662626682, 107425.4628726867, 108106.45946770215, 56372.71813640987, 56448.0, 87413.56293218747, 89676.10323896808, 90990.54504727566, 9370.083039246245, 9641.37331073478, 9661.13049825519, 9837.311388203043, 9840.311178217456, 49000.0, 51808.48191518037, 52888.0, 52986.2052069227, 53270.66823329293, 69298.0, 75858.0, 80692.59653701694, 81471.0, 83837.58081209555, 12310.692232694255, 12341.259524428562, 12483.750324993267, 12520.937395312965, 12857.485700571873, 13651.590452286448, 13913.791293130409, 13998.650033749238, 14045.438182472586, 14522.0, 12922.00465315984, 12969.480067601227, 13020.8046879295, 13137.0, 13144.474221031052, 13036.739265214832, 13135.474581017035, 13139.737205256033, 13161.473541058633, 13375.197488150352, 12793.765997158172, 13141.474341026253, 13321.66241370446, 13385.66535836612, 13408.396622151831, 10405.115565176742, 11050.281731687415, 11140.16448766362, 11150.832737509107, 11195.2723073, 10755.462226888782, 11430.542778288775, 11464.541418343506, 11545.711357216136, 11706.941465292619], "value": 7638.082714456417, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 106.0, 112.0, 112.0, 113.0, 113.0, 112.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 150.0, 180.0, 119.0, 147.0, 151.0, 120.0, 192.0, 120.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 162.0, 169.0, 167.0, 162.0, 162.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 74.0, 174.0, 76.0, 76.0, 74.0, 75.0, 160.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 163.0, 84.0, 86.0, 84.0, 146.0, 84.0, 84.0, 153.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 120.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 53.0, 52.0, 53.0, 53.0, 56.0, 53.0, 52.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 83.0, 76.0, 77.0, 79.0, 76.0, 76.0, 79.0, 76.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 125.0, 124.0, 122.0, 128.0, 123.0, 121.0, 129.0, 163.0, 127.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 159.0, 156.0, 161.0, 160.0, 156.0, 158.0, 159.0, 156.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 63.0, 64.0, 65.0, 64.0, 66.0, 63.0, 67.0], "value": 64.7, "unit": "score"}]}]} 22:33:43 INFO - Return code: 0 22:33:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:33:43 ERROR - # TBPL SUCCESS # 22:33:43 INFO - Running post-action listener: _resource_record_post_action 22:33:43 INFO - [mozharness: 2016-07-26 05:33:43.815438Z] Finished run-tests step (success) 22:33:43 INFO - Running post-run listener: _resource_record_post_run 22:33:43 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 564719616; Read time: 0; Write time: 1190868 22:33:43 INFO - TinderboxPrint: CPU usage
13.4% 22:33:43 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:33:43 INFO - TinderboxPrint: I/O write bytes / time
564,719,616 / 1,190,868 22:33:43 INFO - TinderboxPrint: CPU idle
8,252.1 (86.5%) 22:33:43 INFO - TinderboxPrint: CPU user
1,216.0 (12.8%) 22:33:43 INFO - TinderboxPrint: Swap in / out
0 / 0 22:33:43 INFO - install - Wall time: 20s; CPU: 15.0%; Read bytes: 0; Write bytes: 270557184; Read time: 0; Write time: 625896 22:33:43 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293576704; Read time: 0; Write time: 564940 22:33:44 INFO - Running post-run listener: _upload_blobber_files 22:33:44 INFO - Blob upload gear active. 22:33:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:33:44 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 22:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:33:44 INFO - (blobuploader) - INFO - Open directory for files ... 22:33:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:33:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:45 INFO - (blobuploader) - INFO - Done attempting. 22:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:33:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:46 INFO - (blobuploader) - INFO - Done attempting. 22:33:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:33:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:33:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:59 INFO - (blobuploader) - INFO - Done attempting. 22:33:59 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:59 INFO - Return code: 0 22:33:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:33:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7172eb6383ea2358bd5cd7ddc25e0f5ef94123b80fd7862b68256965ee7a58d50341ff00e5f591996f404fb2d54311b6f8390888e2442cfae44018f7e028c269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9e74c41180175686d0d102efc0bc4fac40b924b4e1d629e4eef73ca97c5e25185d93f3a5aa639ff441e753c55011748636b1122f11e754377d4b48e7adae1f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158682621c0795d7468f36cc8e7b0f46bba19a2025afe68c26f1dd3fcdeccd9c923ede4b580069e16e3f029a30493d0cc650528dc8c8f3694c7fe609dc651aa3"} 22:33:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:33:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:33:59 INFO - Contents: 22:33:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7172eb6383ea2358bd5cd7ddc25e0f5ef94123b80fd7862b68256965ee7a58d50341ff00e5f591996f404fb2d54311b6f8390888e2442cfae44018f7e028c269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9e74c41180175686d0d102efc0bc4fac40b924b4e1d629e4eef73ca97c5e25185d93f3a5aa639ff441e753c55011748636b1122f11e754377d4b48e7adae1f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158682621c0795d7468f36cc8e7b0f46bba19a2025afe68c26f1dd3fcdeccd9c923ede4b580069e16e3f029a30493d0cc650528dc8c8f3694c7fe609dc651aa3"} 22:33:59 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:59 INFO - Copying logs to upload dir... 22:33:59 INFO - mkdir: /builds/slave/test/build/upload/logs 22:33:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.708457 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-25 22:33:59.113528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 22:33:59.117505) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7172eb6383ea2358bd5cd7ddc25e0f5ef94123b80fd7862b68256965ee7a58d50341ff00e5f591996f404fb2d54311b6f8390888e2442cfae44018f7e028c269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9e74c41180175686d0d102efc0bc4fac40b924b4e1d629e4eef73ca97c5e25185d93f3a5aa639ff441e753c55011748636b1122f11e754377d4b48e7adae1f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158682621c0795d7468f36cc8e7b0f46bba19a2025afe68c26f1dd3fcdeccd9c923ede4b580069e16e3f029a30493d0cc650528dc8c8f3694c7fe609dc651aa3"} build_url:https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7172eb6383ea2358bd5cd7ddc25e0f5ef94123b80fd7862b68256965ee7a58d50341ff00e5f591996f404fb2d54311b6f8390888e2442cfae44018f7e028c269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9e74c41180175686d0d102efc0bc4fac40b924b4e1d629e4eef73ca97c5e25185d93f3a5aa639ff441e753c55011748636b1122f11e754377d4b48e7adae1f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158682621c0795d7468f36cc8e7b0f46bba19a2025afe68c26f1dd3fcdeccd9c923ede4b580069e16e3f029a30493d0cc650528dc8c8f3694c7fe609dc651aa3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 22:33:59.143352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:33:59.143714) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469508485.756718-1243252900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:33:59.227982) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 22:33:59.228302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 22:33:59.228628) ========= ========= Total master_lag: 0.18 =========