builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1469509437.94 results: success (0) buildid: 20160725203026 builduid: 2b87fc9b155e4445804412d751ffaebf revision: 94968a940273882150fc98556d4abf961b287ad8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:57.938430) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:57.939063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:57.939521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:57.960453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:57.960820) ========= 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=1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 22:03:58-- 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% 50.6K=0.2s 2016-07-25 22:03:58 (50.6 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.355482 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:58.330101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:58.330480) ========= 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=1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018011 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:58.380261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:58.380625) ========= 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=1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 22:03:58,530 truncating revision to first 12 chars 2016-07-25 22:03:58,530 Setting DEBUG logging. 2016-07-25 22:03:58,530 attempt 1/10 2016-07-25 22:03:58,530 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:03:58,850 unpacking tar archive at: fx-team-94968a940273/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:59.046451) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:59.046802) ========= script_repo_revision: 94968a940273882150fc98556d4abf961b287ad8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:59.047251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:59.047866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 22:03:59.058386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-25 22:03:59.058831) ========= /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=1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:03:59 INFO - MultiFileLogger online at 20160725 22:03:59 in /builds/slave/test 22:03:59 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:03:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:03:59 INFO - {'append_to_log': False, 22:03:59 INFO - 'base_work_dir': '/builds/slave/test', 22:03:59 INFO - 'blob_upload_branch': 'Fx-Team', 22:03:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:03:59 INFO - 'branch': 'Fx-Team', 22:03:59 INFO - 'buildbot_json_path': 'buildprops.json', 22:03:59 INFO - 'config_files': ('talos/linux_config.py',), 22:03:59 INFO - 'default_actions': ('clobber', 22:03:59 INFO - 'read-buildbot-config', 22:03:59 INFO - 'download-and-extract', 22:03:59 INFO - 'populate-webroot', 22:03:59 INFO - 'create-virtualenv', 22:03:59 INFO - 'install', 22:03:59 INFO - 'run-tests'), 22:03:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:03:59 INFO - 'download_minidump_stackwalk': True, 22:03:59 INFO - 'download_symbols': 'ondemand', 22:03:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:03:59 INFO - 'tooltool.py': '/tools/tooltool.py', 22:03:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:03:59 INFO - '/tools/misc-python/virtualenv.py')}, 22:03:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:03:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:03:59 INFO - 'installer_path': 'installer.exe', 22:03:59 INFO - 'log_level': 'info', 22:03:59 INFO - 'log_name': 'talos', 22:03:59 INFO - 'log_to_console': True, 22:03:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:03:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:03:59 INFO - 'opt_config_files': (), 22:03:59 INFO - 'pip_index': False, 22:03:59 INFO - 'sps_profile': False, 22:03:59 INFO - 'sps_profile_interval': 0, 22:03:59 INFO - 'suite': 'dromaeojs-e10s', 22:03:59 INFO - 'system_bits': '32', 22:03:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:03:59 INFO - 'title': 'talos-linux64-ix-027', 22:03:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:03:59 INFO - 'use_talos_json': True, 22:03:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:03:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:03:59 INFO - 'work_dir': 'build'} 22:03:59 INFO - [mozharness: 2016-07-26 05:03:59.308969Z] Running clobber step. 22:03:59 INFO - Running pre-action listener: _resource_record_pre_action 22:03:59 INFO - Running main action method: clobber 22:03:59 INFO - rmtree: /builds/slave/test/build 22:03:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:03:59 INFO - Running post-action listener: _resource_record_post_action 22:03:59 INFO - [mozharness: 2016-07-26 05:03:59.772316Z] Finished clobber step (success) 22:03:59 INFO - [mozharness: 2016-07-26 05:03:59.772419Z] Running read-buildbot-config step. 22:03:59 INFO - Running pre-action listener: _resource_record_pre_action 22:03:59 INFO - Running main action method: read_buildbot_config 22:03:59 INFO - Using buildbot properties: 22:03:59 INFO - { 22:03:59 INFO - "project": "", 22:03:59 INFO - "product": "firefox", 22:03:59 INFO - "script_repo_revision": "production", 22:03:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:03:59 INFO - "repository": "", 22:03:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:03:59 INFO - "buildid": "20160725203026", 22:03:59 INFO - "pgo_build": "True", 22:03:59 INFO - "basedir": "/builds/slave/test", 22:03:59 INFO - "buildnumber": 977, 22:03:59 INFO - "slavename": "talos-linux64-ix-027", 22:03:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:03:59 INFO - "platform": "ubuntu64_hw", 22:03:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:03:59 INFO - "branch": "fx-team", 22:03:59 INFO - "repo_path": "integration/fx-team", 22:03:59 INFO - "revision": "94968a940273882150fc98556d4abf961b287ad8", 22:03:59 INFO - "stage_platform": "linux64-pgo", 22:03:59 INFO - "builduid": "2b87fc9b155e4445804412d751ffaebf", 22:03:59 INFO - "slavebuilddir": "test" 22:03:59 INFO - } 22:03:59 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:03:59 INFO - Running post-action listener: _resource_record_post_action 22:03:59 INFO - [mozharness: 2016-07-26 05:03:59.774869Z] Finished read-buildbot-config step (success) 22:03:59 INFO - [mozharness: 2016-07-26 05:03:59.774959Z] Running download-and-extract step. 22:03:59 INFO - Running pre-action listener: _resource_record_pre_action 22:03:59 INFO - Running main action method: download_and_extract 22:03:59 INFO - mkdir: /builds/slave/test/build/tests 22:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:04:00 INFO - Downloaded 1361 bytes. 22:04:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:04:00 INFO - Using the following test package requirements: 22:04:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:04:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:04:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:00 INFO - u'jsshell-linux-x86_64.zip'], 22:04:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:04:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:04:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:04:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:04:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:04:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:00 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:04:00 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:04:00 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:04:00 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:04:00 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:04:02 INFO - Downloaded 24311872 bytes. 22:04:02 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:04:02 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:04:03 INFO - Return code: 0 22:04:03 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:04:03 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:04:03 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:04:03 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:04:03 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:04:03 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:04:03 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:04:17 INFO - Downloaded 24311872 bytes. 22:04: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:04: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:04:19 INFO - Return code: 0 22:04: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:04:19 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:04: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.talos.tests.zip 22:04: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.talos.tests.zip 22:04: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.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:04: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.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:04:20 INFO - Downloaded 14403248 bytes. 22:04:20 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:04:20 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:04:21 INFO - Return code: 0 22:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:21 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:04:21 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:04:21 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:04:21 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:04:21 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:04:22 INFO - Downloaded 60891209 bytes. 22:04:22 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:04:22 INFO - mkdir: /builds/slave/test/properties 22:04:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:04:22 INFO - Writing to file /builds/slave/test/properties/build_url 22:04:22 INFO - Contents: 22:04:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ENKMMFkITMut56AH1Rjlwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:04:23 INFO - Running post-action listener: _resource_record_post_action 22:04:23 INFO - Running post-action listener: set_extra_try_arguments 22:04:23 INFO - [mozharness: 2016-07-26 05:04:23.537843Z] Finished download-and-extract step (success) 22:04:23 INFO - [mozharness: 2016-07-26 05:04:23.538002Z] Running populate-webroot step. 22:04:23 INFO - Running pre-action listener: _resource_record_pre_action 22:04:23 INFO - Running main action method: populate_webroot 22:04:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:04:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:04:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:04:23 INFO - '--tppagecycles', 22:04:23 INFO - '7'], 22:04:23 INFO - 'tests': ['tsvgm']}}, 22:04:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:04:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:04:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:04:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:04:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:23 INFO - 'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:23 INFO - 'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['damp', 'tps']}, 22:04:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:23 INFO - 'tests': ['damp', 'tps']}, 22:04:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['dromaeo_dom']}, 22:04:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:04:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['basic_compositor_video']}, 22:04:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:04:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['a11yr', 22:04:23 INFO - 'ts_paint', 22:04:23 INFO - 'tpaint', 22:04:23 INFO - 'sessionrestore', 22:04:23 INFO - 'sessionrestore_no_auto_restore', 22:04:23 INFO - 'tabpaint']}, 22:04:23 INFO - 'other-e10s': {'tests': ['a11yr', 22:04:23 INFO - 'ts_paint', 22:04:23 INFO - 'tpaint', 22:04:23 INFO - 'sessionrestore', 22:04:23 INFO - 'sessionrestore_no_auto_restore', 22:04:23 INFO - 'tabpaint']}, 22:04:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:04:23 INFO - 'ts_paint', 22:04:23 INFO - 'tpaint', 22:04:23 INFO - 'sessionrestore', 22:04:23 INFO - 'sessionrestore_no_auto_restore', 22:04:23 INFO - 'tabpaint']}, 22:04:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:04:23 INFO - 'ts_paint', 22:04:23 INFO - 'tpaint', 22:04:23 INFO - 'sessionrestore', 22:04:23 INFO - 'sessionrestore_no_auto_restore', 22:04:23 INFO - 'tabpaint']}, 22:04:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['a11yr', 22:04:23 INFO - 'ts_paint', 22:04:23 INFO - 'tpaint', 22:04:23 INFO - 'sessionrestore', 22:04:23 INFO - 'sessionrestore_no_auto_restore', 22:04:23 INFO - 'tabpaint']}, 22:04:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['a11yr', 22:04:23 INFO - 'ts_paint', 22:04:23 INFO - 'tpaint', 22:04:23 INFO - 'sessionrestore', 22:04:23 INFO - 'sessionrestore_no_auto_restore', 22:04:23 INFO - 'tabpaint']}, 22:04:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['tsvgx', 22:04:23 INFO - 'tsvgr_opacity', 22:04:23 INFO - 'tart', 22:04:23 INFO - 'tscrollx', 22:04:23 INFO - 'cart']}, 22:04:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:04:23 INFO - 'tsvgr_opacity', 22:04:23 INFO - 'tart', 22:04:23 INFO - 'tscrollx', 22:04:23 INFO - 'cart']}, 22:04:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:23 INFO - 'talos_options': ['--disable-e10s'], 22:04:23 INFO - 'tests': ['tp5o']}, 22:04:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:23 INFO - 'tests': ['tp5o']}, 22:04:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:23 INFO - 'talos_options': ['--disable-e10s', 22:04:23 INFO - '--xperf_path', 22:04:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:23 INFO - 'tests': ['tp5n']}, 22:04:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:23 INFO - 'talos_options': ['--xperf_path', 22:04:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:23 INFO - 'tests': ['tp5n']}}, 22:04:23 INFO - 'talos.zip': {'path': '', 22:04:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:04:23 INFO - Running post-action listener: _resource_record_post_action 22:04:23 INFO - [mozharness: 2016-07-26 05:04:23.558481Z] Finished populate-webroot step (success) 22:04:23 INFO - [mozharness: 2016-07-26 05:04:23.558570Z] Running create-virtualenv step. 22:04:23 INFO - Running pre-action listener: _resource_record_pre_action 22:04:23 INFO - Running main action method: create_virtualenv 22:04:23 INFO - Creating virtualenv /builds/slave/test/build/venv 22:04:23 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:04:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:04:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:04:23 INFO - Using real prefix '/usr' 22:04:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:04:24 INFO - Installing distribute.............................................................................................................................................................................................done. 22:04:26 INFO - Installing pip.................done. 22:04:26 INFO - Return code: 0 22:04:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:04:26 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:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:26 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:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:26 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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04:26 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:04:26 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:04:26 INFO - Using env: {'DISPLAY': ':0', 22:04:26 INFO - 'HOME': '/home/cltbld', 22:04:26 INFO - 'LANG': 'en_US.UTF-8', 22:04:26 INFO - 'LANGUAGE': 'en_US:en', 22:04:26 INFO - 'LOGNAME': 'cltbld', 22:04:26 INFO - 'MAIL': '/var/mail/cltbld', 22:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:26 INFO - 'MOZ_NO_REMOTE': '1', 22:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:26 INFO - 'NO_EM_RESTART': '1', 22:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:26 INFO - 'PWD': '/builds/slave/test', 22:04:26 INFO - 'SHELL': '/bin/bash', 22:04:26 INFO - 'SHLVL': '1', 22:04:26 INFO - 'TERM': 'linux', 22:04:26 INFO - 'TMOUT': '86400', 22:04:26 INFO - 'USER': 'cltbld', 22:04:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:26 INFO - '_': '/tools/buildbot/bin/python'} 22:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:26 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:04:26 INFO - Cleaning up... 22:04:26 INFO - Return code: 0 22:04:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:04:26 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:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:26 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:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:26 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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04:26 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:04:26 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:04:26 INFO - Using env: {'DISPLAY': ':0', 22:04:26 INFO - 'HOME': '/home/cltbld', 22:04:26 INFO - 'LANG': 'en_US.UTF-8', 22:04:26 INFO - 'LANGUAGE': 'en_US:en', 22:04:26 INFO - 'LOGNAME': 'cltbld', 22:04:26 INFO - 'MAIL': '/var/mail/cltbld', 22:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:26 INFO - 'MOZ_NO_REMOTE': '1', 22:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:26 INFO - 'NO_EM_RESTART': '1', 22:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:26 INFO - 'PWD': '/builds/slave/test', 22:04:26 INFO - 'SHELL': '/bin/bash', 22:04:26 INFO - 'SHLVL': '1', 22:04:26 INFO - 'TERM': 'linux', 22:04:26 INFO - 'TMOUT': '86400', 22:04:26 INFO - 'USER': 'cltbld', 22:04:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:26 INFO - '_': '/tools/buildbot/bin/python'} 22:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:26 INFO - Downloading/unpacking psutil>=3.1.1 22:04:26 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:04:26 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:04:26 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:04:26 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:04:26 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:04:26 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:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:04:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:28 INFO - Installing collected packages: psutil 22:04:28 INFO - Running setup.py install for psutil 22:04:28 INFO - building 'psutil._psutil_linux' extension 22:04:28 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:04:28 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:04:28 INFO - building 'psutil._psutil_posix' extension 22:04:28 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:04:28 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:04:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:29 INFO - Successfully installed psutil 22:04:29 INFO - Cleaning up... 22:04:30 INFO - Return code: 0 22:04:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:04:30 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:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:30 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:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:30 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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04:30 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:04:30 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:04:30 INFO - Using env: {'DISPLAY': ':0', 22:04:30 INFO - 'HOME': '/home/cltbld', 22:04:30 INFO - 'LANG': 'en_US.UTF-8', 22:04:30 INFO - 'LANGUAGE': 'en_US:en', 22:04:30 INFO - 'LOGNAME': 'cltbld', 22:04:30 INFO - 'MAIL': '/var/mail/cltbld', 22:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:30 INFO - 'MOZ_NO_REMOTE': '1', 22:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:30 INFO - 'NO_EM_RESTART': '1', 22:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:30 INFO - 'PWD': '/builds/slave/test', 22:04:30 INFO - 'SHELL': '/bin/bash', 22:04:30 INFO - 'SHLVL': '1', 22:04:30 INFO - 'TERM': 'linux', 22:04:30 INFO - 'TMOUT': '86400', 22:04:30 INFO - 'USER': 'cltbld', 22:04:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:30 INFO - '_': '/tools/buildbot/bin/python'} 22:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:04:30 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:04:30 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:04:30 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:04:30 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:04:30 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:04:30 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:04:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:04:32 INFO - Installing collected packages: mozsystemmonitor 22:04:32 INFO - Running setup.py install for mozsystemmonitor 22:04:32 INFO - Successfully installed mozsystemmonitor 22:04:32 INFO - Cleaning up... 22:04:32 INFO - Return code: 0 22:04:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:04: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:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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', '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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:04: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 jsonschema==2.5.1 22:04:32 INFO - Using env: {'DISPLAY': ':0', 22:04:32 INFO - 'HOME': '/home/cltbld', 22:04:32 INFO - 'LANG': 'en_US.UTF-8', 22:04:32 INFO - 'LANGUAGE': 'en_US:en', 22:04:32 INFO - 'LOGNAME': 'cltbld', 22:04:32 INFO - 'MAIL': '/var/mail/cltbld', 22:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:32 INFO - 'MOZ_NO_REMOTE': '1', 22:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:32 INFO - 'NO_EM_RESTART': '1', 22:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:32 INFO - 'PWD': '/builds/slave/test', 22:04:32 INFO - 'SHELL': '/bin/bash', 22:04:32 INFO - 'SHLVL': '1', 22:04:32 INFO - 'TERM': 'linux', 22:04:32 INFO - 'TMOUT': '86400', 22:04:32 INFO - 'USER': 'cltbld', 22:04:32 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:32 INFO - '_': '/tools/buildbot/bin/python'} 22:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:32 INFO - Downloading/unpacking jsonschema==2.5.1 22:04: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:04: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:04: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:04: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:04: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:04: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:04:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:04:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:04: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:04: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:04: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:04: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:04: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:04: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:04:34 INFO - Downloading functools32-3.2.3-2.tar.gz 22:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:04:34 INFO - warning: no files found matching '*.txt' 22:04:34 INFO - no previously-included directories found matching 'build' 22:04:34 INFO - no previously-included directories found matching 'dist' 22:04:34 INFO - no previously-included directories found matching '.git*' 22:04:34 INFO - Installing collected packages: jsonschema, functools32 22:04:35 INFO - Running setup.py install for functools32 22:04:35 INFO - warning: no files found matching '*.txt' 22:04:35 INFO - no previously-included directories found matching 'build' 22:04:35 INFO - no previously-included directories found matching 'dist' 22:04:35 INFO - no previously-included directories found matching '.git*' 22:04:35 INFO - Successfully installed jsonschema functools32 22:04:35 INFO - Cleaning up... 22:04:35 INFO - Return code: 0 22:04:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:35 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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04:35 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:04:35 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:04:35 INFO - Using env: {'DISPLAY': ':0', 22:04:35 INFO - 'HOME': '/home/cltbld', 22:04:35 INFO - 'LANG': 'en_US.UTF-8', 22:04:35 INFO - 'LANGUAGE': 'en_US:en', 22:04:35 INFO - 'LOGNAME': 'cltbld', 22:04:35 INFO - 'MAIL': '/var/mail/cltbld', 22:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:35 INFO - 'MOZ_NO_REMOTE': '1', 22:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:35 INFO - 'NO_EM_RESTART': '1', 22:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:35 INFO - 'PWD': '/builds/slave/test', 22:04:35 INFO - 'SHELL': '/bin/bash', 22:04:35 INFO - 'SHLVL': '1', 22:04:35 INFO - 'TERM': 'linux', 22:04:35 INFO - 'TMOUT': '86400', 22:04:35 INFO - 'USER': 'cltbld', 22:04:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:35 INFO - '_': '/tools/buildbot/bin/python'} 22:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:04:35 INFO - Cleaning up... 22:04:35 INFO - Return code: 0 22:04:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:35 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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04:35 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:04:35 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:04:35 INFO - Using env: {'DISPLAY': ':0', 22:04:35 INFO - 'HOME': '/home/cltbld', 22:04:35 INFO - 'LANG': 'en_US.UTF-8', 22:04:35 INFO - 'LANGUAGE': 'en_US:en', 22:04:35 INFO - 'LOGNAME': 'cltbld', 22:04:35 INFO - 'MAIL': '/var/mail/cltbld', 22:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:35 INFO - 'MOZ_NO_REMOTE': '1', 22:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:35 INFO - 'NO_EM_RESTART': '1', 22:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:35 INFO - 'PWD': '/builds/slave/test', 22:04:35 INFO - 'SHELL': '/bin/bash', 22:04:35 INFO - 'SHLVL': '1', 22:04:35 INFO - 'TERM': 'linux', 22:04:35 INFO - 'TMOUT': '86400', 22:04:35 INFO - 'USER': 'cltbld', 22:04:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:35 INFO - '_': '/tools/buildbot/bin/python'} 22:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:35 INFO - Downloading/unpacking blobuploader==1.2.4 22:04:35 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:04:35 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:04:35 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:04:35 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:04:35 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:04:35 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:04:37 INFO - Downloading blobuploader-1.2.4.tar.gz 22:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:04:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:04: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:04: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:04: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:04: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:04: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:04: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:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:04:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:04: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:04: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:04: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:04: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:04: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:04: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:04:38 INFO - Downloading docopt-0.6.1.tar.gz 22:04:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:04:38 INFO - Installing collected packages: blobuploader, requests, docopt 22:04:38 INFO - Running setup.py install for blobuploader 22:04:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:04:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:04:38 INFO - Running setup.py install for requests 22:04:38 INFO - Running setup.py install for docopt 22:04:38 INFO - Successfully installed blobuploader requests docopt 22:04:38 INFO - Cleaning up... 22:04:38 INFO - Return code: 0 22:04:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:38 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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04:38 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:04:38 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:04:38 INFO - Using env: {'DISPLAY': ':0', 22:04:38 INFO - 'HOME': '/home/cltbld', 22:04:38 INFO - 'LANG': 'en_US.UTF-8', 22:04:38 INFO - 'LANGUAGE': 'en_US:en', 22:04:38 INFO - 'LOGNAME': 'cltbld', 22:04:38 INFO - 'MAIL': '/var/mail/cltbld', 22:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:38 INFO - 'MOZ_NO_REMOTE': '1', 22:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:38 INFO - 'NO_EM_RESTART': '1', 22:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:38 INFO - 'PWD': '/builds/slave/test', 22:04:38 INFO - 'SHELL': '/bin/bash', 22:04:38 INFO - 'SHLVL': '1', 22:04:38 INFO - 'TERM': 'linux', 22:04:38 INFO - 'TMOUT': '86400', 22:04:38 INFO - 'USER': 'cltbld', 22:04:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:38 INFO - '_': '/tools/buildbot/bin/python'} 22:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:04:39 INFO - Running setup.py (path:/tmp/pip-BkhZ5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:04:39 INFO - Running setup.py (path:/tmp/pip-5ASakW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:04:39 INFO - Running setup.py (path:/tmp/pip-mhg3Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:04:39 INFO - Running setup.py (path:/tmp/pip-Fnxk_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:04:39 INFO - Running setup.py (path:/tmp/pip-rTDJCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:04:39 INFO - Running setup.py (path:/tmp/pip-jgnfbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:04:39 INFO - Running setup.py (path:/tmp/pip-rzvQco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:04:39 INFO - Running setup.py (path:/tmp/pip-z9FhK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:04:39 INFO - Running setup.py (path:/tmp/pip-QiKSTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:04:39 INFO - Running setup.py (path:/tmp/pip-Q6Et5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:04:39 INFO - Running setup.py (path:/tmp/pip-3OG6Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:04:39 INFO - Running setup.py (path:/tmp/pip-QVYPE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:04:39 INFO - Running setup.py (path:/tmp/pip-24bIen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:04:40 INFO - Running setup.py (path:/tmp/pip-wsdKx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:40 INFO - Running setup.py (path:/tmp/pip-1hc__I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:04:40 INFO - Running setup.py (path:/tmp/pip-1sRYGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:04:40 INFO - Running setup.py (path:/tmp/pip-6j29Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:04:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:04:40 INFO - Running setup.py install for manifestparser 22:04:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:04:40 INFO - Running setup.py install for mozcrash 22:04:40 INFO - Running setup.py install for mozdebug 22:04:40 INFO - Running setup.py install for mozdevice 22:04:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:04:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:04:40 INFO - Running setup.py install for mozfile 22:04:40 INFO - Running setup.py install for mozhttpd 22:04:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:04:40 INFO - Running setup.py install for mozinfo 22:04:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Running setup.py install for mozInstall 22:04:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Running setup.py install for mozleak 22:04:41 INFO - Running setup.py install for mozlog 22:04:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Running setup.py install for moznetwork 22:04:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Running setup.py install for mozprocess 22:04:41 INFO - Running setup.py install for mozprofile 22:04:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Running setup.py install for mozrunner 22:04:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:04:41 INFO - Running setup.py install for mozscreenshot 22:04:41 INFO - Running setup.py install for moztest 22:04:41 INFO - Running setup.py install for mozversion 22:04:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:04:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:04:42 INFO - Cleaning up... 22:04:42 INFO - Return code: 0 22:04:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:42 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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04:42 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:04:42 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:04:42 INFO - Using env: {'DISPLAY': ':0', 22:04:42 INFO - 'HOME': '/home/cltbld', 22:04:42 INFO - 'LANG': 'en_US.UTF-8', 22:04:42 INFO - 'LANGUAGE': 'en_US:en', 22:04:42 INFO - 'LOGNAME': 'cltbld', 22:04:42 INFO - 'MAIL': '/var/mail/cltbld', 22:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:42 INFO - 'MOZ_NO_REMOTE': '1', 22:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:42 INFO - 'NO_EM_RESTART': '1', 22:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:42 INFO - 'PWD': '/builds/slave/test', 22:04:42 INFO - 'SHELL': '/bin/bash', 22:04:42 INFO - 'SHLVL': '1', 22:04:42 INFO - 'TERM': 'linux', 22:04:42 INFO - 'TMOUT': '86400', 22:04:42 INFO - 'USER': 'cltbld', 22:04:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:42 INFO - '_': '/tools/buildbot/bin/python'} 22:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:04:42 INFO - Running setup.py (path:/tmp/pip-SC70kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:04:42 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:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:04:42 INFO - Running setup.py (path:/tmp/pip-WduDIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:04:42 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:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:04:42 INFO - Running setup.py (path:/tmp/pip-_dkEj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:04:42 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:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:04:42 INFO - Running setup.py (path:/tmp/pip-YDJtJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:04:42 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:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:04:42 INFO - Running setup.py (path:/tmp/pip-K13FCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:04:42 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:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:04:42 INFO - Running setup.py (path:/tmp/pip-u79iKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:04:42 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:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:04:42 INFO - Running setup.py (path:/tmp/pip-8F7utI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:04:42 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:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:04:42 INFO - Running setup.py (path:/tmp/pip-m5bWC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:04:42 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:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:04:42 INFO - Running setup.py (path:/tmp/pip-NzaYDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:04:42 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:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:04:42 INFO - Running setup.py (path:/tmp/pip-NGVX7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:04:43 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:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:04:43 INFO - Running setup.py (path:/tmp/pip-gOZIQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:04:43 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:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:04:43 INFO - Running setup.py (path:/tmp/pip-1BT7DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:04:43 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:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:04:43 INFO - Running setup.py (path:/tmp/pip-mMQsYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:04:43 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:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:04:43 INFO - Running setup.py (path:/tmp/pip-5t2rm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:04:43 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:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:43 INFO - Running setup.py (path:/tmp/pip-dooe4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:43 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:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:04:43 INFO - Running setup.py (path:/tmp/pip-r7RoMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:04:43 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:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:04:43 INFO - Running setup.py (path:/tmp/pip-GiN_i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:04:43 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:04:43 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:04:43 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:04:43 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:04:43 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:04:43 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:04:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:45 INFO - Downloading blessings-1.6.tar.gz 22:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:04:45 INFO - Installing collected packages: blessings 22:04:45 INFO - Running setup.py install for blessings 22:04:45 INFO - Successfully installed blessings 22:04:45 INFO - Cleaning up... 22:04:45 INFO - Return code: 0 22:04:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:04:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:04:45 INFO - Reading from file tmpfile_stdout 22:04:45 INFO - Current package versions: 22:04:45 INFO - argparse == 1.2.1 22:04:45 INFO - blessings == 1.6 22:04:45 INFO - blobuploader == 1.2.4 22:04:45 INFO - docopt == 0.6.1 22:04:45 INFO - functools32 == 3.2.3-2 22:04:45 INFO - jsonschema == 2.5.1 22:04:45 INFO - manifestparser == 1.1 22:04:45 INFO - mozInstall == 1.12 22:04:45 INFO - mozcrash == 0.17 22:04:45 INFO - mozdebug == 0.1 22:04:45 INFO - mozdevice == 0.48 22:04:45 INFO - mozfile == 1.2 22:04:45 INFO - mozhttpd == 0.7 22:04:45 INFO - mozinfo == 0.9 22:04:45 INFO - mozleak == 0.1 22:04:45 INFO - mozlog == 3.3 22:04:45 INFO - moznetwork == 0.27 22:04:45 INFO - mozprocess == 0.23 22:04:45 INFO - mozprofile == 0.28 22:04:45 INFO - mozrunner == 6.12 22:04:45 INFO - mozscreenshot == 0.1 22:04:45 INFO - mozsystemmonitor == 0.3 22:04:45 INFO - moztest == 0.7 22:04:45 INFO - mozversion == 1.4 22:04:45 INFO - psutil == 3.1.1 22:04:45 INFO - requests == 1.2.3 22:04:45 INFO - wsgiref == 0.1.2 22:04:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:45 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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04:45 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:04:45 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:04:45 INFO - Using env: {'DISPLAY': ':0', 22:04:45 INFO - 'HOME': '/home/cltbld', 22:04:45 INFO - 'LANG': 'en_US.UTF-8', 22:04:45 INFO - 'LANGUAGE': 'en_US:en', 22:04:45 INFO - 'LOGNAME': 'cltbld', 22:04:45 INFO - 'MAIL': '/var/mail/cltbld', 22:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:45 INFO - 'MOZ_NO_REMOTE': '1', 22:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:45 INFO - 'NO_EM_RESTART': '1', 22:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:45 INFO - 'PWD': '/builds/slave/test', 22:04:45 INFO - 'SHELL': '/bin/bash', 22:04:45 INFO - 'SHLVL': '1', 22:04:45 INFO - 'TERM': 'linux', 22:04:45 INFO - 'TMOUT': '86400', 22:04:45 INFO - 'USER': 'cltbld', 22:04:45 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:45 INFO - '_': '/tools/buildbot/bin/python'} 22:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 INFO - Cleaning up... 22:04:46 INFO - Return code: 0 22:04:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:04:46 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:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:46 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:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:46 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 0x1ed7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, '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': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', '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:04:46 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:04:46 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:04:46 INFO - Using env: {'DISPLAY': ':0', 22:04:46 INFO - 'HOME': '/home/cltbld', 22:04:46 INFO - 'LANG': 'en_US.UTF-8', 22:04:46 INFO - 'LANGUAGE': 'en_US:en', 22:04:46 INFO - 'LOGNAME': 'cltbld', 22:04:46 INFO - 'MAIL': '/var/mail/cltbld', 22:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:46 INFO - 'MOZ_NO_REMOTE': '1', 22:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:46 INFO - 'NO_EM_RESTART': '1', 22:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:46 INFO - 'PWD': '/builds/slave/test', 22:04:46 INFO - 'SHELL': '/bin/bash', 22:04:46 INFO - 'SHLVL': '1', 22:04:46 INFO - 'TERM': 'linux', 22:04:46 INFO - 'TMOUT': '86400', 22:04:46 INFO - 'USER': 'cltbld', 22:04:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:46 INFO - '_': '/tools/buildbot/bin/python'} 22:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:04:46 INFO - Cleaning up... 22:04:46 INFO - Return code: 0 22:04:46 INFO - Running post-action listener: _resource_record_post_action 22:04:46 INFO - Running post-action listener: _start_resource_monitoring 22:04:46 INFO - Starting resource monitoring. 22:04:46 INFO - [mozharness: 2016-07-26 05:04:46.365008Z] Finished create-virtualenv step (success) 22:04:46 INFO - [mozharness: 2016-07-26 05:04:46.365588Z] Running install step. 22:04:46 INFO - Running pre-action listener: _resource_record_pre_action 22:04:46 INFO - Running main action method: install 22:04:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:04:46 INFO - Reading from file tmpfile_stdout 22:04:46 INFO - Detecting whether we're running mozinstall >=1.0... 22:04:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:04:46 INFO - Reading from file tmpfile_stdout 22:04:46 INFO - Output received: 22:04:46 INFO - Usage: mozinstall [options] installer 22:04:46 INFO - Options: 22:04:46 INFO - -h, --help show this help message and exit 22:04:46 INFO - -d DEST, --destination=DEST 22:04:46 INFO - Directory to install application into. [default: 22:04:46 INFO - "/builds/slave/test"] 22:04:46 INFO - --app=APP Application being installed. [default: firefox] 22:04:46 INFO - mkdir: /builds/slave/test/build/application 22:04:46 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:04:46 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:05:03 INFO - Reading from file tmpfile_stdout 22:05:03 INFO - Output received: 22:05:03 INFO - /builds/slave/test/build/application/firefox/firefox 22:05:03 INFO - Running post-action listener: _resource_record_post_action 22:05:03 INFO - [mozharness: 2016-07-26 05:05:03.861764Z] Finished install step (success) 22:05:03 INFO - [mozharness: 2016-07-26 05:05:03.862042Z] Running run-tests step. 22:05:03 INFO - Running pre-action listener: _resource_record_pre_action 22:05:03 INFO - Running main action method: run_tests 22:05:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:05:03 INFO - Python 2.7.3 22:05:03 INFO - Return code: 0 22:05:03 INFO - grabbing minidump binary from tooltool 22:05:03 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:05:03 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 0x21963b0>, '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 0x21972b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2197740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:05:03 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:05:03 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:05:03 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:05:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:05:03 INFO - Return code: 0 22:05:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:05:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:05:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:05:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:05:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:05:03 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-027', '--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:05:03 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-027 --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:05:03 INFO - Using env: {'DISPLAY': ':0', 22:05:03 INFO - 'HOME': '/home/cltbld', 22:05:03 INFO - 'LANG': 'en_US.UTF-8', 22:05:03 INFO - 'LANGUAGE': 'en_US:en', 22:05:03 INFO - 'LOGNAME': 'cltbld', 22:05:03 INFO - 'MAIL': '/var/mail/cltbld', 22:05:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:05:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:03 INFO - 'MOZ_NO_REMOTE': '1', 22:05:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:03 INFO - 'NO_EM_RESTART': '1', 22:05:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:03 INFO - 'PWD': '/builds/slave/test', 22:05:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:05:03 INFO - 'SHELL': '/bin/bash', 22:05:03 INFO - 'SHLVL': '1', 22:05:03 INFO - 'TERM': 'linux', 22:05:03 INFO - 'TMOUT': '86400', 22:05:03 INFO - 'USER': 'cltbld', 22:05:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277', 22:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:03 INFO - '_': '/tools/buildbot/bin/python'} 22:05:03 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-027', '--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:05:04 INFO - mozversion application_buildid: 20160725203026 22:05:04 INFO - mozversion application_changeset: 94968a940273882150fc98556d4abf961b287ad8 22:05:04 INFO - mozversion application_display_name: Nightly 22:05:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:05:04 INFO - mozversion application_name: Firefox 22:05:04 INFO - mozversion application_remotingname: firefox 22:05:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:05:04 INFO - mozversion application_vendor: Mozilla 22:05:04 INFO - mozversion application_version: 50.0a1 22:05:04 INFO - mozversion platform_buildid: 20160725203026 22:05:04 INFO - mozversion platform_changeset: 94968a940273882150fc98556d4abf961b287ad8 22:05:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:05:04 INFO - mozversion platform_version: 50.0a1 22:05:04 INFO - using testdate: 1469509504 22:05:04 INFO - actual date: 1469509504 22:05:04 INFO - starting webserver on 'localhost:47309' 22:05:04 INFO - SUITE-START | Running 2 tests 22:05:04 INFO - TEST-START | dromaeo_css 22:05:04 INFO - operating with platform_type : linux_ 22:05:04 INFO - Initialising browser for dromaeo_css test... 22:05:04 INFO - TEST-INFO | started process 4239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwL_BGY/profile http://localhost:47309/getInfo.html) 22:05:07 INFO - PROCESS | 4239 | JavaScript error: , line 0: uncaught exception: undefined 22:05:08 INFO - PROCESS | 4239 | __metrics Screen width/height:1600/1200 22:05:08 INFO - PROCESS | 4239 | colorDepth:24 22:05:08 INFO - PROCESS | 4239 | Browser inner width/height: 1024/697 22:05:08 INFO - PROCESS | 4239 | __metrics 22:05:09 ERROR - PROCESS | 4239 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 22:05:10 INFO - TEST-INFO | 4239: exit 0 22:05:10 INFO - Browser initialized. 22:05:10 INFO - Running cycle 1/1 for dromaeo_css test... 22:05:10 INFO - TEST-INFO | started process 4358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwL_BGY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:22 INFO - PROCESS | 4358 | RSS: Main: 165167104 22:05:22 INFO - PROCESS | 4358 | 22:06:11 INFO - PROCESS | 4358 | 1469509571773 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:08:20 INFO - PROCESS | 4358 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47309/tests/dromaeo/cssquery-ext.html) 22:08:21 INFO - PROCESS | 4358 | RSS: Main: 170246144 22:08:21 INFO - PROCESS | 4358 | 22:11:23 INFO - PROCESS | 4358 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-ext.html (next: http://localhost:47309/tests/dromaeo/cssquery-jquery.html) 22:11:24 INFO - PROCESS | 4358 | RSS: Main: 166989824 22:11:24 INFO - PROCESS | 4358 | 22:14:25 INFO - PROCESS | 4358 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47309/tests/dromaeo/cssquery-mootools.html) 22:14:26 INFO - PROCESS | 4358 | RSS: Main: 170520576 22:14:26 INFO - PROCESS | 4358 | 22:17:28 INFO - PROCESS | 4358 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47309/tests/dromaeo/cssquery-prototype.html) 22:17:28 INFO - PROCESS | 4358 | RSS: Main: 164818944 22:17:28 INFO - PROCESS | 4358 | 22:20:31 INFO - PROCESS | 4358 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47309/tests/dromaeo/cssquery-yui.html) 22:20:32 INFO - PROCESS | 4358 | RSS: Main: 167206912 22:20:32 INFO - PROCESS | 4358 | 22:23:34 INFO - PROCESS | 4358 | Cycle 1(1): loaded http://localhost:47309/tests/dromaeo/cssquery-yui.html (next: http://localhost:47309/tests/dromaeo/cssquery-dojo.html) 22:23:35 INFO - PROCESS | 4358 | RSS: Main: 170135552 22:23:35 INFO - PROCESS | 4358 | 22:23:35 INFO - PROCESS | 4358 | __start_tp_report 22:23:35 INFO - PROCESS | 4358 | _x_x_mozilla_page_load 22:23:35 INFO - PROCESS | 4358 | _x_x_mozilla_page_load_details 22:23:35 INFO - PROCESS | 4358 | |i|pagename|runs| 22:23:35 INFO - PROCESS | 4358 | |0;dojo.html;3121.750259979202;3129.9843500782495;3159.826209558474;3163.572917656117;3171.3023134910313;5374.381946076202;5450.56395488361;5450.67295962242;5468.753906074221;5496.1755736639525;5471.151971444422;5500.532454741352;5530.806421775239;5545.057340252157;5582.106862901936;4939.592216218379;4977.178765503688;5032.094223039851;5042.394912610492;5226.764795584208;5198.532132108109;5205.141151709963;5219.321488206547;5261.158214685651;5268.236105764662;4957.975210123945;4980.053789779967;5024.171011783052;5026.472220416858;5036.672616279949;5040.34475518184;5044.369453818273;5055.949440505585;5064.822731204427;5095.082885080684;4973.52751488608;5007.474215207387;5008.148614735467;5028.245763135523;5030.144875371159;5351.812686555991;5424.213489044106;5534.446555344473;5545.029619816556;5553.666779993213;5981.132735753335;6000.96999515004;6001.099835024737;6009.849753756147;6017.277926648786;5987.042073268256;6023.578349515536;6036.215292012011;6042.0332746760305;6044.516438684895;5411.18832175173;5546.944530554723;5572.359178694462;5583.553315734772;5592.916106258409;6048.6673232971725;6050.273967123973;6060.090986352083;6078.057901025348;6106.603070800384;5837.737301821428;5838.38696936824;5848.152017957457;5856.326522449887;5864.413558644102;5753.309602847601;5884.235049443545;5899.852503687443;5918.082697181943;5926;5759.395263497272;5899.852503687356;5951.553633477506;5954.07711804671;5969.940300596939;5967.46292833647;5973.1936188614845;5977.581569290108;5979.611325263844;5998.880022399528;4414.09511050234;4504.054148628825;4512.481064677539;4527.298268768346;4540.2962540805565;3995.0411901143516;4030.1133750574827;4053.108316170438;4062.918741625151;4071.470708807836;5701.087825947829;5707.629004114802;5736.655800651891;5748.827535173951;5764.74058667361;5783.103618939072;5966.850828729316;6026.608270462406;6048.0625503047095;6065.878682426327;5685.232493613309;5737.053386191315;5742.425757424307;5747.080467125324;5790.131480277908;5103.18349064148;5106.131957567222;5122.462141475092;5152.742362881916;5188.662736922088;5975.760969561169;6105.095857753072;6157.404420267923;6173.32093469718;6212.968935155295;6002.129691194665;6018.067199584071;6020.729067191987;6081.057436097412;6086;6118.60229085108;6192.380761923771;6247.6563788990225;6253.843653908507;6257.9674353731125;5711.343195532567;5793.594448388572;5960.046392577166;5965.761369545169;6014.097885317237;5946.762129514771;5971.4327138921735;5973.880522389441;5992.191054207626;6024.638521688713;5796.449337312949;5815.273090863642;5823.1847541343395;5833.125031245348;5835.299764028344;5703.116017017369;5737.397573254915;5752.827415177551;5790.536757059341;5793.0731083028195;5775.537956963349;5813.069908814569;5826.76692932278;5827.562932779973;5887.764489420375;5898.233229680114;5905.4685078343155;5911.1428842816695;5934.970325148347;5942.821715348547;5615.5507559395965;5693.373728889902;5746.166805813217;5759.683217423082;5770.682612456355 22:23:35 INFO - PROCESS | 4358 | |1;ext.html;549.6814455945786;578.7569220927213;582.9387914268999;590.0676930449889;608.130373565801;44940;46808.06383872325;46872.765636171775;46922.2961655575;49734;47027.294590581085;48030;48087.51912480874;48136.27795583061;48182.27726584104;9087.318451116176;9256.67601633943;9260.39807412516;9261.166495015448;9261.768455788626;9092.454452732858;9114.77213069672;9173.633054677804;9182.908170918272;9197.264218862509;9107.089291070906;9167.083291670846;9195.72412827613;9200.539973001356;9202.125798049208;9058.23005044572;9103.863442048374;9150.54247287633;9157.450552966844;9215.58529866151;9050.7284781456;9120.224780893632;9128.726138215865;9133.315001374924;9135.588898499584;44418;44807.775961120315;44977.325340119925;44993.550064499264;45018.77490612526;3315.7015868571702;3357.9664203357897;3440.2947395784054;3456.2741824216946;3954.3079961006997;27764;29520;30292.54561181584;30386.392272154433;30449.847750761324;4328.199283132631;4476.690951072884;4495.865124046284;4525.094981003779;4667;384178;384193;385930;386099;387588;63782.68108659427;64108;64389.678051609444;64514.677426612565;64621.67689161618;66701.33298667049;66736.33263667398;66782.33217667858;66841.66579167171;66900.97539758352;14290.57128286153;14595;14631.92684036573;14826.220853497649;14938.402463901539;12244.571439999558;12410;12415.689607759878;12444.688882778002;12450.066245031478;19748.11133498996;19755.111020004133;19874.50313742168;19926.8117101266;20006.399808005783;7072.575645461289;7258.854822903512;7278.126624805057;7298.671559779823;7350.816229594196;985.7831277119022;1089.8528698625585;1107.070061148639;1125.8311253311904;1164.557468162093;34073.318533629186;34619.30761384758;34764;34928;35244.11889702778;1103.5309993252836;1122.9831552526718;1202.6572426858304;1211.3882489342825;1222.2605323778985;16863.747043794352;17871.285148594172;17936.013519256565;18051.370782494472;18213.54466138357;581264;628143;637370;639535;928256;62215.688921555105;63230;63360.68319658464;63387.683061584394;63401.365986339544;1356.891448684103;1359.6736783172166;1367.1523655333558;1374.979375309371;1402.3479082226813;32940.835295823366;35040.82479587586;35637.28725425529;35656.286874262885;35795;55158.44841551533;55754;56029;56064.43935560592;56186.438135619755;530982;532825;536226;536824;538575;29356.266093347836;29567.704322957357;29585.112446626637;29690.406191876475;29729.85135074311;49738.50261497339;49800.25299620581;49905.75047124741;51630;51804.48195518147;41680.37479437872;43419.34870976875;44746;45548.54451455575;45651.086978260915;42176.36735449032;42855.35716964186;43143.203883495196;44279;45766.771166145285;42314.788426057676;43810.123797523236;43814.56185438232;44363.11273774571;45666.315005274286;34034.31931361408;38821.41767873427;39749.205015898944;40048.79975600103;40239.79880100581;29802;30025.249368765955;30111;30122.54816177715;30143.246418839706 22:23:35 INFO - PROCESS | 4358 | |2;jquery.html;371.2982463144657;388.31462468742666;391.58687584598255;395.8060550330339;411.829090927265;17527.386541471053;20101.58780946285;20453.181872725072;20582.176712931465;20612.38162855113;18824.435266942015;19044.809551904476;19405.514862128453;19457.90271048643;19528.804711952875;5766.452187042224;5793.82618521443;5904.586678932476;5975.970120149394;6045.425684559959;5766.135079738031;5846.64920104793;5849.268841394825;5853.50245229156;5853.50245229156;5719.742611582468;5752.935706894238;5840.415958404168;5845.503132233765;5866.941330586682;5837.678927658977;5839.591228613998;5887.735051922674;5890.293164820207;5898.233229680136;5176.275321454999;5177.223416487519;5189.351331083614;5190.948090519122;5207.895842083175;22964.425889352733;23130.65304020441;23306.76693233063;23348.76651233483;23411.297661070024;2259.581977334182;2302.9424264393524;2310.0528783198806;2452.31335226137;2891.407261511406;14418.423263069464;14553.199574023425;14816.851831481763;14892.255387230594;15277.847221527754;1891.9810801891942;1970.655135351322;2009.7688765791975;2020.9595808083757;2022.383173132194;79024;80127.79808302938;80263.19736802674;80972.59513702393;81958.59020704919;9897.80204395908;10190.898091018995;10305.587776489007;10416.635417760343;10440.42577658221;14116.294185290695;14256;14284.42862285497;14297.78553321701;14336.713265734836;7729.458937874408;7966.0839003514175;7966.442349035628;8216.671333146607;8222.301104406073;7758.806029849186;7926.286634202949;7956.085050219183;8076.111627720946;8152.714654987166;6318.026277721829;6406.775762848278;6439.259485159173;6449.580777249464;6608.173978252718;1854.1841589700489;1881.0876724788466;1889.28207281235;1897.193692680633;1963.1656545967905;937.8874535055837;950.847864341702;962.3495704866189;992.1368409483796;1051.3796859852723;19947;20141.49646258826;20169.09239084245;20256.59486810285;20312;974.0648976982035;981.8085473332632;997.5610731278215;1092.5247517329988;1100.9394483303336;10924.344539327665;11398.590915904728;11578.47896844644;11591.536338546364;11703;455601;458553;461392;486584;498986;76565.6171719149;77743.22256777473;77750.6112469434;77832;83036.58481707553;995.3977843404781;1015.3146626027402;1030.2736570717775;1037.7924415117006;1046.1264843855465;16181.838181618034;16619.584510387336;17418.651626967643;17860.19629116667;18001.54996125055;42359;43470.78264608657;43927.34108988304;44008;44016.33975490306;60060.69969650124;61801;61837.07244391428;62086;65039.34960650333;6974.965125174342;7297.452691048086;7965.761027169194;7995.560244186626;8299.917000829915;11764.235324703866;13041.217526948414;13255.138416002928;13312.800307995582;13317.533886313933;11363.54545818158;11442.485088170886;11697.532098715956;11709.238899471507;11791.764164716486;11304.208705390873;11307.151963602599;11409.828852567052;11511.194216405107;11684.006859417044;11257.549698011988;11265.26775759573;11369.204155709353;11432.771344573228;11782.82325765097;7433.219511951167;7439.55362678241;7508.136564295176;7515.173330933702;7591.658375373232;10022.949885250528;10953.671389858317;11094.44527773592;11325.207235493437;11502.309861408008 22:23:35 INFO - PROCESS | 4358 | |3;mootools.html;1465.3918623771133;1503.331017697125;1628.1289510112092;1782.4474412931984;1795.8383745462913;7735.265149810773;8653.740387788368;8684.826303473927;9284.48935308557;9288.535573221337;8736.432131911437;9040.276777857773;9046.00493945667;9078.04680508547;9110.95444522778;2338.228384633071;2368.27767530903;2370.96443553346;2371.1937941100023;2371.632396978471;2312.2138472919205;2339.4736184358467;2363.4918492524102;2368.4078980254935;2370.383700237933;2303.9654405183937;2306.3542208181734;2306.6885970394032;2337.859728416292;2342.0865862313713;2186.5517568898335;2209.6464565669494;2234.028197733983;2237.1387015998957;2238.9664155037685;2187.628103222456;2220.7779222077825;2221.800037996572;2222.9888850555644;2226.3432287475234;9076.909230907739;9101.453912765255;9131.497767622777;9153.267738580898;9153.855768028996;5217.113090774577;5391.056565101131;5407.351117865842;5412.9458705412835;5420.024395608789;3165.889193878203;3275.410426123297;3355.865765369382;3377.1425715856426;3421.469672200813;1030.4590090202628;1051.910587600055;1065.957361705531;1076.784643071389;1092.0771947704177;12503.124781265315;12609.684757881034;12636.431360588796;12715.872841271654;12719.999999999907;4491.550844915482;4515.367848501212;4692.718436893797;4701;4720.763961801897;10547.314424562532;10674.466276686135;10691.30506517074;10692.198085143646;10703.518341674644;5406.378266499324;5412.0258353495965;5424.918626220609;5425.674459532441;5442.836714898559;4356.6732495063;4787.760611969387;4859.246816743411;4886.682365646222;4935.555799978019;3767.3030489359558;3871.922561548753;3928.980355098206;3958.841646334172;4000.9199816003515;1215.8905698487179;1219.2745316536646;1221.7556488702296;1225.075068323428;1236.8577613574373;967.0716112531908;983.5475681186734;1010.3988127064385;1013.3767732844395;1014.5840205515703;5994.460498555151;6072.817815465543;6122.632642041492;6131.110988906673;6269.62382257066;454.3616219212012;462.4058085360296;462.9837506672821;463.1038939651785;465.3996344715347;4120.91758164835;4267.722598031118;4272.914541709149;4328.28583283761;4400.185965596375;10997;11322.886771132184;11429.97130258264;11432.142589305835;11450.656480305604;11296.717582060513;11304.830427543593;11311.264767790068;11313.490892909838;11318.32090074598;7966.442349035512;8119;8173.386995975326;8239.464434811718;8264.917350826536;6114.633122012693;6123.295820980644;6161.938380616316;6218.378162183745;6245.313015568375;10128.291019628556;10330.121939635215;10378.948105259426;10395.94802025985;10561.10230630405;9603.759906002406;9918.355306905029;10044.849327260243;10046.04102200064;10164.491775411348;7714.190010048864;8305.12796156419;8400;8434.662613495391;8584;8787.736367908972;8821.867671984797;8850.73447796567;8859.11408859109;8915.910840891507;7713.575753333621;7745.53526788372;7846.960765196138;7908.655528560043;7982.361411086983;7559.697612095454;7598.12621548529;7747.49641273338;7760.30157285847;7818.061832580127;7166.104236970379;7312.1591017033725;7313.890291645524;7329.377002954809;7343.70625174987;5060.1650727631;5257.868553286198;5269.683818970874;5292.7353632319;5479.945200547943;5201.791928322825;5214.7914083436235;5255.710935898563;5297.655652382583;5505.944940550704 22:23:35 INFO - PROCESS | 4358 | |4;prototype.html;305.44409175300945;317.639479191118;318.6319800630272;325.73778108622577;327.1951000538674;5491.588130890189;5559.3328800543995;5684.289463817023;5695.971520142399;5719.942800571993;5545.195946587753;5596.636218645785;5606.299212598426;5618.353889302721;5626.099824028156;4324.632406245457;4332.263515202415;4332.588404101605;4338.674599405057;4357.782110894443;4084.9183016339657;4306.35404689296;4355.954570902976;4361.323994780814;4389.209942210401;4250.97874510627;4278.871633850974;4295.72077814941;4296.570342965694;4320.4599425071865;4248.299030659938;4260.510041345254;4302.376155457457;4310.461192350972;4341.978290108529;3548.290341931624;3788.9621103788886;3789.696824254053;3793.6585707286476;3796.52543432071;5473.562115030788;5473.67157970519;5493.533049690781;5495.763453222993;5560.888782224373;4934.407871055496;4942.431620363633;4952.851414457572;4968.552830245259;4974.726390048546;5558.221848941152;5878.853028674317;5884.6469211847;5899.32157801854;5908.527317814564;4069.6540794032544;4069.8779036628653;4083.734557253769;4101.712880098395;4110.321796903508;6067;6106.938930610681;6122.653016336443;6173.9073913891325;6199.473044791153;4103.7742924138865;4161.91904047976;4203.654830454226;4209.431726716915;4222.437698051741;4213.810378532973;4218.303979843292;4223.303154979455;4238.3430568261965;4256.489221293465;4931.630127740434;4958.95024559893;4972.254161875675;4975.90048199034;4979.435590670808;5814.79648212319;5867.765289388377;5950.613210141327;5983.551233657406;6016.608920420159;1439.2731670506328;1463.5975106845704;1463.831659359166;1465.6116129225763;1471.2496626720235;869.1829680100685;918.2791508665665;919.2278486071732;928.2713070239964;933.281373342536;5022.824201152942;5033.723145227048;5088.491150884882;5090.414602320707;5098.872528186825;5372.5433338166695;5390.54180394663;5415.214793854869;5439.238506609078;5467.890642187213;5163.793448262102;5173.818916337986;5181.300524429229;5339.492748188916;5760.452756988079;3181.5661019320237;3237.2877966847254;3254.625718042408;3265.1837040739815;3270.31323422084;6061.909071363933;6306.180196574416;6332.398422149889;6359.236891573041;6371.776987805404;6212.409821066992;6217.129601855744;6218.818424499331;6231.750729970841;6256.655883926428;6199.845003874939;6220.657863817533;6265.780697675559;6276.968615156987;6294.779682711083;5733.416614615865;6085.66528840918;6092.208012958287;6112.358202388685;6143.508519318533;6072.392760723892;6086;6087.391260873877;6091.9086213707715;6106.603070800384;6058.12157237207;6240.625562466266;6257.68711564429;6259.78090766821;6301;4095.7952102394165;4156.210320039183;4214.7049706521475;4215.135897141017;4228.13323268723;6131.049687298476;6160.767846430642;6169.722362493609;6181.1655426516845;6222.471089957405;5707;5912;5928.081147422156;5942.910856337072;5943.316518600416;5913.66942437948;5926.1999630049395;5931.50876631807;5935.317438494629;5985.132155837467;5879.147523609138;5879.206307148651;5882.617629854046;5893.204417403767;5922.845045216141;5660.490555849993;5956.851078723066;5986.59315060969;6004.039353703386;6011;5824.5631577631;5900.852478688067;5911.911321330097;5935.376785437467;5950.851228719317 22:23:35 INFO - PROCESS | 4358 | |5;yui.html;733.8202140475581;757.5151902782217;764.5794812852931;798.2416704131075;856.4133568505578;15658.84341156588;16414.671706565892;16450.09524476155;16504.092274924875;16529.752053719203;15484.458043968463;15624.2969066392;15632.2965466554;15642.921785391085;15673;650.4991156809255;782.941279404047;797.812514059197;813.0852790610563;814.1451475950258;793.3217099380033;793.5159552672865;795.1213908630966;795.3756301303478;801.3629164813987;865.1694373401542;872.7556284240391;875.3347455933505;876.0669886570813;877.5743764274322;863.546638015044;866.8439680857443;867.7917299848054;868.3140319147866;870.316801310971;630.1713247080075;630.2531500172311;633.6799916042415;635.0664523150961;635.2250254689271;15107.848921510755;15210.16344101074;15225.162616056112;15233;15243.466478673194;15194.848051519564;15205.923970380189;15264.542063738105;15567.29947152381;15774.447894323643;11818.468168932333;12027.21823081497;12121.515139394414;12130.575429859913;12749.490020399173;3904.531456225243;3916.2559113768293;4099.9180016399505;4158.854440094612;4160.022394737234;76367;77813.61093194554;78526.21473785247;78544;79269;11502.194846360675;11543.134264930164;11618.360990145624;11666.70833229176;12077.214981026205;21712.348629540822;21736.13055477795;21819.345419637437;21867.890660546596;21874.23440179586;8897.777555561162;8938.597763100675;9544.284178686627;9545.856812147824;9559.139677429064;5034.270030845507;5172.663776854492;5219.5041471060185;5245.10833158364;5325.547328477122;3519.472079188091;3573.999280201496;3622.4023036198732;3634.527511423551;3641.089727568108;620.3430775577942;642.0722056628127;655.2170156662837;657.14899205528;662.6819126819154;699.7341010416111;703.3177817517001;716.9820754481179;742.595285569366;748.5620911766568;9606.406270307118;9740.512974351253;9775.462349570842;9820.65627703027;10060.446675432922;583.5215123598693;604.6221111805122;700.7547358424613;725.26747984536;749.7675720526654;4440.600345968878;4783.689060211075;4805.639577031737;4815.374001379798;4864.659473836798;101753;118892;123358.38320808338;125899.3705031469;126121;102441.48779256055;103047;104522;108513.45743271233;109243.45378273216;58595.707021465474;59592;90128.54935725279;90163;93999;9873.851892221766;10494.580216791242;10701.625443109453;10877.12982961377;10993.230473866752;52309.215361768845;54504.727476362365;54831;54857.72571137119;55668.721656391455;71190.64404677943;77531;77697;78577.214227857;79845;13376.598702038955;13499.73000539964;13531.797023044859;13586.592402227949;13881.65295867571;15191.392344306547;15228.552295443747;15364.385424583339;15588.532344029698;15692.058476491447;14008.792965627661;14203.147811131365;14301.141931484144;14304.785428218793;14454.927725361305;13834.308284585932;14058.718825623635;14540.781888271473;14937.925310373379;15066.397344106113;14191.148531088167;14301.57095287143;14547.418103276173;14679.41282348694;14883.925580372028;11081.667549973514;11465.36940468249;11578.826317605075;11710.063194944554;11867.643970680894;10938.234323597271;11791.646250612152;12056.336901470504;12317.07621928341;12385.690357741129 22:23:35 INFO - PROCESS | 4358 | __end_tp_report 22:23:35 INFO - PROCESS | 4358 | __start_cc_report 22:23:35 INFO - PROCESS | 4358 | _x_x_mozilla_cycle_collect,351 22:23:35 INFO - PROCESS | 4358 | __end_cc_report 22:23:35 INFO - PROCESS | 4358 | __startTimestamp1469510615182__endTimestamp 22:23:35 INFO - PROCESS | 4358 | 22:23:35 INFO - PROCESS | 4358 | ------- Summary: start ------- 22:23:35 INFO - PROCESS | 4358 | Number of tests: 6 22:23:35 INFO - PROCESS | 4358 | 22:23:35 INFO - PROCESS | 4358 | [#0] dojo.html Cycles:165 Average:5533.96 Median:5759.68 stddev:646.82 (11.2%) stddev-sans-first:620.50 22:23:35 INFO - PROCESS | 4358 | Values: 3121.8 3130.0 3159.8 3163.6 3171.3 5374.4 5450.6 5450.7 5468.8 5496.2 5471.2 5500.5 5530.8 5545.1 5582.1 4939.6 4977.2 5032.1 5042.4 5226.8 5198.5 5205.1 5219.3 5261.2 5268.2 4958.0 4980.1 5024.2 5026.5 5036.7 5040.3 5044.4 5055.9 5064.8 5095.1 4973.5 5007.5 5008.1 5028.2 5030.1 5351.8 5424.2 5534.4 5545.0 5553.7 5981.1 6001.0 6001.1 6009.8 6017.3 5987.0 6023.6 6036.2 6042.0 6044.5 5411.2 5546.9 5572.4 5583.6 5592.9 6048.7 6050.3 6060.1 6078.1 6106.6 5837.7 5838.4 5848.2 5856.3 5864.4 5753.3 5884.2 5899.9 5918.1 5926.0 5759.4 5899.9 5951.6 5954.1 5969.9 5967.5 5973.2 5977.6 5979.6 5998.9 4414.1 4504.1 4512.5 4527.3 4540.3 3995.0 4030.1 4053.1 4062.9 4071.5 5701.1 5707.6 5736.7 5748.8 5764.7 5783.1 5966.9 6026.6 6048.1 6065.9 5685.2 5737.1 5742.4 5747.1 5790.1 5103.2 5106.1 5122.5 5152.7 5188.7 5975.8 6105.1 6157.4 6173.3 6213.0 6002.1 6018.1 6020.7 6081.1 6086.0 6118.6 6192.4 6247.7 6253.8 6258.0 5711.3 5793.6 5960.0 5965.8 6014.1 5946.8 5971.4 5973.9 5992.2 6024.6 5796.4 5815.3 5823.2 5833.1 5835.3 5703.1 5737.4 5752.8 5790.5 5793.1 5775.5 5813.1 5826.8 5827.6 5887.8 5898.2 5905.5 5911.1 5935.0 5942.8 5615.6 5693.4 5746.2 5759.7 5770.7 22:23:35 INFO - PROCESS | 4358 | 22:23:35 INFO - PROCESS | 4358 | [#1] ext.html Cycles:180 Average:69540.31 Median:24736.60 stddev:147752.30 (597.3%) stddev-sans-first:148075.99 22:23:35 INFO - PROCESS | 4358 | Values: 549.7 578.8 582.9 590.1 608.1 44940.0 46808.1 46872.8 46922.3 49734.0 47027.3 48030.0 48087.5 48136.3 48182.3 9087.3 9256.7 9260.4 9261.2 9261.8 9092.5 9114.8 9173.6 9182.9 9197.3 9107.1 9167.1 9195.7 9200.5 9202.1 9058.2 9103.9 9150.5 9157.5 9215.6 9050.7 9120.2 9128.7 9133.3 9135.6 44418.0 44807.8 44977.3 44993.6 45018.8 3315.7 3358.0 3440.3 3456.3 3954.3 27764.0 29520.0 30292.5 30386.4 30449.8 4328.2 4476.7 4495.9 4525.1 4667.0 384178.0 384193.0 385930.0 386099.0 387588.0 63782.7 64108.0 64389.7 64514.7 64621.7 66701.3 66736.3 66782.3 66841.7 66901.0 14290.6 14595.0 14631.9 14826.2 14938.4 12244.6 12410.0 12415.7 12444.7 12450.1 19748.1 19755.1 19874.5 19926.8 20006.4 7072.6 7258.9 7278.1 7298.7 7350.8 985.8 1089.9 1107.1 1125.8 1164.6 34073.3 34619.3 34764.0 34928.0 35244.1 1103.5 1123.0 1202.7 1211.4 1222.3 16863.7 17871.3 17936.0 18051.4 18213.5 581264.0 628143.0 637370.0 639535.0 928256.0 62215.7 63230.0 63360.7 63387.7 63401.4 1356.9 1359.7 1367.2 1375.0 1402.3 32940.8 35040.8 35637.3 35656.3 35795.0 55158.4 55754.0 56029.0 56064.4 56186.4 530982.0 532825.0 536226.0 536824.0 538575.0 29356.3 29567.7 29585.1 29690.4 29729.9 49738.5 49800.3 49905.8 51630.0 51804.5 41680.4 43419.3 44746.0 45548.5 45651.1 42176.4 42855.4 43143.2 44279.0 45766.8 42314.8 43810.1 43814.6 44363.1 45666.3 34034.3 38821.4 39749.2 40048.8 40239.8 29802.0 30025.2 30111.0 30122.5 30143.2 22:23:35 INFO - PROCESS | 4358 | 22:23:35 INFO - PROCESS | 4358 | [#2] jquery.html Cycles:180 Average:28384.18 Median:1631.35 stddev:77771.30 (4767.3%) stddev-sans-first:77961.03 22:23:35 INFO - PROCESS | 4358 | Values: 371.3 388.3 391.6 395.8 411.8 17527.4 20101.6 20453.2 20582.2 20612.4 18824.4 19044.8 19405.5 19457.9 19528.8 5766.5 5793.8 5904.6 5976.0 6045.4 5766.1 5846.6 5849.3 5853.5 5853.5 5719.7 5752.9 5840.4 5845.5 5866.9 5837.7 5839.6 5887.7 5890.3 5898.2 5176.3 5177.2 5189.4 5190.9 5207.9 22964.4 23130.7 23306.8 23348.8 23411.3 2259.6 2302.9 2310.1 2452.3 2891.4 14418.4 14553.2 14816.9 14892.3 15277.8 1892.0 1970.7 2009.8 2021.0 2022.4 79024.0 80127.8 80263.2 80972.6 81958.6 9897.8 10190.9 10305.6 10416.6 10440.4 14116.3 14256.0 14284.4 14297.8 14336.7 7729.5 7966.1 7966.4 8216.7 8222.3 7758.8 7926.3 7956.1 8076.1 8152.7 6318.0 6406.8 6439.3 6449.6 6608.2 1854.2 1881.1 1889.3 1897.2 1963.2 937.9 950.8 962.3 992.1 1051.4 19947.0 20141.5 20169.1 20256.6 20312.0 974.1 981.8 997.6 1092.5 1100.9 10924.3 11398.6 11578.5 11591.5 11703.0 455601.0 458553.0 461392.0 486584.0 498986.0 76565.6 77743.2 77750.6 77832.0 83036.6 995.4 1015.3 1030.3 1037.8 1046.1 16181.8 16619.6 17418.7 17860.2 18001.5 42359.0 43470.8 43927.3 44008.0 44016.3 60060.7 61801.0 61837.1 62086.0 65039.3 6975.0 7297.5 7965.8 7995.6 8299.9 11764.2 13041.2 13255.1 13312.8 13317.5 11363.5 11442.5 11697.5 11709.2 11791.8 11304.2 11307.2 11409.8 11511.2 11684.0 11257.5 11265.3 11369.2 11432.8 11782.8 7433.2 7439.6 7508.1 7515.2 7591.7 10022.9 10953.7 11094.4 11325.2 11502.3 22:23:35 INFO - PROCESS | 4358 | 22:23:35 INFO - PROCESS | 4358 | [#3] mootools.html Cycles:180 Average:5905.99 Median:462.69 stddev:3424.66 (740.2%) stddev-sans-first:3418.01 22:23:35 INFO - PROCESS | 4358 | Values: 1465.4 1503.3 1628.1 1782.4 1795.8 7735.3 8653.7 8684.8 9284.5 9288.5 8736.4 9040.3 9046.0 9078.0 9111.0 2338.2 2368.3 2371.0 2371.2 2371.6 2312.2 2339.5 2363.5 2368.4 2370.4 2304.0 2306.4 2306.7 2337.9 2342.1 2186.6 2209.6 2234.0 2237.1 2239.0 2187.6 2220.8 2221.8 2223.0 2226.3 9076.9 9101.5 9131.5 9153.3 9153.9 5217.1 5391.1 5407.4 5412.9 5420.0 3165.9 3275.4 3355.9 3377.1 3421.5 1030.5 1051.9 1066.0 1076.8 1092.1 12503.1 12609.7 12636.4 12715.9 12720.0 4491.6 4515.4 4692.7 4701.0 4720.8 10547.3 10674.5 10691.3 10692.2 10703.5 5406.4 5412.0 5424.9 5425.7 5442.8 4356.7 4787.8 4859.2 4886.7 4935.6 3767.3 3871.9 3929.0 3958.8 4000.9 1215.9 1219.3 1221.8 1225.1 1236.9 967.1 983.5 1010.4 1013.4 1014.6 5994.5 6072.8 6122.6 6131.1 6269.6 454.4 462.4 463.0 463.1 465.4 4120.9 4267.7 4272.9 4328.3 4400.2 10997.0 11322.9 11430.0 11432.1 11450.7 11296.7 11304.8 11311.3 11313.5 11318.3 7966.4 8119.0 8173.4 8239.5 8264.9 6114.6 6123.3 6161.9 6218.4 6245.3 10128.3 10330.1 10378.9 10395.9 10561.1 9603.8 9918.4 10044.8 10046.0 10164.5 7714.2 8305.1 8400.0 8434.7 8584.0 8787.7 8821.9 8850.7 8859.1 8915.9 7713.6 7745.5 7847.0 7908.7 7982.4 7559.7 7598.1 7747.5 7760.3 7818.1 7166.1 7312.2 7313.9 7329.4 7343.7 5060.2 5257.9 5269.7 5292.7 5479.9 5201.8 5214.8 5255.7 5297.7 5505.9 22:23:35 INFO - PROCESS | 4358 | 22:23:35 INFO - PROCESS | 4358 | [#4] prototype.html Cycles:180 Average:4909.60 Median:5558.78 stddev:1480.95 (26.6%) stddev-sans-first:1444.23 22:23:35 INFO - PROCESS | 4358 | Values: 305.4 317.6 318.6 325.7 327.2 5491.6 5559.3 5684.3 5696.0 5719.9 5545.2 5596.6 5606.3 5618.4 5626.1 4324.6 4332.3 4332.6 4338.7 4357.8 4084.9 4306.4 4356.0 4361.3 4389.2 4251.0 4278.9 4295.7 4296.6 4320.5 4248.3 4260.5 4302.4 4310.5 4342.0 3548.3 3789.0 3789.7 3793.7 3796.5 5473.6 5473.7 5493.5 5495.8 5560.9 4934.4 4942.4 4952.9 4968.6 4974.7 5558.2 5878.9 5884.6 5899.3 5908.5 4069.7 4069.9 4083.7 4101.7 4110.3 6067.0 6106.9 6122.7 6173.9 6199.5 4103.8 4161.9 4203.7 4209.4 4222.4 4213.8 4218.3 4223.3 4238.3 4256.5 4931.6 4959.0 4972.3 4975.9 4979.4 5814.8 5867.8 5950.6 5983.6 6016.6 1439.3 1463.6 1463.8 1465.6 1471.2 869.2 918.3 919.2 928.3 933.3 5022.8 5033.7 5088.5 5090.4 5098.9 5372.5 5390.5 5415.2 5439.2 5467.9 5163.8 5173.8 5181.3 5339.5 5760.5 3181.6 3237.3 3254.6 3265.2 3270.3 6061.9 6306.2 6332.4 6359.2 6371.8 6212.4 6217.1 6218.8 6231.8 6256.7 6199.8 6220.7 6265.8 6277.0 6294.8 5733.4 6085.7 6092.2 6112.4 6143.5 6072.4 6086.0 6087.4 6091.9 6106.6 6058.1 6240.6 6257.7 6259.8 6301.0 4095.8 4156.2 4214.7 4215.1 4228.1 6131.0 6160.8 6169.7 6181.2 6222.5 5707.0 5912.0 5928.1 5942.9 5943.3 5913.7 5926.2 5931.5 5935.3 5985.1 5879.1 5879.2 5882.6 5893.2 5922.8 5660.5 5956.9 5986.6 6004.0 6011.0 5824.6 5900.9 5911.9 5935.4 5950.9 22:23:35 INFO - PROCESS | 4358 | 22:23:35 INFO - PROCESS | 4358 | [#5] yui.html Cycles:180 Average:21407.51 Median:3910.39 stddev:30724.84 (785.7%) stddev-sans-first:30771.82 22:23:35 INFO - PROCESS | 4358 | Values: 733.8 757.5 764.6 798.2 856.4 15658.8 16414.7 16450.1 16504.1 16529.8 15484.5 15624.3 15632.3 15642.9 15673.0 650.5 782.9 797.8 813.1 814.1 793.3 793.5 795.1 795.4 801.4 865.2 872.8 875.3 876.1 877.6 863.5 866.8 867.8 868.3 870.3 630.2 630.3 633.7 635.1 635.2 15107.8 15210.2 15225.2 15233.0 15243.5 15194.8 15205.9 15264.5 15567.3 15774.4 11818.5 12027.2 12121.5 12130.6 12749.5 3904.5 3916.3 4099.9 4158.9 4160.0 76367.0 77813.6 78526.2 78544.0 79269.0 11502.2 11543.1 11618.4 11666.7 12077.2 21712.3 21736.1 21819.3 21867.9 21874.2 8897.8 8938.6 9544.3 9545.9 9559.1 5034.3 5172.7 5219.5 5245.1 5325.5 3519.5 3574.0 3622.4 3634.5 3641.1 620.3 642.1 655.2 657.1 662.7 699.7 703.3 717.0 742.6 748.6 9606.4 9740.5 9775.5 9820.7 10060.4 583.5 604.6 700.8 725.3 749.8 4440.6 4783.7 4805.6 4815.4 4864.7 101753.0 118892.0 123358.4 125899.4 126121.0 102441.5 103047.0 104522.0 108513.5 109243.5 58595.7 59592.0 90128.5 90163.0 93999.0 9873.9 10494.6 10701.6 10877.1 10993.2 52309.2 54504.7 54831.0 54857.7 55668.7 71190.6 77531.0 77697.0 78577.2 79845.0 13376.6 13499.7 13531.8 13586.6 13881.7 15191.4 15228.6 15364.4 15588.5 15692.1 14008.8 14203.1 14301.1 14304.8 14454.9 13834.3 14058.7 14540.8 14937.9 15066.4 14191.1 14301.6 14547.4 14679.4 14883.9 11081.7 11465.4 11578.8 11710.1 11867.6 10938.2 11791.6 12056.3 12317.1 12385.7 22:23:35 INFO - PROCESS | 4358 | -------- Summary: end -------- 22:23:35 INFO - PROCESS | 4358 | 22:23:35 INFO - TEST-INFO | 4358: exit 0 22:23:35 INFO - TEST-OK | dromaeo_css | took 1111744ms 22:23:35 INFO - TEST-START | kraken 22:23:35 INFO - operating with platform_type : linux_ 22:23:35 INFO - Initialising browser for kraken test... 22:23:35 INFO - TEST-INFO | started process 4603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrNaDG/profile http://localhost:47309/getInfo.html) 22:23:39 INFO - PROCESS | 4603 | JavaScript error: , line 0: uncaught exception: undefined 22:23:40 INFO - PROCESS | 4603 | __metrics Screen width/height:1600/1200 22:23:40 INFO - PROCESS | 4603 | colorDepth:24 22:23:40 INFO - PROCESS | 4603 | Browser inner width/height: 1024/697 22:23:40 INFO - PROCESS | 4603 | __metrics 22:23:40 ERROR - PROCESS | 4603 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 22:23:41 INFO - TEST-INFO | 4603: exit 0 22:23:41 INFO - Browser initialized. 22:23:41 INFO - Running cycle 1/1 for kraken test... 22:23:41 INFO - TEST-INFO | started process 4726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrNaDG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:23:53 INFO - PROCESS | 4726 | RSS: Main: 164352000 22:23:53 INFO - PROCESS | 4726 | 22:23:55 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47309/tests/kraken/driver.html?testName=audio-beat-detection) 22:23:56 INFO - PROCESS | 4726 | RSS: Main: 170201088 22:23:56 INFO - PROCESS | 4726 | 22:23:59 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47309/tests/kraken/driver.html?testName=audio-dft) 22:23:59 INFO - PROCESS | 4726 | RSS: Main: 169598976 22:23:59 INFO - PROCESS | 4726 | 22:24:02 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47309/tests/kraken/driver.html?testName=audio-fft) 22:24:03 INFO - PROCESS | 4726 | RSS: Main: 165343232 22:24:03 INFO - PROCESS | 4726 | 22:24:05 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47309/tests/kraken/driver.html?testName=audio-oscillator) 22:24:06 INFO - PROCESS | 4726 | RSS: Main: 166453248 22:24:06 INFO - PROCESS | 4726 | 22:24:08 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47309/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:24:08 INFO - PROCESS | 4726 | RSS: Main: 166387712 22:24:08 INFO - PROCESS | 4726 | 22:24:12 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47309/tests/kraken/driver.html?testName=imaging-darkroom) 22:24:12 INFO - PROCESS | 4726 | RSS: Main: 166051840 22:24:12 INFO - PROCESS | 4726 | 22:24:16 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47309/tests/kraken/driver.html?testName=imaging-desaturate) 22:24:16 INFO - PROCESS | 4726 | RSS: Main: 167563264 22:24:16 INFO - PROCESS | 4726 | 22:24:19 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47309/tests/kraken/driver.html?testName=json-parse-financial) 22:24:20 INFO - PROCESS | 4726 | RSS: Main: 167235584 22:24:20 INFO - PROCESS | 4726 | 22:24:21 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47309/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:24:22 INFO - PROCESS | 4726 | RSS: Main: 166780928 22:24:22 INFO - PROCESS | 4726 | 22:24:24 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:24:24 INFO - PROCESS | 4726 | RSS: Main: 167055360 22:24:24 INFO - PROCESS | 4726 | 22:24:26 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:24:27 INFO - PROCESS | 4726 | RSS: Main: 167550976 22:24:27 INFO - PROCESS | 4726 | 22:24:30 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:24:30 INFO - PROCESS | 4726 | RSS: Main: 167538688 22:24:30 INFO - PROCESS | 4726 | 22:24:33 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:24:34 INFO - PROCESS | 4726 | RSS: Main: 167747584 22:24:34 INFO - PROCESS | 4726 | 22:24:35 INFO - PROCESS | 4726 | Cycle 1(1): loaded http://localhost:47309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47309/tests/kraken/driver.html?testName=ai-astar) 22:24:36 INFO - PROCESS | 4726 | RSS: Main: 168574976 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | __start_tp_report 22:24:36 INFO - PROCESS | 4726 | _x_x_mozilla_page_load 22:24:36 INFO - PROCESS | 4726 | _x_x_mozilla_page_load_details 22:24:36 INFO - PROCESS | 4726 | |i|pagename|runs| 22:24:36 INFO - PROCESS | 4726 | |0;ai-astar;102;112;106;113;112;113;115;111;111;112 22:24:36 INFO - PROCESS | 4726 | |1;audio-beat-detection;146;127;146;170;120;144;150;123;175;119 22:24:36 INFO - PROCESS | 4726 | |2;audio-dft;163;162;165;163;161;168;175;167;161;161 22:24:36 INFO - PROCESS | 4726 | |3;audio-fft;76;75;74;152;79;75;79;74;174;75 22:24:36 INFO - PROCESS | 4726 | |4;audio-oscillator;84;84;143;85;84;84;150;84;84;145 22:24:36 INFO - PROCESS | 4726 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;118;118 22:24:36 INFO - PROCESS | 4726 | |6;imaging-darkroom;150;147;150;147;147;147;146;147;146;147 22:24:36 INFO - PROCESS | 4726 | |7;imaging-desaturate;95;102;95;95;95;95;95;96;95;96 22:24:36 INFO - PROCESS | 4726 | |8;json-parse-financial;53;58;55;54;57;53;53;52;52;53 22:24:36 INFO - PROCESS | 4726 | |9;json-stringify-tinderbox;62;62;61;62;61;62;62;62;61;61 22:24:36 INFO - PROCESS | 4726 | |10;stanford-crypto-aes;82;77;86;79;82;77;77;75;83;77 22:24:36 INFO - PROCESS | 4726 | |11;stanford-crypto-ccm;129;121;130;127;134;128;126;130;177;126 22:24:36 INFO - PROCESS | 4726 | |12;stanford-crypto-pbkdf2;157;154;156;157;157;157;164;161;159;159 22:24:36 INFO - PROCESS | 4726 | |13;stanford-crypto-sha256-iterative;64;70;65;64;63;63;64;65;64;62 22:24:36 INFO - PROCESS | 4726 | __end_tp_report 22:24:36 INFO - PROCESS | 4726 | __start_cc_report 22:24:36 INFO - PROCESS | 4726 | _x_x_mozilla_cycle_collect,889 22:24:36 INFO - PROCESS | 4726 | __end_cc_report 22:24:36 INFO - PROCESS | 4726 | __startTimestamp1469510676104__endTimestamp 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | ------- Summary: start ------- 22:24:36 INFO - PROCESS | 4726 | Number of tests: 14 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.83 (3.4%) stddev-sans-first:2.45 22:24:36 INFO - PROCESS | 4726 | Values: 102.0 112.0 106.0 113.0 112.0 113.0 115.0 111.0 111.0 112.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:146.00 stddev:19.92 (13.6%) stddev-sans-first:21.08 22:24:36 INFO - PROCESS | 4726 | Values: 146.0 127.0 146.0 170.0 120.0 144.0 150.0 123.0 175.0 119.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:4.43 (2.7%) stddev-sans-first:4.66 22:24:36 INFO - PROCESS | 4726 | Values: 163.0 162.0 165.0 163.0 161.0 168.0 175.0 167.0 161.0 161.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.00 stddev:37.14 (49.5%) stddev-sans-first:38.86 22:24:36 INFO - PROCESS | 4726 | Values: 76.0 75.0 74.0 152.0 79.0 75.0 79.0 74.0 174.0 75.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.00 stddev:29.93 (35.6%) stddev-sans-first:30.97 22:24:36 INFO - PROCESS | 4726 | Values: 84.0 84.0 143.0 85.0 84.0 84.0 150.0 84.0 84.0 145.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:24:36 INFO - PROCESS | 4726 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.43 (1.0%) stddev-sans-first:1.17 22:24:36 INFO - PROCESS | 4726 | Values: 150.0 147.0 150.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:2.18 (2.3%) stddev-sans-first:2.29 22:24:36 INFO - PROCESS | 4726 | Values: 95.0 102.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:2.05 (3.8%) stddev-sans-first:2.15 22:24:36 INFO - PROCESS | 4726 | Values: 53.0 58.0 55.0 54.0 57.0 53.0 53.0 52.0 52.0 53.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 22:24:36 INFO - PROCESS | 4726 | Values: 62.0 62.0 61.0 62.0 61.0 62.0 62.0 62.0 61.0 61.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.50 stddev:3.54 (4.4%) stddev-sans-first:3.63 22:24:36 INFO - PROCESS | 4726 | Values: 82.0 77.0 86.0 79.0 82.0 77.0 77.0 75.0 83.0 77.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:129.50 stddev:15.89 (12.3%) stddev-sans-first:16.80 22:24:36 INFO - PROCESS | 4726 | Values: 129.0 121.0 130.0 127.0 134.0 128.0 126.0 130.0 177.0 126.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.00 stddev:2.81 (1.8%) stddev-sans-first:2.95 22:24:36 INFO - PROCESS | 4726 | Values: 157.0 154.0 156.0 157.0 157.0 157.0 164.0 161.0 159.0 159.0 22:24:36 INFO - PROCESS | 4726 | 22:24:36 INFO - PROCESS | 4726 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:2.17 (3.4%) stddev-sans-first:2.30 22:24:36 INFO - PROCESS | 4726 | Values: 64.0 70.0 65.0 64.0 63.0 63.0 64.0 65.0 64.0 62.0 22:24:36 INFO - PROCESS | 4726 | -------- Summary: end -------- 22:24:36 INFO - PROCESS | 4726 | 22:24:37 INFO - TEST-INFO | 4726: exit 0 22:24:37 INFO - TEST-OK | kraken | took 61246ms 22:24:37 INFO - SUITE-END | took 1172s 22:24:37 INFO - Completed test suite (00:19:33) 22:24:37 INFO - javascript benchmark 22:24:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7457.748877416153, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.750259979202, 3129.9843500782495, 3159.826209558474, 3163.572917656117, 3171.3023134910313, 5374.381946076202, 5450.56395488361, 5450.67295962242, 5468.753906074221, 5496.1755736639525, 5471.151971444422, 5500.532454741352, 5530.806421775239, 5545.057340252157, 5582.106862901936, 4939.592216218379, 4977.178765503688, 5032.094223039851, 5042.394912610492, 5226.764795584208, 5198.532132108109, 5205.141151709963, 5219.321488206547, 5261.158214685651, 5268.236105764662, 4957.975210123945, 4980.053789779967, 5024.171011783052, 5026.472220416858, 5036.672616279949, 5040.34475518184, 5044.369453818273, 5055.949440505585, 5064.822731204427, 5095.082885080684, 4973.52751488608, 5007.474215207387, 5008.148614735467, 5028.245763135523, 5030.144875371159, 5351.812686555991, 5424.213489044106, 5534.446555344473, 5545.029619816556, 5553.666779993213, 5981.132735753335, 6000.96999515004, 6001.099835024737, 6009.849753756147, 6017.277926648786, 5987.042073268256, 6023.578349515536, 6036.215292012011, 6042.0332746760305, 6044.516438684895, 5411.18832175173, 5546.944530554723, 5572.359178694462, 5583.553315734772, 5592.916106258409, 6048.6673232971725, 6050.273967123973, 6060.090986352083, 6078.057901025348, 6106.603070800384, 5837.737301821428, 5838.38696936824, 5848.152017957457, 5856.326522449887, 5864.413558644102, 5753.309602847601, 5884.235049443545, 5899.852503687443, 5918.082697181943, 5926.0, 5759.395263497272, 5899.852503687356, 5951.553633477506, 5954.07711804671, 5969.940300596939, 5967.46292833647, 5973.1936188614845, 5977.581569290108, 5979.611325263844, 5998.880022399528, 4414.09511050234, 4504.054148628825, 4512.481064677539, 4527.298268768346, 4540.2962540805565, 3995.0411901143516, 4030.1133750574827, 4053.108316170438, 4062.918741625151, 4071.470708807836, 5701.087825947829, 5707.629004114802, 5736.655800651891, 5748.827535173951, 5764.74058667361, 5783.103618939072, 5966.850828729316, 6026.608270462406, 6048.0625503047095, 6065.878682426327, 5685.232493613309, 5737.053386191315, 5742.425757424307, 5747.080467125324, 5790.131480277908, 5103.18349064148, 5106.131957567222, 5122.462141475092, 5152.742362881916, 5188.662736922088, 5975.760969561169, 6105.095857753072, 6157.404420267923, 6173.32093469718, 6212.968935155295, 6002.129691194665, 6018.067199584071, 6020.729067191987, 6081.057436097412, 6086.0, 6118.60229085108, 6192.380761923771, 6247.6563788990225, 6253.843653908507, 6257.9674353731125, 5711.343195532567, 5793.594448388572, 5960.046392577166, 5965.761369545169, 6014.097885317237, 5946.762129514771, 5971.4327138921735, 5973.880522389441, 5992.191054207626, 6024.638521688713, 5796.449337312949, 5815.273090863642, 5823.1847541343395, 5833.125031245348, 5835.299764028344, 5703.116017017369, 5737.397573254915, 5752.827415177551, 5790.536757059341, 5793.0731083028195, 5775.537956963349, 5813.069908814569, 5826.76692932278, 5827.562932779973, 5887.764489420375, 5898.233229680114, 5905.4685078343155, 5911.1428842816695, 5934.970325148347, 5942.821715348547, 5615.5507559395965, 5693.373728889902, 5746.166805813217, 5759.683217423082, 5770.682612456355], "value": 5488.5935618850235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.6814455945786, 578.7569220927213, 582.9387914268999, 590.0676930449889, 608.130373565801, 44940.0, 46808.06383872325, 46872.765636171775, 46922.2961655575, 49734.0, 47027.294590581085, 48030.0, 48087.51912480874, 48136.27795583061, 48182.27726584104, 9087.318451116176, 9256.67601633943, 9260.39807412516, 9261.166495015448, 9261.768455788626, 9092.454452732858, 9114.77213069672, 9173.633054677804, 9182.908170918272, 9197.264218862509, 9107.089291070906, 9167.083291670846, 9195.72412827613, 9200.539973001356, 9202.125798049208, 9058.23005044572, 9103.863442048374, 9150.54247287633, 9157.450552966844, 9215.58529866151, 9050.7284781456, 9120.224780893632, 9128.726138215865, 9133.315001374924, 9135.588898499584, 44418.0, 44807.775961120315, 44977.325340119925, 44993.550064499264, 45018.77490612526, 3315.7015868571702, 3357.9664203357897, 3440.2947395784054, 3456.2741824216946, 3954.3079961006997, 27764.0, 29520.0, 30292.54561181584, 30386.392272154433, 30449.847750761324, 4328.199283132631, 4476.690951072884, 4495.865124046284, 4525.094981003779, 4667.0, 384178.0, 384193.0, 385930.0, 386099.0, 387588.0, 63782.68108659427, 64108.0, 64389.678051609444, 64514.677426612565, 64621.67689161618, 66701.33298667049, 66736.33263667398, 66782.33217667858, 66841.66579167171, 66900.97539758352, 14290.57128286153, 14595.0, 14631.92684036573, 14826.220853497649, 14938.402463901539, 12244.571439999558, 12410.0, 12415.689607759878, 12444.688882778002, 12450.066245031478, 19748.11133498996, 19755.111020004133, 19874.50313742168, 19926.8117101266, 20006.399808005783, 7072.575645461289, 7258.854822903512, 7278.126624805057, 7298.671559779823, 7350.816229594196, 985.7831277119022, 1089.8528698625585, 1107.070061148639, 1125.8311253311904, 1164.557468162093, 34073.318533629186, 34619.30761384758, 34764.0, 34928.0, 35244.11889702778, 1103.5309993252836, 1122.9831552526718, 1202.6572426858304, 1211.3882489342825, 1222.2605323778985, 16863.747043794352, 17871.285148594172, 17936.013519256565, 18051.370782494472, 18213.54466138357, 581264.0, 628143.0, 637370.0, 639535.0, 928256.0, 62215.688921555105, 63230.0, 63360.68319658464, 63387.683061584394, 63401.365986339544, 1356.891448684103, 1359.6736783172166, 1367.1523655333558, 1374.979375309371, 1402.3479082226813, 32940.835295823366, 35040.82479587586, 35637.28725425529, 35656.286874262885, 35795.0, 55158.44841551533, 55754.0, 56029.0, 56064.43935560592, 56186.438135619755, 530982.0, 532825.0, 536226.0, 536824.0, 538575.0, 29356.266093347836, 29567.704322957357, 29585.112446626637, 29690.406191876475, 29729.85135074311, 49738.50261497339, 49800.25299620581, 49905.75047124741, 51630.0, 51804.48195518147, 41680.37479437872, 43419.34870976875, 44746.0, 45548.54451455575, 45651.086978260915, 42176.36735449032, 42855.35716964186, 43143.203883495196, 44279.0, 45766.771166145285, 42314.788426057676, 43810.123797523236, 43814.56185438232, 44363.11273774571, 45666.315005274286, 34034.31931361408, 38821.41767873427, 39749.205015898944, 40048.79975600103, 40239.79880100581, 29802.0, 30025.249368765955, 30111.0, 30122.54816177715, 30143.246418839706], "value": 21197.76665243306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.2982463144657, 388.31462468742666, 391.58687584598255, 395.8060550330339, 411.829090927265, 17527.386541471053, 20101.58780946285, 20453.181872725072, 20582.176712931465, 20612.38162855113, 18824.435266942015, 19044.809551904476, 19405.514862128453, 19457.90271048643, 19528.804711952875, 5766.452187042224, 5793.82618521443, 5904.586678932476, 5975.970120149394, 6045.425684559959, 5766.135079738031, 5846.64920104793, 5849.268841394825, 5853.50245229156, 5853.50245229156, 5719.742611582468, 5752.935706894238, 5840.415958404168, 5845.503132233765, 5866.941330586682, 5837.678927658977, 5839.591228613998, 5887.735051922674, 5890.293164820207, 5898.233229680136, 5176.275321454999, 5177.223416487519, 5189.351331083614, 5190.948090519122, 5207.895842083175, 22964.425889352733, 23130.65304020441, 23306.76693233063, 23348.76651233483, 23411.297661070024, 2259.581977334182, 2302.9424264393524, 2310.0528783198806, 2452.31335226137, 2891.407261511406, 14418.423263069464, 14553.199574023425, 14816.851831481763, 14892.255387230594, 15277.847221527754, 1891.9810801891942, 1970.655135351322, 2009.7688765791975, 2020.9595808083757, 2022.383173132194, 79024.0, 80127.79808302938, 80263.19736802674, 80972.59513702393, 81958.59020704919, 9897.80204395908, 10190.898091018995, 10305.587776489007, 10416.635417760343, 10440.42577658221, 14116.294185290695, 14256.0, 14284.42862285497, 14297.78553321701, 14336.713265734836, 7729.458937874408, 7966.0839003514175, 7966.442349035628, 8216.671333146607, 8222.301104406073, 7758.806029849186, 7926.286634202949, 7956.085050219183, 8076.111627720946, 8152.714654987166, 6318.026277721829, 6406.775762848278, 6439.259485159173, 6449.580777249464, 6608.173978252718, 1854.1841589700489, 1881.0876724788466, 1889.28207281235, 1897.193692680633, 1963.1656545967905, 937.8874535055837, 950.847864341702, 962.3495704866189, 992.1368409483796, 1051.3796859852723, 19947.0, 20141.49646258826, 20169.09239084245, 20256.59486810285, 20312.0, 974.0648976982035, 981.8085473332632, 997.5610731278215, 1092.5247517329988, 1100.9394483303336, 10924.344539327665, 11398.590915904728, 11578.47896844644, 11591.536338546364, 11703.0, 455601.0, 458553.0, 461392.0, 486584.0, 498986.0, 76565.6171719149, 77743.22256777473, 77750.6112469434, 77832.0, 83036.58481707553, 995.3977843404781, 1015.3146626027402, 1030.2736570717775, 1037.7924415117006, 1046.1264843855465, 16181.838181618034, 16619.584510387336, 17418.651626967643, 17860.19629116667, 18001.54996125055, 42359.0, 43470.78264608657, 43927.34108988304, 44008.0, 44016.33975490306, 60060.69969650124, 61801.0, 61837.07244391428, 62086.0, 65039.34960650333, 6974.965125174342, 7297.452691048086, 7965.761027169194, 7995.560244186626, 8299.917000829915, 11764.235324703866, 13041.217526948414, 13255.138416002928, 13312.800307995582, 13317.533886313933, 11363.54545818158, 11442.485088170886, 11697.532098715956, 11709.238899471507, 11791.764164716486, 11304.208705390873, 11307.151963602599, 11409.828852567052, 11511.194216405107, 11684.006859417044, 11257.549698011988, 11265.26775759573, 11369.204155709353, 11432.771344573228, 11782.82325765097, 7433.219511951167, 7439.55362678241, 7508.136564295176, 7515.173330933702, 7591.658375373232, 10022.949885250528, 10953.671389858317, 11094.44527773592, 11325.207235493437, 11502.309861408008], "value": 9295.044266459761, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.3918623771133, 1503.331017697125, 1628.1289510112092, 1782.4474412931984, 1795.8383745462913, 7735.265149810773, 8653.740387788368, 8684.826303473927, 9284.48935308557, 9288.535573221337, 8736.432131911437, 9040.276777857773, 9046.00493945667, 9078.04680508547, 9110.95444522778, 2338.228384633071, 2368.27767530903, 2370.96443553346, 2371.1937941100023, 2371.632396978471, 2312.2138472919205, 2339.4736184358467, 2363.4918492524102, 2368.4078980254935, 2370.383700237933, 2303.9654405183937, 2306.3542208181734, 2306.6885970394032, 2337.859728416292, 2342.0865862313713, 2186.5517568898335, 2209.6464565669494, 2234.028197733983, 2237.1387015998957, 2238.9664155037685, 2187.628103222456, 2220.7779222077825, 2221.800037996572, 2222.9888850555644, 2226.3432287475234, 9076.909230907739, 9101.453912765255, 9131.497767622777, 9153.267738580898, 9153.855768028996, 5217.113090774577, 5391.056565101131, 5407.351117865842, 5412.9458705412835, 5420.024395608789, 3165.889193878203, 3275.410426123297, 3355.865765369382, 3377.1425715856426, 3421.469672200813, 1030.4590090202628, 1051.910587600055, 1065.957361705531, 1076.784643071389, 1092.0771947704177, 12503.124781265315, 12609.684757881034, 12636.431360588796, 12715.872841271654, 12719.999999999907, 4491.550844915482, 4515.367848501212, 4692.718436893797, 4701.0, 4720.763961801897, 10547.314424562532, 10674.466276686135, 10691.30506517074, 10692.198085143646, 10703.518341674644, 5406.378266499324, 5412.0258353495965, 5424.918626220609, 5425.674459532441, 5442.836714898559, 4356.6732495063, 4787.760611969387, 4859.246816743411, 4886.682365646222, 4935.555799978019, 3767.3030489359558, 3871.922561548753, 3928.980355098206, 3958.841646334172, 4000.9199816003515, 1215.8905698487179, 1219.2745316536646, 1221.7556488702296, 1225.075068323428, 1236.8577613574373, 967.0716112531908, 983.5475681186734, 1010.3988127064385, 1013.3767732844395, 1014.5840205515703, 5994.460498555151, 6072.817815465543, 6122.632642041492, 6131.110988906673, 6269.62382257066, 454.3616219212012, 462.4058085360296, 462.9837506672821, 463.1038939651785, 465.3996344715347, 4120.91758164835, 4267.722598031118, 4272.914541709149, 4328.28583283761, 4400.185965596375, 10997.0, 11322.886771132184, 11429.97130258264, 11432.142589305835, 11450.656480305604, 11296.717582060513, 11304.830427543593, 11311.264767790068, 11313.490892909838, 11318.32090074598, 7966.442349035512, 8119.0, 8173.386995975326, 8239.464434811718, 8264.917350826536, 6114.633122012693, 6123.295820980644, 6161.938380616316, 6218.378162183745, 6245.313015568375, 10128.291019628556, 10330.121939635215, 10378.948105259426, 10395.94802025985, 10561.10230630405, 9603.759906002406, 9918.355306905029, 10044.849327260243, 10046.04102200064, 10164.491775411348, 7714.190010048864, 8305.12796156419, 8400.0, 8434.662613495391, 8584.0, 8787.736367908972, 8821.867671984797, 8850.73447796567, 8859.11408859109, 8915.910840891507, 7713.575753333621, 7745.53526788372, 7846.960765196138, 7908.655528560043, 7982.361411086983, 7559.697612095454, 7598.12621548529, 7747.49641273338, 7760.30157285847, 7818.061832580127, 7166.104236970379, 7312.1591017033725, 7313.890291645524, 7329.377002954809, 7343.70625174987, 5060.1650727631, 5257.868553286198, 5269.683818970874, 5292.7353632319, 5479.945200547943, 5201.791928322825, 5214.7914083436235, 5255.710935898563, 5297.655652382583, 5505.944940550704], "value": 4610.64495574273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.44409175300945, 317.639479191118, 318.6319800630272, 325.73778108622577, 327.1951000538674, 5491.588130890189, 5559.3328800543995, 5684.289463817023, 5695.971520142399, 5719.942800571993, 5545.195946587753, 5596.636218645785, 5606.299212598426, 5618.353889302721, 5626.099824028156, 4324.632406245457, 4332.263515202415, 4332.588404101605, 4338.674599405057, 4357.782110894443, 4084.9183016339657, 4306.35404689296, 4355.954570902976, 4361.323994780814, 4389.209942210401, 4250.97874510627, 4278.871633850974, 4295.72077814941, 4296.570342965694, 4320.4599425071865, 4248.299030659938, 4260.510041345254, 4302.376155457457, 4310.461192350972, 4341.978290108529, 3548.290341931624, 3788.9621103788886, 3789.696824254053, 3793.6585707286476, 3796.52543432071, 5473.562115030788, 5473.67157970519, 5493.533049690781, 5495.763453222993, 5560.888782224373, 4934.407871055496, 4942.431620363633, 4952.851414457572, 4968.552830245259, 4974.726390048546, 5558.221848941152, 5878.853028674317, 5884.6469211847, 5899.32157801854, 5908.527317814564, 4069.6540794032544, 4069.8779036628653, 4083.734557253769, 4101.712880098395, 4110.321796903508, 6067.0, 6106.938930610681, 6122.653016336443, 6173.9073913891325, 6199.473044791153, 4103.7742924138865, 4161.91904047976, 4203.654830454226, 4209.431726716915, 4222.437698051741, 4213.810378532973, 4218.303979843292, 4223.303154979455, 4238.3430568261965, 4256.489221293465, 4931.630127740434, 4958.95024559893, 4972.254161875675, 4975.90048199034, 4979.435590670808, 5814.79648212319, 5867.765289388377, 5950.613210141327, 5983.551233657406, 6016.608920420159, 1439.2731670506328, 1463.5975106845704, 1463.831659359166, 1465.6116129225763, 1471.2496626720235, 869.1829680100685, 918.2791508665665, 919.2278486071732, 928.2713070239964, 933.281373342536, 5022.824201152942, 5033.723145227048, 5088.491150884882, 5090.414602320707, 5098.872528186825, 5372.5433338166695, 5390.54180394663, 5415.214793854869, 5439.238506609078, 5467.890642187213, 5163.793448262102, 5173.818916337986, 5181.300524429229, 5339.492748188916, 5760.452756988079, 3181.5661019320237, 3237.2877966847254, 3254.625718042408, 3265.1837040739815, 3270.31323422084, 6061.909071363933, 6306.180196574416, 6332.398422149889, 6359.236891573041, 6371.776987805404, 6212.409821066992, 6217.129601855744, 6218.818424499331, 6231.750729970841, 6256.655883926428, 6199.845003874939, 6220.657863817533, 6265.780697675559, 6276.968615156987, 6294.779682711083, 5733.416614615865, 6085.66528840918, 6092.208012958287, 6112.358202388685, 6143.508519318533, 6072.392760723892, 6086.0, 6087.391260873877, 6091.9086213707715, 6106.603070800384, 6058.12157237207, 6240.625562466266, 6257.68711564429, 6259.78090766821, 6301.0, 4095.7952102394165, 4156.210320039183, 4214.7049706521475, 4215.135897141017, 4228.13323268723, 6131.049687298476, 6160.767846430642, 6169.722362493609, 6181.1655426516845, 6222.471089957405, 5707.0, 5912.0, 5928.081147422156, 5942.910856337072, 5943.316518600416, 5913.66942437948, 5926.1999630049395, 5931.50876631807, 5935.317438494629, 5985.132155837467, 5879.147523609138, 5879.206307148651, 5882.617629854046, 5893.204417403767, 5922.845045216141, 5660.490555849993, 5956.851078723066, 5986.59315060969, 6004.039353703386, 6011.0, 5824.5631577631, 5900.852478688067, 5911.911321330097, 5935.376785437467, 5950.851228719317], "value": 4423.267061240164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.8202140475581, 757.5151902782217, 764.5794812852931, 798.2416704131075, 856.4133568505578, 15658.84341156588, 16414.671706565892, 16450.09524476155, 16504.092274924875, 16529.752053719203, 15484.458043968463, 15624.2969066392, 15632.2965466554, 15642.921785391085, 15673.0, 650.4991156809255, 782.941279404047, 797.812514059197, 813.0852790610563, 814.1451475950258, 793.3217099380033, 793.5159552672865, 795.1213908630966, 795.3756301303478, 801.3629164813987, 865.1694373401542, 872.7556284240391, 875.3347455933505, 876.0669886570813, 877.5743764274322, 863.546638015044, 866.8439680857443, 867.7917299848054, 868.3140319147866, 870.316801310971, 630.1713247080075, 630.2531500172311, 633.6799916042415, 635.0664523150961, 635.2250254689271, 15107.848921510755, 15210.16344101074, 15225.162616056112, 15233.0, 15243.466478673194, 15194.848051519564, 15205.923970380189, 15264.542063738105, 15567.29947152381, 15774.447894323643, 11818.468168932333, 12027.21823081497, 12121.515139394414, 12130.575429859913, 12749.490020399173, 3904.531456225243, 3916.2559113768293, 4099.9180016399505, 4158.854440094612, 4160.022394737234, 76367.0, 77813.61093194554, 78526.21473785247, 78544.0, 79269.0, 11502.194846360675, 11543.134264930164, 11618.360990145624, 11666.70833229176, 12077.214981026205, 21712.348629540822, 21736.13055477795, 21819.345419637437, 21867.890660546596, 21874.23440179586, 8897.777555561162, 8938.597763100675, 9544.284178686627, 9545.856812147824, 9559.139677429064, 5034.270030845507, 5172.663776854492, 5219.5041471060185, 5245.10833158364, 5325.547328477122, 3519.472079188091, 3573.999280201496, 3622.4023036198732, 3634.527511423551, 3641.089727568108, 620.3430775577942, 642.0722056628127, 655.2170156662837, 657.14899205528, 662.6819126819154, 699.7341010416111, 703.3177817517001, 716.9820754481179, 742.595285569366, 748.5620911766568, 9606.406270307118, 9740.512974351253, 9775.462349570842, 9820.65627703027, 10060.446675432922, 583.5215123598693, 604.6221111805122, 700.7547358424613, 725.26747984536, 749.7675720526654, 4440.600345968878, 4783.689060211075, 4805.639577031737, 4815.374001379798, 4864.659473836798, 101753.0, 118892.0, 123358.38320808338, 125899.3705031469, 126121.0, 102441.48779256055, 103047.0, 104522.0, 108513.45743271233, 109243.45378273216, 58595.707021465474, 59592.0, 90128.54935725279, 90163.0, 93999.0, 9873.851892221766, 10494.580216791242, 10701.625443109453, 10877.12982961377, 10993.230473866752, 52309.215361768845, 54504.727476362365, 54831.0, 54857.72571137119, 55668.721656391455, 71190.64404677943, 77531.0, 77697.0, 78577.214227857, 79845.0, 13376.598702038955, 13499.73000539964, 13531.797023044859, 13586.592402227949, 13881.65295867571, 15191.392344306547, 15228.552295443747, 15364.385424583339, 15588.532344029698, 15692.058476491447, 14008.792965627661, 14203.147811131365, 14301.141931484144, 14304.785428218793, 14454.927725361305, 13834.308284585932, 14058.718825623635, 14540.781888271473, 14937.925310373379, 15066.397344106113, 14191.148531088167, 14301.57095287143, 14547.418103276173, 14679.41282348694, 14883.925580372028, 11081.667549973514, 11465.36940468249, 11578.826317605075, 11710.063194944554, 11867.643970680894, 10938.234323597271, 11791.646250612152, 12056.336901470504, 12317.07621928341, 12385.690357741129], "value": 7799.9904387619135, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 106.0, 113.0, 112.0, 113.0, 115.0, 111.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 127.0, 146.0, 170.0, 120.0, 144.0, 150.0, 123.0, 175.0, 119.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 163.0, 161.0, 168.0, 175.0, 167.0, 161.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 152.0, 79.0, 75.0, 79.0, 74.0, 174.0, 75.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 143.0, 85.0, 84.0, 84.0, 150.0, 84.0, 84.0, 145.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 150.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 102.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 55.0, 54.0, 57.0, 53.0, 53.0, 52.0, 52.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 86.0, 79.0, 82.0, 77.0, 77.0, 75.0, 83.0, 77.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 121.0, 130.0, 127.0, 134.0, 128.0, 126.0, 130.0, 177.0, 126.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 156.0, 157.0, 157.0, 157.0, 164.0, 161.0, 159.0, 159.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 65.0, 64.0, 63.0, 63.0, 64.0, 65.0, 64.0, 62.0], "value": 64.4, "unit": "score"}]}]} 22:24:37 INFO - Return code: 0 22:24:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:24:37 ERROR - # TBPL SUCCESS # 22:24:37 INFO - Running post-action listener: _resource_record_post_action 22:24:37 INFO - [mozharness: 2016-07-26 05:24:37.399673Z] Finished run-tests step (success) 22:24:37 INFO - Running post-run listener: _resource_record_post_run 22:24:37 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 310448128; Read time: 64; Write time: 241644 22:24:37 INFO - TinderboxPrint: CPU usage
13.3% 22:24:37 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 64 22:24:37 INFO - TinderboxPrint: I/O write bytes / time
310,448,128 / 241,644 22:24:37 INFO - TinderboxPrint: CPU idle
8,230.9 (86.7%) 22:24:37 INFO - TinderboxPrint: CPU user
1,208.9 (12.7%) 22:24:37 INFO - TinderboxPrint: Swap in / out
0 / 0 22:24:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13955072; Read time: 0; Write time: 3508 22:24:37 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296493056; Read time: 64; Write time: 238136 22:24:38 INFO - Running post-run listener: _upload_blobber_files 22:24:38 INFO - Blob upload gear active. 22:24:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:24:38 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:24:38 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:24:38 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:24:38 INFO - (blobuploader) - INFO - Open directory for files ... 22:24:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:24:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:24:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:24:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:24:41 INFO - (blobuploader) - INFO - Done attempting. 22:24:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:24:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:24:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:24:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:24:42 INFO - (blobuploader) - INFO - Done attempting. 22:24:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:24:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:24:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:24:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:24:43 INFO - (blobuploader) - INFO - Done attempting. 22:24:43 INFO - (blobuploader) - INFO - Iteration through files over. 22:24:43 INFO - Return code: 0 22:24:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:24:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:24:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df8a45ebc764eed80195b4df778637ae2ad6823509daa4bb7e8dce7e70890fa029ddd892bf24ba1113df162342a2ce28d3eef102621cedd813c7ad6e8b9b6200", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccf99716cf3dbf1dc01804ff629eb485d5050fd8f1c83d0889c22ba824800858ac111cc10ab7baca0a29eaef707e7520d9a3476d73b67c2f0e603cd1a06cac26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa81980c4a9cfba920dcb7f225e1f44d1cdc91171ac10d99a7f8b6ae73e3375d21c4360ff7c6148b84f9730c8628a271051f7bd33c9ef6087634228ebb71c0c9"} 22:24:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:24:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:24:43 INFO - Contents: 22:24:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df8a45ebc764eed80195b4df778637ae2ad6823509daa4bb7e8dce7e70890fa029ddd892bf24ba1113df162342a2ce28d3eef102621cedd813c7ad6e8b9b6200", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccf99716cf3dbf1dc01804ff629eb485d5050fd8f1c83d0889c22ba824800858ac111cc10ab7baca0a29eaef707e7520d9a3476d73b67c2f0e603cd1a06cac26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa81980c4a9cfba920dcb7f225e1f44d1cdc91171ac10d99a7f8b6ae73e3375d21c4360ff7c6148b84f9730c8628a271051f7bd33c9ef6087634228ebb71c0c9"} 22:24:43 INFO - Running post-run listener: copy_logs_to_upload_dir 22:24:43 INFO - Copying logs to upload dir... 22:24:43 INFO - mkdir: /builds/slave/test/build/upload/logs 22:24:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.516393 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-25 22:24:43.590213) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 22:24:43.594820) ========= 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=1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277 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/df8a45ebc764eed80195b4df778637ae2ad6823509daa4bb7e8dce7e70890fa029ddd892bf24ba1113df162342a2ce28d3eef102621cedd813c7ad6e8b9b6200", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccf99716cf3dbf1dc01804ff629eb485d5050fd8f1c83d0889c22ba824800858ac111cc10ab7baca0a29eaef707e7520d9a3476d73b67c2f0e603cd1a06cac26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa81980c4a9cfba920dcb7f225e1f44d1cdc91171ac10d99a7f8b6ae73e3375d21c4360ff7c6148b84f9730c8628a271051f7bd33c9ef6087634228ebb71c0c9"} 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.011210 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/df8a45ebc764eed80195b4df778637ae2ad6823509daa4bb7e8dce7e70890fa029ddd892bf24ba1113df162342a2ce28d3eef102621cedd813c7ad6e8b9b6200", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccf99716cf3dbf1dc01804ff629eb485d5050fd8f1c83d0889c22ba824800858ac111cc10ab7baca0a29eaef707e7520d9a3476d73b67c2f0e603cd1a06cac26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa81980c4a9cfba920dcb7f225e1f44d1cdc91171ac10d99a7f8b6ae73e3375d21c4360ff7c6148b84f9730c8628a271051f7bd33c9ef6087634228ebb71c0c9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 22:24:43.639013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:24:43.639357) ========= 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=1f5564757af27664ca02d71f000001b0-1469507458.614538-721074277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004680 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 22:24:43.724439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 22:24:43.724759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 22:24:43.725105) ========= ========= Total master_lag: 0.19 =========