builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1469481600.31 results: success (0) buildid: 20160725113021 builduid: e789c7a3c2c44177ae2e0e988055bd0c revision: 10a51f3936ca99c96f0d1ebfe9fca833c8a77bdf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:00.312093) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:00.312749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:00.313052) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:00.334664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:00.335097) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 14:20:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-25 14:20:00 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122199 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:00.473378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:00.473736) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018111 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:00.525165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:00.525536) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 10a51f3936ca99c96f0d1ebfe9fca833c8a77bdf --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 10a51f3936ca99c96f0d1ebfe9fca833c8a77bdf --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=a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 14:20:00,682 truncating revision to first 12 chars 2016-07-25 14:20:00,682 Setting DEBUG logging. 2016-07-25 14:20:00,682 attempt 1/10 2016-07-25 14:20:00,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/10a51f3936ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 14:20:00,979 unpacking tar archive at: fx-team-10a51f3936ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607739 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:01.147865) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:01.148350) ========= script_repo_revision: 10a51f3936ca99c96f0d1ebfe9fca833c8a77bdf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:01.148913) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:01.149312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 14:20:01.161687) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-25 14:20:01.162111) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:20:01 INFO - MultiFileLogger online at 20160725 14:20:01 in /builds/slave/test 14:20:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:20:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:20:01 INFO - {'append_to_log': False, 14:20:01 INFO - 'base_work_dir': '/builds/slave/test', 14:20:01 INFO - 'blob_upload_branch': 'Fx-Team', 14:20:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:20:01 INFO - 'branch': 'Fx-Team', 14:20:01 INFO - 'buildbot_json_path': 'buildprops.json', 14:20:01 INFO - 'config_files': ('talos/linux_config.py',), 14:20:01 INFO - 'default_actions': ('clobber', 14:20:01 INFO - 'read-buildbot-config', 14:20:01 INFO - 'download-and-extract', 14:20:01 INFO - 'populate-webroot', 14:20:01 INFO - 'create-virtualenv', 14:20:01 INFO - 'install', 14:20:01 INFO - 'run-tests'), 14:20:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:20:01 INFO - 'download_minidump_stackwalk': True, 14:20:01 INFO - 'download_symbols': 'ondemand', 14:20:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:20:01 INFO - 'tooltool.py': '/tools/tooltool.py', 14:20:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:20:01 INFO - '/tools/misc-python/virtualenv.py')}, 14:20:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:20:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:20:01 INFO - 'installer_path': 'installer.exe', 14:20:01 INFO - 'log_level': 'info', 14:20:01 INFO - 'log_name': 'talos', 14:20:01 INFO - 'log_to_console': True, 14:20:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:20:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:20:01 INFO - 'opt_config_files': (), 14:20:01 INFO - 'pip_index': False, 14:20:01 INFO - 'sps_profile': False, 14:20:01 INFO - 'sps_profile_interval': 0, 14:20:01 INFO - 'suite': 'dromaeojs', 14:20:01 INFO - 'system_bits': '32', 14:20:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:20:01 INFO - 'title': 'talos-linux64-ix-002', 14:20:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:20:01 INFO - 'use_talos_json': True, 14:20:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:20:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:20:01 INFO - 'work_dir': 'build'} 14:20:01 INFO - [mozharness: 2016-07-25 21:20:01.414561Z] Running clobber step. 14:20:01 INFO - Running pre-action listener: _resource_record_pre_action 14:20:01 INFO - Running main action method: clobber 14:20:01 INFO - rmtree: /builds/slave/test/build 14:20:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:20:01 INFO - Running post-action listener: _resource_record_post_action 14:20:01 INFO - [mozharness: 2016-07-25 21:20:01.884402Z] Finished clobber step (success) 14:20:01 INFO - [mozharness: 2016-07-25 21:20:01.884503Z] Running read-buildbot-config step. 14:20:01 INFO - Running pre-action listener: _resource_record_pre_action 14:20:01 INFO - Running main action method: read_buildbot_config 14:20:01 INFO - Using buildbot properties: 14:20:01 INFO - { 14:20:01 INFO - "project": "", 14:20:01 INFO - "product": "firefox", 14:20:01 INFO - "script_repo_revision": "production", 14:20:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:20:01 INFO - "repository": "", 14:20:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:20:01 INFO - "buildid": "20160725113021", 14:20:01 INFO - "pgo_build": "True", 14:20:01 INFO - "basedir": "/builds/slave/test", 14:20:01 INFO - "buildnumber": 316, 14:20:01 INFO - "slavename": "talos-linux64-ix-002", 14:20:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:20:01 INFO - "platform": "ubuntu64_hw", 14:20:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:20:01 INFO - "branch": "fx-team", 14:20:01 INFO - "repo_path": "integration/fx-team", 14:20:01 INFO - "revision": "10a51f3936ca99c96f0d1ebfe9fca833c8a77bdf", 14:20:01 INFO - "stage_platform": "linux64-pgo", 14:20:01 INFO - "builduid": "e789c7a3c2c44177ae2e0e988055bd0c", 14:20:01 INFO - "slavebuilddir": "test" 14:20:01 INFO - } 14:20:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:20:01 INFO - Running post-action listener: _resource_record_post_action 14:20:01 INFO - [mozharness: 2016-07-25 21:20:01.886928Z] Finished read-buildbot-config step (success) 14:20:01 INFO - [mozharness: 2016-07-25 21:20:01.887016Z] Running download-and-extract step. 14:20:01 INFO - Running pre-action listener: _resource_record_pre_action 14:20:01 INFO - Running main action method: download_and_extract 14:20:01 INFO - mkdir: /builds/slave/test/build/tests 14:20:01 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')]} 14:20:01 INFO - https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:20:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:20:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:20:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:05 INFO - Downloaded 1361 bytes. 14:20:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:20:05 INFO - Using the following test package requirements: 14:20:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:20:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:20:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:20:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:05 INFO - u'jsshell-linux-x86_64.zip'], 14:20:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:20:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:20:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:20:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:20:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:20:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:20:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:20:05 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')]} 14:20:05 INFO - https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:20:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:20:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:20:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:10 INFO - Downloaded 24311935 bytes. 14:20:10 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'] 14:20:10 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 14:20:11 INFO - Return code: 0 14:20:11 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 14:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:11 INFO - https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:20:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:20:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:20:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:13 INFO - Downloaded 24311935 bytes. 14:20:13 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'] 14:20:13 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 14:20:14 INFO - Return code: 0 14:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:14 INFO - https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:20:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:20:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:20:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:15 INFO - Downloaded 14403248 bytes. 14:20:15 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'] 14:20:15 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 14:20:15 INFO - Return code: 0 14:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:15 INFO - https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:20:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:20:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:20:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WcbABj3iT36PmXN0Rj96lw/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 14:20:17 INFO - Downloaded 60887463 bytes. 14:20:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:20:17 INFO - mkdir: /builds/slave/test/properties 14:20:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:20:17 INFO - Writing to file /builds/slave/test/properties/build_url 14:20:17 INFO - Contents: 14:20:17 INFO - build_url:https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:20:17 INFO - Running post-action listener: _resource_record_post_action 14:20:17 INFO - Running post-action listener: set_extra_try_arguments 14:20:17 INFO - [mozharness: 2016-07-25 21:20:17.768446Z] Finished download-and-extract step (success) 14:20:17 INFO - [mozharness: 2016-07-25 21:20:17.768677Z] Running populate-webroot step. 14:20:17 INFO - Running pre-action listener: _resource_record_pre_action 14:20:17 INFO - Running main action method: populate_webroot 14:20:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:20:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:20:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:20:17 INFO - '--tppagecycles', 14:20:17 INFO - '7'], 14:20:17 INFO - 'tests': ['tsvgm']}}, 14:20:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:20:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:20:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:20:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:20:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:17 INFO - 'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:20:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:20:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:17 INFO - 'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['damp', 'tps']}, 14:20:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:17 INFO - 'tests': ['damp', 'tps']}, 14:20:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['dromaeo_dom']}, 14:20:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:20:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['basic_compositor_video']}, 14:20:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:20:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['a11yr', 14:20:17 INFO - 'ts_paint', 14:20:17 INFO - 'tpaint', 14:20:17 INFO - 'sessionrestore', 14:20:17 INFO - 'sessionrestore_no_auto_restore', 14:20:17 INFO - 'tabpaint']}, 14:20:17 INFO - 'other-e10s': {'tests': ['a11yr', 14:20:17 INFO - 'ts_paint', 14:20:17 INFO - 'tpaint', 14:20:17 INFO - 'sessionrestore', 14:20:17 INFO - 'sessionrestore_no_auto_restore', 14:20:17 INFO - 'tabpaint']}, 14:20:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:20:17 INFO - 'ts_paint', 14:20:17 INFO - 'tpaint', 14:20:17 INFO - 'sessionrestore', 14:20:17 INFO - 'sessionrestore_no_auto_restore', 14:20:17 INFO - 'tabpaint']}, 14:20:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:20:17 INFO - 'ts_paint', 14:20:17 INFO - 'tpaint', 14:20:17 INFO - 'sessionrestore', 14:20:17 INFO - 'sessionrestore_no_auto_restore', 14:20:17 INFO - 'tabpaint']}, 14:20:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['a11yr', 14:20:17 INFO - 'ts_paint', 14:20:17 INFO - 'tpaint', 14:20:17 INFO - 'sessionrestore', 14:20:17 INFO - 'sessionrestore_no_auto_restore', 14:20:17 INFO - 'tabpaint']}, 14:20:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['a11yr', 14:20:17 INFO - 'ts_paint', 14:20:17 INFO - 'tpaint', 14:20:17 INFO - 'sessionrestore', 14:20:17 INFO - 'sessionrestore_no_auto_restore', 14:20:17 INFO - 'tabpaint']}, 14:20:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['tsvgx', 14:20:17 INFO - 'tsvgr_opacity', 14:20:17 INFO - 'tart', 14:20:17 INFO - 'tscrollx', 14:20:17 INFO - 'cart']}, 14:20:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:20:17 INFO - 'tsvgr_opacity', 14:20:17 INFO - 'tart', 14:20:17 INFO - 'tscrollx', 14:20:17 INFO - 'cart']}, 14:20:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:17 INFO - 'talos_options': ['--disable-e10s'], 14:20:17 INFO - 'tests': ['tp5o']}, 14:20:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:17 INFO - 'tests': ['tp5o']}, 14:20:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:17 INFO - 'talos_options': ['--disable-e10s', 14:20:17 INFO - '--xperf_path', 14:20:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:20:17 INFO - 'tests': ['tp5n']}, 14:20:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:17 INFO - 'talos_options': ['--xperf_path', 14:20:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:20:17 INFO - 'tests': ['tp5n']}}, 14:20:17 INFO - 'talos.zip': {'path': '', 14:20:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:20:17 INFO - Running post-action listener: _resource_record_post_action 14:20:17 INFO - [mozharness: 2016-07-25 21:20:17.789892Z] Finished populate-webroot step (success) 14:20:17 INFO - [mozharness: 2016-07-25 21:20:17.789980Z] Running create-virtualenv step. 14:20:17 INFO - Running pre-action listener: _resource_record_pre_action 14:20:17 INFO - Running main action method: create_virtualenv 14:20:17 INFO - Creating virtualenv /builds/slave/test/build/venv 14:20:17 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 14:20:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:20:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:20:17 INFO - Using real prefix '/usr' 14:20:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:20:18 INFO - Installing distribute.............................................................................................................................................................................................done. 14:20:20 INFO - Installing pip.................done. 14:20:20 INFO - Return code: 0 14:20:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:20 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 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:20 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 14:20:20 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 14:20:20 INFO - Using env: {'DISPLAY': ':0', 14:20:20 INFO - 'HOME': '/home/cltbld', 14:20:20 INFO - 'LANG': 'en_US.UTF-8', 14:20:20 INFO - 'LANGUAGE': 'en_US:en', 14:20:20 INFO - 'LOGNAME': 'cltbld', 14:20:20 INFO - 'MAIL': '/var/mail/cltbld', 14:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:20 INFO - 'MOZ_NO_REMOTE': '1', 14:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:20 INFO - 'NO_EM_RESTART': '1', 14:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:20 INFO - 'PWD': '/builds/slave/test', 14:20:20 INFO - 'SHELL': '/bin/bash', 14:20:20 INFO - 'SHLVL': '1', 14:20:20 INFO - 'TERM': 'linux', 14:20:20 INFO - 'TMOUT': '86400', 14:20:20 INFO - 'USER': 'cltbld', 14:20:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:20 INFO - '_': '/tools/buildbot/bin/python'} 14:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:20 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 14:20:20 INFO - Cleaning up... 14:20:20 INFO - Return code: 0 14:20:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:20 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 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:20 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 14:20:20 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 14:20:20 INFO - Using env: {'DISPLAY': ':0', 14:20:20 INFO - 'HOME': '/home/cltbld', 14:20:20 INFO - 'LANG': 'en_US.UTF-8', 14:20:20 INFO - 'LANGUAGE': 'en_US:en', 14:20:20 INFO - 'LOGNAME': 'cltbld', 14:20:20 INFO - 'MAIL': '/var/mail/cltbld', 14:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:20 INFO - 'MOZ_NO_REMOTE': '1', 14:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:20 INFO - 'NO_EM_RESTART': '1', 14:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:20 INFO - 'PWD': '/builds/slave/test', 14:20:20 INFO - 'SHELL': '/bin/bash', 14:20:20 INFO - 'SHLVL': '1', 14:20:20 INFO - 'TERM': 'linux', 14:20:20 INFO - 'TMOUT': '86400', 14:20:20 INFO - 'USER': 'cltbld', 14:20:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:20 INFO - '_': '/tools/buildbot/bin/python'} 14:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:20 INFO - Downloading/unpacking psutil>=3.1.1 14:20:20 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 14:20:20 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 14:20:20 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 14:20:20 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 14:20:20 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 14:20:20 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 14:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:20:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:20:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:20:22 INFO - Installing collected packages: psutil 14:20:22 INFO - Running setup.py install for psutil 14:20:22 INFO - building 'psutil._psutil_linux' extension 14:20:22 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 14:20:23 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 14:20:23 INFO - building 'psutil._psutil_posix' extension 14:20:23 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 14:20:23 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 14:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:20:23 INFO - Successfully installed psutil 14:20:23 INFO - Cleaning up... 14:20:23 INFO - Return code: 0 14:20:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:23 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 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:23 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 14:20:23 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 14:20:23 INFO - Using env: {'DISPLAY': ':0', 14:20:23 INFO - 'HOME': '/home/cltbld', 14:20:23 INFO - 'LANG': 'en_US.UTF-8', 14:20:23 INFO - 'LANGUAGE': 'en_US:en', 14:20:23 INFO - 'LOGNAME': 'cltbld', 14:20:23 INFO - 'MAIL': '/var/mail/cltbld', 14:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:23 INFO - 'MOZ_NO_REMOTE': '1', 14:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:23 INFO - 'NO_EM_RESTART': '1', 14:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:23 INFO - 'PWD': '/builds/slave/test', 14:20:23 INFO - 'SHELL': '/bin/bash', 14:20:23 INFO - 'SHLVL': '1', 14:20:23 INFO - 'TERM': 'linux', 14:20:23 INFO - 'TMOUT': '86400', 14:20:23 INFO - 'USER': 'cltbld', 14:20:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:23 INFO - '_': '/tools/buildbot/bin/python'} 14:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:20:23 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 14:20:23 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 14:20:23 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 14:20:23 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 14:20:23 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 14:20:23 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 14:20:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:20:25 INFO - Installing collected packages: mozsystemmonitor 14:20:25 INFO - Running setup.py install for mozsystemmonitor 14:20:25 INFO - Successfully installed mozsystemmonitor 14:20:25 INFO - Cleaning up... 14:20:25 INFO - Return code: 0 14:20:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:20:25 INFO - Using env: {'DISPLAY': ':0', 14:20:25 INFO - 'HOME': '/home/cltbld', 14:20:25 INFO - 'LANG': 'en_US.UTF-8', 14:20:25 INFO - 'LANGUAGE': 'en_US:en', 14:20:25 INFO - 'LOGNAME': 'cltbld', 14:20:25 INFO - 'MAIL': '/var/mail/cltbld', 14:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:25 INFO - 'MOZ_NO_REMOTE': '1', 14:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:25 INFO - 'NO_EM_RESTART': '1', 14:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:25 INFO - 'PWD': '/builds/slave/test', 14:20:25 INFO - 'SHELL': '/bin/bash', 14:20:25 INFO - 'SHLVL': '1', 14:20:25 INFO - 'TERM': 'linux', 14:20:25 INFO - 'TMOUT': '86400', 14:20:25 INFO - 'USER': 'cltbld', 14:20:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:25 INFO - '_': '/tools/buildbot/bin/python'} 14:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:20:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:20:28 INFO - warning: no files found matching '*.txt' 14:20:28 INFO - no previously-included directories found matching 'build' 14:20:28 INFO - no previously-included directories found matching 'dist' 14:20:28 INFO - no previously-included directories found matching '.git*' 14:20:28 INFO - Installing collected packages: jsonschema, functools32 14:20:28 INFO - Running setup.py install for functools32 14:20:28 INFO - warning: no files found matching '*.txt' 14:20:28 INFO - no previously-included directories found matching 'build' 14:20:28 INFO - no previously-included directories found matching 'dist' 14:20:28 INFO - no previously-included directories found matching '.git*' 14:20:28 INFO - Successfully installed jsonschema functools32 14:20:28 INFO - Cleaning up... 14:20:28 INFO - Return code: 0 14:20:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:28 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 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:28 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 14:20:28 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 14:20:28 INFO - Using env: {'DISPLAY': ':0', 14:20:28 INFO - 'HOME': '/home/cltbld', 14:20:28 INFO - 'LANG': 'en_US.UTF-8', 14:20:28 INFO - 'LANGUAGE': 'en_US:en', 14:20:28 INFO - 'LOGNAME': 'cltbld', 14:20:28 INFO - 'MAIL': '/var/mail/cltbld', 14:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:28 INFO - 'MOZ_NO_REMOTE': '1', 14:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:28 INFO - 'NO_EM_RESTART': '1', 14:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:28 INFO - 'PWD': '/builds/slave/test', 14:20:28 INFO - 'SHELL': '/bin/bash', 14:20:28 INFO - 'SHLVL': '1', 14:20:28 INFO - 'TERM': 'linux', 14:20:28 INFO - 'TMOUT': '86400', 14:20:28 INFO - 'USER': 'cltbld', 14:20:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:28 INFO - '_': '/tools/buildbot/bin/python'} 14:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:20:28 INFO - Cleaning up... 14:20:28 INFO - Return code: 0 14:20:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:28 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 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:28 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 14:20:28 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 14:20:28 INFO - Using env: {'DISPLAY': ':0', 14:20:28 INFO - 'HOME': '/home/cltbld', 14:20:28 INFO - 'LANG': 'en_US.UTF-8', 14:20:28 INFO - 'LANGUAGE': 'en_US:en', 14:20:28 INFO - 'LOGNAME': 'cltbld', 14:20:28 INFO - 'MAIL': '/var/mail/cltbld', 14:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:28 INFO - 'MOZ_NO_REMOTE': '1', 14:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:28 INFO - 'NO_EM_RESTART': '1', 14:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:28 INFO - 'PWD': '/builds/slave/test', 14:20:28 INFO - 'SHELL': '/bin/bash', 14:20:28 INFO - 'SHLVL': '1', 14:20:28 INFO - 'TERM': 'linux', 14:20:28 INFO - 'TMOUT': '86400', 14:20:28 INFO - 'USER': 'cltbld', 14:20:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:28 INFO - '_': '/tools/buildbot/bin/python'} 14:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:20:28 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 14:20:28 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 14:20:28 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 14:20:28 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 14:20:28 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 14:20:28 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 14:20:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:20:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:20: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 14:20: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 14:20: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 14:20: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 14:20: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 14:20: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 14:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:20:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:20:31 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 14:20:31 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 14:20:31 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 14:20:31 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 14:20:31 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 14:20:31 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 14:20:31 INFO - Downloading docopt-0.6.1.tar.gz 14:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:20:31 INFO - Installing collected packages: blobuploader, requests, docopt 14:20:31 INFO - Running setup.py install for blobuploader 14:20:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:20:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:20:31 INFO - Running setup.py install for requests 14:20:31 INFO - Running setup.py install for docopt 14:20:31 INFO - Successfully installed blobuploader requests docopt 14:20:31 INFO - Cleaning up... 14:20:32 INFO - Return code: 0 14:20:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20: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')]} 14:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20: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')]} 14:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:32 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 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:32 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 14:20:32 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 14:20:32 INFO - Using env: {'DISPLAY': ':0', 14:20:32 INFO - 'HOME': '/home/cltbld', 14:20:32 INFO - 'LANG': 'en_US.UTF-8', 14:20:32 INFO - 'LANGUAGE': 'en_US:en', 14:20:32 INFO - 'LOGNAME': 'cltbld', 14:20:32 INFO - 'MAIL': '/var/mail/cltbld', 14:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:32 INFO - 'MOZ_NO_REMOTE': '1', 14:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:32 INFO - 'NO_EM_RESTART': '1', 14:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:32 INFO - 'PWD': '/builds/slave/test', 14:20:32 INFO - 'SHELL': '/bin/bash', 14:20:32 INFO - 'SHLVL': '1', 14:20:32 INFO - 'TERM': 'linux', 14:20:32 INFO - 'TMOUT': '86400', 14:20:32 INFO - 'USER': 'cltbld', 14:20:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:32 INFO - '_': '/tools/buildbot/bin/python'} 14:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:20:32 INFO - Running setup.py (path:/tmp/pip-4vuqtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:20:32 INFO - Running setup.py (path:/tmp/pip-8iqNys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:20:32 INFO - Running setup.py (path:/tmp/pip-Z1nzKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:20:32 INFO - Running setup.py (path:/tmp/pip-efAUlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:20:32 INFO - Running setup.py (path:/tmp/pip-2Ujimg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:20:32 INFO - Running setup.py (path:/tmp/pip-0SPV4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:20:32 INFO - Running setup.py (path:/tmp/pip-0WaP6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:20:32 INFO - Running setup.py (path:/tmp/pip-LRUI9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:20:32 INFO - Running setup.py (path:/tmp/pip-Tzmw2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:20:32 INFO - Running setup.py (path:/tmp/pip-0d76Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:20:32 INFO - Running setup.py (path:/tmp/pip-MHhVFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:20:33 INFO - Running setup.py (path:/tmp/pip-VOig6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:20:33 INFO - Running setup.py (path:/tmp/pip-6ajsM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:20:33 INFO - Running setup.py (path:/tmp/pip-_0RvBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:33 INFO - Running setup.py (path:/tmp/pip-kWAhrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:20:33 INFO - Running setup.py (path:/tmp/pip-6CNIk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:20:33 INFO - Running setup.py (path:/tmp/pip-QyCHkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:20:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:20:33 INFO - Running setup.py install for manifestparser 14:20:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:20:33 INFO - Running setup.py install for mozcrash 14:20:33 INFO - Running setup.py install for mozdebug 14:20:33 INFO - Running setup.py install for mozdevice 14:20:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:20:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:20:33 INFO - Running setup.py install for mozfile 14:20:34 INFO - Running setup.py install for mozhttpd 14:20:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Running setup.py install for mozinfo 14:20:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Running setup.py install for mozInstall 14:20:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Running setup.py install for mozleak 14:20:34 INFO - Running setup.py install for mozlog 14:20:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Running setup.py install for moznetwork 14:20:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Running setup.py install for mozprocess 14:20:34 INFO - Running setup.py install for mozprofile 14:20:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Running setup.py install for mozrunner 14:20:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:20:34 INFO - Running setup.py install for mozscreenshot 14:20:35 INFO - Running setup.py install for moztest 14:20:35 INFO - Running setup.py install for mozversion 14:20:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:20:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:20:35 INFO - Cleaning up... 14:20:35 INFO - Return code: 0 14:20:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20: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')]} 14:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20: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')]} 14:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:35 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 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:35 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 14:20:35 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 14:20:35 INFO - Using env: {'DISPLAY': ':0', 14:20:35 INFO - 'HOME': '/home/cltbld', 14:20:35 INFO - 'LANG': 'en_US.UTF-8', 14:20:35 INFO - 'LANGUAGE': 'en_US:en', 14:20:35 INFO - 'LOGNAME': 'cltbld', 14:20:35 INFO - 'MAIL': '/var/mail/cltbld', 14:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:35 INFO - 'MOZ_NO_REMOTE': '1', 14:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:35 INFO - 'NO_EM_RESTART': '1', 14:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:35 INFO - 'PWD': '/builds/slave/test', 14:20:35 INFO - 'SHELL': '/bin/bash', 14:20:35 INFO - 'SHLVL': '1', 14:20:35 INFO - 'TERM': 'linux', 14:20:35 INFO - 'TMOUT': '86400', 14:20:35 INFO - 'USER': 'cltbld', 14:20:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:35 INFO - '_': '/tools/buildbot/bin/python'} 14:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:20:35 INFO - Running setup.py (path:/tmp/pip-TJcfwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:20:35 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)) 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:20:35 INFO - Running setup.py (path:/tmp/pip-HUm2wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:20:35 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)) 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:20:35 INFO - Running setup.py (path:/tmp/pip-W_jUtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:20:35 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)) 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:20:35 INFO - Running setup.py (path:/tmp/pip-Je5jOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:20:35 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)) 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:20:35 INFO - Running setup.py (path:/tmp/pip-gud6cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:20:35 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)) 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:20:35 INFO - Running setup.py (path:/tmp/pip-LQI55r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:20:35 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)) 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:20:35 INFO - Running setup.py (path:/tmp/pip-NKcd9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:20:35 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)) 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:20:35 INFO - Running setup.py (path:/tmp/pip-1DZF_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:20:36 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)) 14:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:20:36 INFO - Running setup.py (path:/tmp/pip-9I6iMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:20:36 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)) 14:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:20:36 INFO - Running setup.py (path:/tmp/pip-Ke196J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:20:36 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)) 14:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:20:36 INFO - Running setup.py (path:/tmp/pip-sqasDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:20:36 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)) 14:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:20:36 INFO - Running setup.py (path:/tmp/pip-Thqea2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:20:36 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)) 14:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:20:36 INFO - Running setup.py (path:/tmp/pip-Pb2ij9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:20:36 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)) 14:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:20:36 INFO - Running setup.py (path:/tmp/pip-fAKy22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:20:36 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)) 14:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:36 INFO - Running setup.py (path:/tmp/pip-uKOXjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:36 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)) 14:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:20:36 INFO - Running setup.py (path:/tmp/pip-nWGVFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:20:36 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)) 14:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:20:36 INFO - Running setup.py (path:/tmp/pip-Oqa1RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:20:36 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)) 14:20:36 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)) 14:20:36 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)) 14:20:36 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)) 14:20:36 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)) 14:20:36 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)) 14:20:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:38 INFO - Downloading blessings-1.6.tar.gz 14:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:20:38 INFO - Installing collected packages: blessings 14:20:38 INFO - Running setup.py install for blessings 14:20:38 INFO - Successfully installed blessings 14:20:38 INFO - Cleaning up... 14:20:38 INFO - Return code: 0 14:20:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:20:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:20:39 INFO - Reading from file tmpfile_stdout 14:20:39 INFO - Current package versions: 14:20:39 INFO - argparse == 1.2.1 14:20:39 INFO - blessings == 1.6 14:20:39 INFO - blobuploader == 1.2.4 14:20:39 INFO - docopt == 0.6.1 14:20:39 INFO - functools32 == 3.2.3-2 14:20:39 INFO - jsonschema == 2.5.1 14:20:39 INFO - manifestparser == 1.1 14:20:39 INFO - mozInstall == 1.12 14:20:39 INFO - mozcrash == 0.17 14:20:39 INFO - mozdebug == 0.1 14:20:39 INFO - mozdevice == 0.48 14:20:39 INFO - mozfile == 1.2 14:20:39 INFO - mozhttpd == 0.7 14:20:39 INFO - mozinfo == 0.9 14:20:39 INFO - mozleak == 0.1 14:20:39 INFO - mozlog == 3.3 14:20:39 INFO - moznetwork == 0.27 14:20:39 INFO - mozprocess == 0.23 14:20:39 INFO - mozprofile == 0.28 14:20:39 INFO - mozrunner == 6.12 14:20:39 INFO - mozscreenshot == 0.1 14:20:39 INFO - mozsystemmonitor == 0.3 14:20:39 INFO - moztest == 0.7 14:20:39 INFO - mozversion == 1.4 14:20:39 INFO - psutil == 3.1.1 14:20:39 INFO - requests == 1.2.3 14:20:39 INFO - wsgiref == 0.1.2 14:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:39 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 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:39 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 14:20:39 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 14:20:39 INFO - Using env: {'DISPLAY': ':0', 14:20:39 INFO - 'HOME': '/home/cltbld', 14:20:39 INFO - 'LANG': 'en_US.UTF-8', 14:20:39 INFO - 'LANGUAGE': 'en_US:en', 14:20:39 INFO - 'LOGNAME': 'cltbld', 14:20:39 INFO - 'MAIL': '/var/mail/cltbld', 14:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:39 INFO - 'MOZ_NO_REMOTE': '1', 14:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:39 INFO - 'NO_EM_RESTART': '1', 14:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:39 INFO - 'PWD': '/builds/slave/test', 14:20:39 INFO - 'SHELL': '/bin/bash', 14:20:39 INFO - 'SHLVL': '1', 14:20:39 INFO - 'TERM': 'linux', 14:20:39 INFO - 'TMOUT': '86400', 14:20:39 INFO - 'USER': 'cltbld', 14:20:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:39 INFO - '_': '/tools/buildbot/bin/python'} 14:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:39 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)) 14:20:39 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)) 14:20:39 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)) 14:20:39 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)) 14:20:39 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)) 14:20:39 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)) 14:20:39 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)) 14:20:39 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)) 14:20:39 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)) 14:20:39 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)) 14:20:39 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)) 14:20:39 INFO - Cleaning up... 14:20:39 INFO - Return code: 0 14:20:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', '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 14:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:20:39 INFO - Using env: {'DISPLAY': ':0', 14:20:39 INFO - 'HOME': '/home/cltbld', 14:20:39 INFO - 'LANG': 'en_US.UTF-8', 14:20:39 INFO - 'LANGUAGE': 'en_US:en', 14:20:39 INFO - 'LOGNAME': 'cltbld', 14:20:39 INFO - 'MAIL': '/var/mail/cltbld', 14:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:39 INFO - 'MOZ_NO_REMOTE': '1', 14:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:39 INFO - 'NO_EM_RESTART': '1', 14:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:39 INFO - 'PWD': '/builds/slave/test', 14:20:39 INFO - 'SHELL': '/bin/bash', 14:20:39 INFO - 'SHLVL': '1', 14:20:39 INFO - 'TERM': 'linux', 14:20:39 INFO - 'TMOUT': '86400', 14:20:39 INFO - 'USER': 'cltbld', 14:20:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:39 INFO - '_': '/tools/buildbot/bin/python'} 14:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:20:39 INFO - Cleaning up... 14:20:39 INFO - Return code: 0 14:20:39 INFO - Running post-action listener: _resource_record_post_action 14:20:39 INFO - Running post-action listener: _start_resource_monitoring 14:20:39 INFO - Starting resource monitoring. 14:20:39 INFO - [mozharness: 2016-07-25 21:20:39.565079Z] Finished create-virtualenv step (success) 14:20:39 INFO - [mozharness: 2016-07-25 21:20:39.565573Z] Running install step. 14:20:39 INFO - Running pre-action listener: _resource_record_pre_action 14:20:39 INFO - Running main action method: install 14:20:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:20:39 INFO - Reading from file tmpfile_stdout 14:20:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:20:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:20:39 INFO - Reading from file tmpfile_stdout 14:20:39 INFO - Output received: 14:20:39 INFO - Usage: mozinstall [options] installer 14:20:39 INFO - Options: 14:20:39 INFO - -h, --help show this help message and exit 14:20:39 INFO - -d DEST, --destination=DEST 14:20:39 INFO - Directory to install application into. [default: 14:20:39 INFO - "/builds/slave/test"] 14:20:39 INFO - --app=APP Application being installed. [default: firefox] 14:20:39 INFO - mkdir: /builds/slave/test/build/application 14:20:39 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'] 14:20:39 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 14:20:57 INFO - Reading from file tmpfile_stdout 14:20:57 INFO - Output received: 14:20:57 INFO - /builds/slave/test/build/application/firefox/firefox 14:20:57 INFO - Running post-action listener: _resource_record_post_action 14:20:57 INFO - [mozharness: 2016-07-25 21:20:57.082877Z] Finished install step (success) 14:20:57 INFO - [mozharness: 2016-07-25 21:20:57.083147Z] Running run-tests step. 14:20:57 INFO - Running pre-action listener: _resource_record_pre_action 14:20:57 INFO - Running main action method: run_tests 14:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:20:57 INFO - Python 2.7.3 14:20:57 INFO - Return code: 0 14:20:57 INFO - grabbing minidump binary from tooltool 14:20:57 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')]} 14:20:57 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 0x1e403b0>, '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 0x1e412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e41740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:20:57 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 14:20:57 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 14:20:57 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 14:20:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:20:57 INFO - Return code: 0 14:20:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:20:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:20:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:20:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:20:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:20:57 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:20:57 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:20:57 INFO - Using env: {'DISPLAY': ':0', 14:20:57 INFO - 'HOME': '/home/cltbld', 14:20:57 INFO - 'LANG': 'en_US.UTF-8', 14:20:57 INFO - 'LANGUAGE': 'en_US:en', 14:20:57 INFO - 'LOGNAME': 'cltbld', 14:20:57 INFO - 'MAIL': '/var/mail/cltbld', 14:20:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:20:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:57 INFO - 'MOZ_NO_REMOTE': '1', 14:20:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:57 INFO - 'NO_EM_RESTART': '1', 14:20:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:57 INFO - 'PWD': '/builds/slave/test', 14:20:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:20:57 INFO - 'SHELL': '/bin/bash', 14:20:57 INFO - 'SHLVL': '1', 14:20:57 INFO - 'TERM': 'linux', 14:20:57 INFO - 'TMOUT': '86400', 14:20:57 INFO - 'USER': 'cltbld', 14:20:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998', 14:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:57 INFO - '_': '/tools/buildbot/bin/python'} 14:20:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:20:57 INFO - mozversion application_buildid: 20160725113021 14:20:57 INFO - mozversion application_changeset: 10a51f3936ca99c96f0d1ebfe9fca833c8a77bdf 14:20:57 INFO - mozversion application_display_name: Nightly 14:20:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:20:57 INFO - mozversion application_name: Firefox 14:20:57 INFO - mozversion application_remotingname: firefox 14:20:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:20:57 INFO - mozversion application_vendor: Mozilla 14:20:57 INFO - mozversion application_version: 50.0a1 14:20:57 INFO - mozversion platform_buildid: 20160725113021 14:20:57 INFO - mozversion platform_changeset: 10a51f3936ca99c96f0d1ebfe9fca833c8a77bdf 14:20:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:20:57 INFO - mozversion platform_version: 50.0a1 14:20:57 INFO - using testdate: 1469481657 14:20:57 INFO - actual date: 1469481657 14:20:57 INFO - starting webserver on 'localhost:46983' 14:20:57 INFO - SUITE-START | Running 2 tests 14:20:57 INFO - TEST-START | dromaeo_css 14:20:57 INFO - operating with platform_type : linux_ 14:20:57 INFO - Initialising browser for dromaeo_css test... 14:20:57 INFO - TEST-INFO | started process 30373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0OXjlF/profile http://localhost:46983/getInfo.html) 14:21:00 INFO - PROCESS | 30373 | JavaScript error: , line 0: uncaught exception: undefined 14:21:01 INFO - PROCESS | 30373 | __metrics Screen width/height:1600/1200 14:21:01 INFO - PROCESS | 30373 | colorDepth:24 14:21:01 INFO - PROCESS | 30373 | Browser inner width/height: 1024/697 14:21:01 INFO - PROCESS | 30373 | __metrics 14:21:02 INFO - PROCESS | 30373 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:21:02 INFO - PROCESS | 30373 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:03 INFO - TEST-INFO | 30373: exit 0 14:21:03 INFO - Browser initialized. 14:21:03 INFO - Running cycle 1/1 for dromaeo_css test... 14:21:03 INFO - TEST-INFO | started process 30455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0OXjlF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:15 INFO - PROCESS | 30455 | RSS: Main: 157806592 14:21:15 INFO - PROCESS | 30455 | 14:22:06 INFO - PROCESS | 30455 | 1469481726820 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] 14:24:14 INFO - PROCESS | 30455 | Cycle 1(1): loaded http://localhost:46983/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46983/tests/dromaeo/cssquery-ext.html) 14:24:15 INFO - PROCESS | 30455 | RSS: Main: 263655424 14:24:15 INFO - PROCESS | 30455 | 14:27:17 INFO - PROCESS | 30455 | Cycle 1(1): loaded http://localhost:46983/tests/dromaeo/cssquery-ext.html (next: http://localhost:46983/tests/dromaeo/cssquery-jquery.html) 14:27:18 INFO - PROCESS | 30455 | RSS: Main: 238448640 14:27:18 INFO - PROCESS | 30455 | 14:30:20 INFO - PROCESS | 30455 | Cycle 1(1): loaded http://localhost:46983/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46983/tests/dromaeo/cssquery-mootools.html) 14:30:21 INFO - PROCESS | 30455 | RSS: Main: 231038976 14:30:21 INFO - PROCESS | 30455 | 14:33:23 INFO - PROCESS | 30455 | Cycle 1(1): loaded http://localhost:46983/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46983/tests/dromaeo/cssquery-prototype.html) 14:33:23 INFO - PROCESS | 30455 | RSS: Main: 221368320 14:33:23 INFO - PROCESS | 30455 | 14:36:26 INFO - PROCESS | 30455 | Cycle 1(1): loaded http://localhost:46983/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46983/tests/dromaeo/cssquery-yui.html) 14:36:26 INFO - PROCESS | 30455 | RSS: Main: 183771136 14:36:26 INFO - PROCESS | 30455 | 14:39:29 INFO - PROCESS | 30455 | Cycle 1(1): loaded http://localhost:46983/tests/dromaeo/cssquery-yui.html (next: http://localhost:46983/tests/dromaeo/cssquery-dojo.html) 14:39:30 INFO - PROCESS | 30455 | RSS: Main: 279318528 14:39:30 INFO - PROCESS | 30455 | 14:39:30 INFO - PROCESS | 30455 | __start_tp_report 14:39:30 INFO - PROCESS | 30455 | _x_x_mozilla_page_load 14:39:30 INFO - PROCESS | 30455 | _x_x_mozilla_page_load_details 14:39:30 INFO - PROCESS | 30455 | |i|pagename|runs| 14:39:30 INFO - PROCESS | 30455 | |0;dojo.html;3040.893568725095;3053.2824786175247;3086.120455670133;3088.366884788618;3098.7056229658174;5294.49702278283;5318.654287471317;5371.248025276464;5380.031594313027;5423.159410291401;5379.166229234465;5439;5441.347038355403;5475.561955043597;5525.060739674255;4821.132196204681;4886.291487734276;4907.509249075082;4923.704577725348;5100.183970564711;5038.874028149307;5058.988202359525;5061.139606266944;5066.493350664922;5070.61970352225;4814.422269327685;4875.24433712775;4880.048390563841;4933.605311575066;4968.527989840959;4880.8047678092835;4910.754462276907;4918.139325618003;5012.548870601663;5045.041442126021;4844.20070688336;4875.804967801284;4878.219484882402;4899.608031357483;4930.063287975273;5215.947840521584;5298.814541491068;5396.082665946798;5402.594805389572;5455.536279416255;5704.714764261812;5767.221425107598;5791.218185544982;5795.88408231833;5797.043487824504;5769.221155144044;5831.591788574801;5835.474807267324;5838.766449342022;5839.270091238595;5246.632735708502;5340.279062326575;5369.382521010056;5437.483439073321;5439.347278326587;5957.463828255478;5958.285005799332;5962.552808539377;5965.463108320185;5965.671888046112;5727.31272247333;5727.742251598688;5731.254936858182;5733.197352370671;5735.77056917727;5527.917081243784;5661.575381846378;5810.854728631818;5817.94182058174;5823.505002074787;5672.177534257592;5700.600957932905;5710.885782284414;5757.971210144006;5763.567732420085;5707.857303567444;5751.079827227623;5756.683382414008;5758.1362795581;5781.82654520365;4344.478662560513;4365.170617582649;4393.802278897458;4410.3825464435;4457.754823484739;3860.4981352424006;3911.9022024449046;3921.039345360405;3934.6655534279334;3955.5055618047745;5410.431904650034;5460.126379779295;5463.508284254436;5465.016297066487;5473.534749546254;5687.60186786921;5776.480116789509;5777.7977770777825;5788.131780232999;5826.82519524415;5507.752151153208;5556.138798486241;5562.360328562187;5565.860853478695;5588.497035266845;5048.444671086178;5065.214891691794;5066.974665126724;5067.214581739762;5108.259302401131;5917.911231331534;5952.464278214981;6072.149899014142;6072.180255665428;6076.726547305293;5778.624389414675;5814.592978491465;5819.5635327351465;5837.09525023622;5872.207252020922;6009.278886533469;6017;6017.548683848817;6020.488258498077;6023.45788879003;5544.75048622821;5639.154126881001;5667.971660141838;5692.430756924275;5716.571257155813;5759.2512973313205;5799.333076696234;5831.533477321719;5867.530597552271;5879.941200587939;5681.4034526374135;5684.374718781013;5684.971575142264;5693.174489699053;5695.288088988877;5539.19681646151;5562.777488900399;5667.4332566743;5680.971595142163;5683;5532.419095995024;5580.274564306615;5621.747021383966;5662.66024038559;5680.11958146488;5664.150377443417;5665.263515742927;5717.542596592346;5718.857028574319;5726.4273572642405;5354.732263386893;5456.563474922076;5534.778608855761;5544.390117087037;5559.58303127259 14:39:30 INFO - PROCESS | 30455 | |1;ext.html;587.5740088435884;598.3059650805066;624.7001439309131;631.1731631562656;657.4970147836902;42973.14053718924;44049.339259911125;44392.778036109776;44477.332840007424;49059.50940490594;46080.53919460804;46410;46433.53566464334;46487.30269045967;46533.767331163384;8975.730728078152;9080.682176123837;9114.726558203265;9124.680636177734;9133.041030691747;8947.552622368856;9102;9107.544622768868;9107.817843643123;9111.635534578609;9055.366124371296;9103.408278461879;9111.863322050142;9114.225290850285;9117.908820911773;9055;9097.590608422637;9108.68119615817;9110.225630821387;9115.863262051074;8927.330450216195;9056.954715226448;9065.546722663841;9065.682701105496;9065.909340906572;43227.78386108081;43549.34675979863;43670.781646091884;43699;43700;3552.2717842842158;3690.2435000824767;3892.9026774330587;4081.10215752534;4278.101598664284;33482.3303533928;34116.65883341184;34486.48270275948;34570.65429345725;35192.824035879916;4180.28935081037;4296.398504209413;4302.032042790347;4372.672049596293;4428.933565996513;361240;361991;362326.5069397221;364057;364597;57488.712556437786;57937.420625794046;58091.419085809444;58116.12825807616;58284.41715582875;59545;59612.40387596155;59635;59790.402095979356;59981.70009150013;16493.257803398876;16738.581535461468;16854.747178792328;16894.74657880133;16930.830691692925;13223.206607603575;13371.130876492996;13423.523412424625;13429.261390623415;13430.395632196574;13860.376283067084;15825.446109386115;15841;15910.139105854485;16016.919915400349;6096.939030609726;6224.719887605069;6234.5635805494085;6282.277538083179;6301.8109456716375;989.8911119776819;1043.6712435582767;1084.295208114716;1114.331401159298;1214.4717048084112;32545.674543254263;32632;32863.83568082192;33088.71249563168;33168.83415582906;952.5237381309346;1125.6904351303458;1126.718320419895;1169.2692067457838;1184.9407529623484;16228.59428514273;16627.334906603843;16680;16688;16835;566279;570677;571252;571793;571998;58187;58538.4146158533;58566.707166464745;58571.41428585745;58609;1234.672811704899;1311.114997376767;1387.5906607550796;1390.5619729785287;1403.8245219347582;32698.673013270516;33854.830725846216;34202.553668023;34253;34420.82789586036;49614.75192624014;50162;50179.24731128963;50214;50276.49723502865;429228;431321;432154.9452801979;432290;433824;27216.183514494598;27588.44823103567;27842.16473505798;28763.28091797722;28876.566851496824;47762.522374777196;47767.28349074697;48794.512054879;49091.75454122706;49202.26196607125;40800.59199407968;41027;42212.15575688407;43215.13569728651;43535;41394.58605413907;41582.79208603938;42205.08180577501;42879.3568096485;43179.35230971475;40763;41816;41846.37230441485;42095.1580968385;42177.36733948932;34701.82649086738;36515.26969460649;37534;37617;37653;28058.71941280561;28223;28326.291842704097;34931.47602785909;35461.46807797936 14:39:30 INFO - PROCESS | 30455 | |2;jquery.html;352.6720150260257;370.8331250937079;376.5819939866747;379.9031247032007;393.7539038101187;14199.858001419983;18351.63296734066;19349.709754353695;19372.51568710781;20018;18303.450896473092;19106.713399298987;19638.70541941872;19906.303279385225;19911.502212444695;5646.068398714217;5851.473367396933;5852.151438041481;5861.589688721791;5863.8534036649;5745.798897038604;5769.740361683714;5798.9130163047585;5856.033754430514;5861.648301101926;5629.437056294379;5758.798442054529;5766.0486019806685;5767.9423205768035;5768.307803063638;5183.222516622499;5389.191621256804;5390.380106287788;5515.944840551583;5755.366909639936;5210.583153347723;5342.893142137135;5349.170878513836;5455.481729235717;5572.331320241557;12881.613551593467;13146.671333216651;13328.266945318004;13361.198328100345;13373.531926382628;2266.263464374085;2270.2167752125656;2343.2970108967243;2352.6706261123454;2678.906238281651;9333.579988900516;9569.712908612753;9590.184834289093;9818.116369526777;9910.20718342538;1860.38607259604;1880.1163453176985;1895.7440745499318;1965.1451618545834;1968.6948522978962;81959.5902020492;85012.57493712554;86313.56843215744;86622;88695;8968.955155224312;9504.04959504044;9506.809863802686;9536.52317384128;9685.903140968641;12850.357482125857;13001.219926804422;13023;13033.608991730263;13040.673983150496;7582.924170758332;7731.342835858903;7738.883916741253;7884.17216192303;7911.723089691834;7671;7778.572178530122;7953.801154971172;7970.800729981681;7973.282404583615;3891.747036442622;3976.920461590752;3997.620226078518;4072.9592704073175;4088;1800.801911789702;1836.8622353323553;1858.6747319219082;1880.0599700149926;1942.873713208637;926.4811705444972;979.0601023017982;992.4343124419012;1006.7382480554962;1041.8697662792151;19483.610327793365;20044;20220.79779202189;20327.695084573745;20511.8974405127;973.7273563402117;980.0867342145264;993.7962717643011;1049.4700176411015;1088.755030118217;10603.204759643058;11129.833052504218;11150.442477876237;11181.44092795357;12122.27266364021;526175;538665;543162;544196;545975;69524.6523767378;76458.61770691222;96195;99257;99821.50089249652;1019.2661283875598;1019.6074511313197;1052.6315789473622;1053.5733028123468;1056.2922841696081;17129.74305385445;17942.5514362142;18041.278348865897;18199.818001820342;18244.90877545657;42472.5752742481;43519.564804351554;43861.56138438575;44196.11607767891;44331.55668443274;56869.43130568807;60448;61045;61344.69327653333;61627.69186154041;7886.211378862068;8098.919010809816;8114.715984940499;8435.91564084376;8542.871856922275;7927.881081783663;12336.938315308365;13236.470541178245;13583.79624305656;13769.31153442344;11560.710982225512;11669.88330116688;11701;11770.58802941893;12131.514739410324;11251.15616328795;11325.943370283096;11388.373639449579;11409.657710268706;11542.769144616892;11088.501017454073;11782.351970641697;12135.878641213474;12174.269543827399;12341.519017717932;8214.83570328602;8282.337413007066;8317.085120636846;8491.702790402307;8575.3997220194;8429.241368276884;10651.094656954245;11611.709707257387;11699.473523691624;12044.457999390224 14:39:30 INFO - PROCESS | 30455 | |3;mootools.html;1422.4239183130833;1494.5441640299707;1593.2033983008496;1698.5753561609597;1782.304901088575;8513.36149788766;8990.325725570576;9024.413413128143;9032.68385606503;9044.186023257906;7784.3772498200005;8012.198780121985;8015.278624923756;8187.05848827385;8863.46819190849;2253.481699209187;2333.708286464192;2335.637976113697;2345.2495201535517;2359.775821296974;2367.4081479630095;2401.891914863835;2419.6491508731224;2422.903083876643;2423.1882319422925;2377.4413012941945;2388.10446082719;2389.2712722619594;2390.282915125464;2393.270052633946;2307.5846347657416;2335.135999680112;2336.5326934613145;2339.1929784224417;2341.063574570177;2317.779810917977;2321.1527792355837;2345.0971376020184;2348.3189874936247;2350.8354415190943;8844;8990.05604411534;9040.186383225542;9052.411593246417;9064.954675226647;5057.367829021372;5159.896802063975;5174.301469301634;5182.404023537304;5190.32525771651;3301.6533264007176;3389.830508474591;3456.3605732939236;3461.16931936336;3475.0617333320115;1048.979020419595;1160.4487868262593;1164.8019836627793;1168.299020587649;1183.1363104933362;12430.813537796941;12432.689182770413;12439;12475.875241247562;12510.18683785551;4431.135928493977;4722.338872557844;4733.786979585927;4740.620750339965;4745.454272758608;10653.147748180127;10661.093807026335;10661.253712240225;10665.146788256921;10671.679849604525;5353.063213937623;5361.785528578813;5364.7049412282695;5368.3826359968325;5373.462653734595;4220.430241917302;4856.514348565186;4858.222684370484;4861.538153875376;4920.40955085392;3949.486566746362;4093.16090201508;4101.938470922939;4108.753474791462;4180.916381672349;1284.537566476068;1287.4270949427603;1299.883010529057;1306.372940988312;1312.6783937935077;969.7333233360741;986.1716158426956;995.328153496387;1004.3823048825066;1005.3264312910368;6175.783847565313;6176.258848938156;6221.564490485713;6243.812685619348;6352.7776527822225;943.688582767685;998.5756053677159;1005.5575546759402;1022.805666923297;1048.9475526223657;4227.640650544677;4317.827286908551;4380.642000979707;4391.3412988051405;4408.669349798778;10872.45637718111;11039.448027598748;11065.557377704963;11070.667879963614;11087.72280692989;10924.344539327665;10945.124390048777;10956.178286628534;10972.615958441416;11001.339919604849;7911.762647120596;8178.959105204555;8185.508869467851;8351.1648835116;8355.749327520305;6158.938410616016;6194.659293738888;6209.223847019122;6323.336049714714;6467.320931302145;10011;10088.949555252177;10197.54111064989;10220.488975551341;10352.430616316175;10452.425116618355;10467.267291289842;10515.842262366225;10594.258401911793;10638.30850994714;7648.502847314907;7719.301753614196;7864.21357864209;7884.053913530183;7987.440879138405;8934.50860202695;8990.100989900957;8991.910080899108;8996.325275604488;9015.729528114167;7714.614269286625;7840;7926.643301051351;7933.484323519184;8002.839943200987;7556.886646700414;7655.961720191363;7700.8844867325915;7704.19105993885;7716.074071111502;7103.680334384861;7168.641567921687;7183;7193.136823581203;7195.35241828217;5123.6157288202785;5197.896042079213;5312.681239125664;5360.3299587551555;5575.804846830341;5388.46115388458;5426;5489.780408783604;5558.221848941071;5643.830685079454 14:39:30 INFO - PROCESS | 30455 | |4;prototype.html;307.9360808406954;313.722355715192;323.6536905511104;324.6558647833296;325.2811287055607;5288.576913846888;5314.76083576239;5341.172118321657;5350.19747037944;5353.812616558421;4963.875903102425;5108.131617625003;5108.1826907694685;5112;5227.503387178212;4014.9598504015025;4042.3532234842432;4127.876163715078;4142.2543942090415;4175.331946888498;4127.8968025799295;4134.441850350209;4156.6051225133715;4158.521769996444;4162.646175075107;4070.267351876661;4073.96449704142;4115.917681646365;4118.155778065489;4134.64855487284;4084.6936479764136;4088.1619268049976;4095.815688294019;4107.383892416146;4114.485689288839;3632.9273414531563;3637.963620363789;3650.251698401821;3652.7625704329134;3665.0470877571756;4963.60291176705;5142.357205349332;5143.845684629429;5150.175971844487;5153.8919132386345;4645.072294997606;4648.953510464886;4656.604188643969;4679.251319788851;4692.55420735033;5475.878749113007;5485.835424937259;5494.203340515643;5504.146857237095;5512.448755124496;3833.961660383416;3908.2965066288057;3925.7840818754958;3937.114149316381;3943.974566612673;5691.943080569183;5692.288463942007;5701.629394089412;5707.286589176353;5725.08398656213;3948.230095131422;3958.940615890764;3975.6421922027157;3985.242803867256;4002.0595160137345;4044.4944381952255;4055.7160998730396;4056.229316429869;4059.086705491241;4060.2894493463527;4578.793954272066;4600.60894823937;4627.514111018362;4661.394018777605;4664.137134630104;5464.836054918359;5493;5493.763903121766;5495.175723641486;5496.31296087989;1344.0793056756154;1403.2983508245877;1416.7037160997572;1421.4527406948193;1428.678547326843;905.2124651553191;914.9588268527932;937.8511323628501;974.1573538888952;982.7837875667485;5231.430570828737;5235.633505654644;5243.528082472596;5264.236685680555;5329.626926115212;5451.371794298003;5565.499105080562;5576.079946808731;5576.637518561281;5601.80393686219;5193.454687257859;5232.790688372498;5241.13521268994;5262.184361423985;5264.368275806928;2961.392914452532;2988.4321978823955;2994.8053376530456;2995.3260516384075;3008.2028262510453;5682.806610611818;5690.829275121753;5740.1102829061565;5751.281089863767;5760.971195143998;5657.464084946908;5662.462066103713;5677.37548869624;5693.345265294544;5700.287464066992;5805.7387417566315;5816.302043754777;5819.476247137778;5821.330546987151;5849.5612829037145;5440.918386224131;5563.610547261653;5597.132444471114;5602.803901863415;5610.4670056344585;5503.642263252876;5536.446355364593;5536.944630553643;5570.136628822539;5591.329040515164;5475.972620136874;5692.373838877637;5815.709214539341;5824.242848429846;5824.9417505826095;3961.8415263390293;3969.861054863066;3970.8881513176357;3981.8651684271003;3991.1219531702977;5661.405552416937;5663.669037776037;5687.459691329317;5693.402192769865;5700.629459085146;5397.8380648580605;5457.645253058538;5486.286782718381;5573.219749235192;5573.498385145194;5468.808591699271;5469.206964989975;5474.698891561003;5477.287952566141;5491.395946445968;5253.422123566328;5285.68285902847;5457.536109430743;5463.48096930791;5480;5516.889662206653;5525.198846167203;5535.806246781504;5541.972290138524;5544.1960915666195;5406.432324605859;5407.297051383295;5415.756290966995;5418.295621569171;5421.972890135682 14:39:30 INFO - PROCESS | 30455 | |5;yui.html;768.488954845028;773.3542492019163;776.9456138070337;817.6402382951504;897.412195012267;15010.849891501082;16320.591985200375;16321.673566528678;16342.591435214126;16349.509514714548;13428;13917.23455209963;14031.92984035081;14053.789193162085;14114.153150810958;655.8655475627509;794.0907660728462;812.695239285268;813.0121901889204;814.2549567146054;783.5416281475344;806.7821688144197;812.9349652027823;813.4509206285763;813.6419975210918;856.9871451928226;859.0292968945083;859.9527026013567;861.0184389795638;861.104451370577;675.6216518749467;850.8936382952162;857.8627419612864;858.7938894665298;859.072202021818;598.6737228210636;619.9132121502993;621.940915613016;623.0342968399009;623.1338439569003;13996.230207338593;14130.858691413057;14184.21986790726;14186.503472378417;14204.218767967757;14252.501162459264;14261.500847470288;14691.706165876623;14996;15194.316255768517;12443.128980971336;12513.249205047727;12714.110012299143;12748;12949.48202071916;4375.846845360429;4449.26587113126;4507.256302710081;4513.932291015637;4633.8609841704465;72530.63734681293;73220;75460.62269688671;77385;78029;11668.124890633237;11679.182457228082;11774.587889423829;11804.586839460577;11812.232204906653;22337.218197363014;22381.44046398853;22395.21616743406;22396.776032239468;22407.775922240897;8625.827483450421;8694.956525217334;8737.650493980296;8799.076097009849;8839.779005524784;4599.379083823641;4701.412323459567;4711.764411779397;4867.245576935581;4936.03747269279;3392.6098498672477;3490.47642853574;3499.4225952718025;3502.754807163474;3580.820958952042;573.4237091722875;578.7308901360803;582.0919365789298;593.3888095261888;593.5518683394096;586.5014737473114;649.4447247603325;654.8657525207321;658.3515237491067;664.2062735031687;8949.731508054638;9231.723048308562;9346.626134954526;9402.764930876783;9415.6704515343;652.1815122021832;659.3274859643137;696.6447111972931;710.2435905760349;712.0494140322623;4397.403076984488;4594.609458196091;4664.158734255109;4737.360456338419;4764.190087685102;64448.677756610916;65606.67196663986;65752.67123664447;65757.34242657608;77539.2246077532;55924.72037639867;65925.67037164784;91625.54187229155;94765;94786;83843;85085;88821.11178888129;90461;91880.54059729658;8356.206160414751;8732.69435569752;8817.338699597683;8842.734717958472;8847.159519845605;46900;48376.51623483861;49592.504074960234;50101.24848127354;52028.47971520388;63163.6841815788;71906.64046679733;72376;72991;74698;12001.63995080149;12074;12436;12582;12707.110502265123;12743;12835.679108022374;12923.353832308536;13146;13269.933650332072;11467.4266286687;11809.232399894323;12019.21875078117;12161.756764864476;12417.06871984623;12199.69500762488;12254.75490490203;12292.692682683004;12756.681082973;12773.361331933553;11601.651950441163;11958.342291174069;12023.699407514881;12388.752224955631;12422.937885310515;10092.526477153084;10291.485425728533;10399.740006499898;10548.605001416536;10853.023227909525;9453.480058596568;9625.422474651543;9667.806643867223;10356.119729822749;10440.530176142243 14:39:30 INFO - PROCESS | 30455 | __end_tp_report 14:39:30 INFO - PROCESS | 30455 | __start_cc_report 14:39:30 INFO - PROCESS | 30455 | _x_x_mozilla_cycle_collect,958 14:39:30 INFO - PROCESS | 30455 | __end_cc_report 14:39:30 INFO - PROCESS | 30455 | __startTimestamp1469482770099__endTimestamp 14:39:30 INFO - PROCESS | 30455 | 14:39:30 INFO - PROCESS | 30455 | ------- Summary: start ------- 14:39:30 INFO - PROCESS | 30455 | Number of tests: 6 14:39:30 INFO - PROCESS | 30455 | 14:39:30 INFO - PROCESS | 30455 | [#0] dojo.html Cycles:165 Average:5376.79 Median:5562.78 stddev:619.12 (11.1%) stddev-sans-first:593.28 14:39:30 INFO - PROCESS | 30455 | Values: 3040.9 3053.3 3086.1 3088.4 3098.7 5294.5 5318.7 5371.2 5380.0 5423.2 5379.2 5439.0 5441.3 5475.6 5525.1 4821.1 4886.3 4907.5 4923.7 5100.2 5038.9 5059.0 5061.1 5066.5 5070.6 4814.4 4875.2 4880.0 4933.6 4968.5 4880.8 4910.8 4918.1 5012.5 5045.0 4844.2 4875.8 4878.2 4899.6 4930.1 5215.9 5298.8 5396.1 5402.6 5455.5 5704.7 5767.2 5791.2 5795.9 5797.0 5769.2 5831.6 5835.5 5838.8 5839.3 5246.6 5340.3 5369.4 5437.5 5439.3 5957.5 5958.3 5962.6 5965.5 5965.7 5727.3 5727.7 5731.3 5733.2 5735.8 5527.9 5661.6 5810.9 5817.9 5823.5 5672.2 5700.6 5710.9 5758.0 5763.6 5707.9 5751.1 5756.7 5758.1 5781.8 4344.5 4365.2 4393.8 4410.4 4457.8 3860.5 3911.9 3921.0 3934.7 3955.5 5410.4 5460.1 5463.5 5465.0 5473.5 5687.6 5776.5 5777.8 5788.1 5826.8 5507.8 5556.1 5562.4 5565.9 5588.5 5048.4 5065.2 5067.0 5067.2 5108.3 5917.9 5952.5 6072.1 6072.2 6076.7 5778.6 5814.6 5819.6 5837.1 5872.2 6009.3 6017.0 6017.5 6020.5 6023.5 5544.8 5639.2 5668.0 5692.4 5716.6 5759.3 5799.3 5831.5 5867.5 5879.9 5681.4 5684.4 5685.0 5693.2 5695.3 5539.2 5562.8 5667.4 5681.0 5683.0 5532.4 5580.3 5621.7 5662.7 5680.1 5664.2 5665.3 5717.5 5718.9 5726.4 5354.7 5456.6 5534.8 5544.4 5559.6 14:39:30 INFO - PROCESS | 30455 | 14:39:30 INFO - PROCESS | 30455 | [#1] ext.html Cycles:180 Average:61781.86 Median:237250.18 stddev:122886.41 (51.8%) stddev-sans-first:123145.25 14:39:30 INFO - PROCESS | 30455 | Values: 587.6 598.3 624.7 631.2 657.5 42973.1 44049.3 44392.8 44477.3 49059.5 46080.5 46410.0 46433.5 46487.3 46533.8 8975.7 9080.7 9114.7 9124.7 9133.0 8947.6 9102.0 9107.5 9107.8 9111.6 9055.4 9103.4 9111.9 9114.2 9117.9 9055.0 9097.6 9108.7 9110.2 9115.9 8927.3 9057.0 9065.5 9065.7 9065.9 43227.8 43549.3 43670.8 43699.0 43700.0 3552.3 3690.2 3892.9 4081.1 4278.1 33482.3 34116.7 34486.5 34570.7 35192.8 4180.3 4296.4 4302.0 4372.7 4428.9 361240.0 361991.0 362326.5 364057.0 364597.0 57488.7 57937.4 58091.4 58116.1 58284.4 59545.0 59612.4 59635.0 59790.4 59981.7 16493.3 16738.6 16854.7 16894.7 16930.8 13223.2 13371.1 13423.5 13429.3 13430.4 13860.4 15825.4 15841.0 15910.1 16016.9 6096.9 6224.7 6234.6 6282.3 6301.8 989.9 1043.7 1084.3 1114.3 1214.5 32545.7 32632.0 32863.8 33088.7 33168.8 952.5 1125.7 1126.7 1169.3 1184.9 16228.6 16627.3 16680.0 16688.0 16835.0 566279.0 570677.0 571252.0 571793.0 571998.0 58187.0 58538.4 58566.7 58571.4 58609.0 1234.7 1311.1 1387.6 1390.6 1403.8 32698.7 33854.8 34202.6 34253.0 34420.8 49614.8 50162.0 50179.2 50214.0 50276.5 429228.0 431321.0 432154.9 432290.0 433824.0 27216.2 27588.4 27842.2 28763.3 28876.6 47762.5 47767.3 48794.5 49091.8 49202.3 40800.6 41027.0 42212.2 43215.1 43535.0 41394.6 41582.8 42205.1 42879.4 43179.4 40763.0 41816.0 41846.4 42095.2 42177.4 34701.8 36515.3 37534.0 37617.0 37653.0 28058.7 28223.0 28326.3 34931.5 35461.5 14:39:30 INFO - PROCESS | 30455 | 14:39:30 INFO - PROCESS | 30455 | [#2] jquery.html Cycles:180 Average:30051.80 Median:4080.48 stddev:88881.43 (2178.2%) stddev-sans-first:89102.79 14:39:30 INFO - PROCESS | 30455 | Values: 352.7 370.8 376.6 379.9 393.8 14199.9 18351.6 19349.7 19372.5 20018.0 18303.5 19106.7 19638.7 19906.3 19911.5 5646.1 5851.5 5852.2 5861.6 5863.9 5745.8 5769.7 5798.9 5856.0 5861.6 5629.4 5758.8 5766.0 5767.9 5768.3 5183.2 5389.2 5390.4 5515.9 5755.4 5210.6 5342.9 5349.2 5455.5 5572.3 12881.6 13146.7 13328.3 13361.2 13373.5 2266.3 2270.2 2343.3 2352.7 2678.9 9333.6 9569.7 9590.2 9818.1 9910.2 1860.4 1880.1 1895.7 1965.1 1968.7 81959.6 85012.6 86313.6 86622.0 88695.0 8969.0 9504.0 9506.8 9536.5 9685.9 12850.4 13001.2 13023.0 13033.6 13040.7 7582.9 7731.3 7738.9 7884.2 7911.7 7671.0 7778.6 7953.8 7970.8 7973.3 3891.7 3976.9 3997.6 4073.0 4088.0 1800.8 1836.9 1858.7 1880.1 1942.9 926.5 979.1 992.4 1006.7 1041.9 19483.6 20044.0 20220.8 20327.7 20511.9 973.7 980.1 993.8 1049.5 1088.8 10603.2 11129.8 11150.4 11181.4 12122.3 526175.0 538665.0 543162.0 544196.0 545975.0 69524.7 76458.6 96195.0 99257.0 99821.5 1019.3 1019.6 1052.6 1053.6 1056.3 17129.7 17942.6 18041.3 18199.8 18244.9 42472.6 43519.6 43861.6 44196.1 44331.6 56869.4 60448.0 61045.0 61344.7 61627.7 7886.2 8098.9 8114.7 8435.9 8542.9 7927.9 12336.9 13236.5 13583.8 13769.3 11560.7 11669.9 11701.0 11770.6 12131.5 11251.2 11325.9 11388.4 11409.7 11542.8 11088.5 11782.4 12135.9 12174.3 12341.5 8214.8 8282.3 8317.1 8491.7 8575.4 8429.2 10651.1 11611.7 11699.5 12044.5 14:39:30 INFO - PROCESS | 30455 | 14:39:30 INFO - PROCESS | 30455 | [#3] mootools.html Cycles:180 Average:5904.43 Median:4419.90 stddev:3335.07 (75.5%) stddev-sans-first:3327.42 14:39:30 INFO - PROCESS | 30455 | Values: 1422.4 1494.5 1593.2 1698.6 1782.3 8513.4 8990.3 9024.4 9032.7 9044.2 7784.4 8012.2 8015.3 8187.1 8863.5 2253.5 2333.7 2335.6 2345.2 2359.8 2367.4 2401.9 2419.6 2422.9 2423.2 2377.4 2388.1 2389.3 2390.3 2393.3 2307.6 2335.1 2336.5 2339.2 2341.1 2317.8 2321.2 2345.1 2348.3 2350.8 8844.0 8990.1 9040.2 9052.4 9065.0 5057.4 5159.9 5174.3 5182.4 5190.3 3301.7 3389.8 3456.4 3461.2 3475.1 1049.0 1160.4 1164.8 1168.3 1183.1 12430.8 12432.7 12439.0 12475.9 12510.2 4431.1 4722.3 4733.8 4740.6 4745.5 10653.1 10661.1 10661.3 10665.1 10671.7 5353.1 5361.8 5364.7 5368.4 5373.5 4220.4 4856.5 4858.2 4861.5 4920.4 3949.5 4093.2 4101.9 4108.8 4180.9 1284.5 1287.4 1299.9 1306.4 1312.7 969.7 986.2 995.3 1004.4 1005.3 6175.8 6176.3 6221.6 6243.8 6352.8 943.7 998.6 1005.6 1022.8 1048.9 4227.6 4317.8 4380.6 4391.3 4408.7 10872.5 11039.4 11065.6 11070.7 11087.7 10924.3 10945.1 10956.2 10972.6 11001.3 7911.8 8179.0 8185.5 8351.2 8355.7 6158.9 6194.7 6209.2 6323.3 6467.3 10011.0 10088.9 10197.5 10220.5 10352.4 10452.4 10467.3 10515.8 10594.3 10638.3 7648.5 7719.3 7864.2 7884.1 7987.4 8934.5 8990.1 8991.9 8996.3 9015.7 7714.6 7840.0 7926.6 7933.5 8002.8 7556.9 7656.0 7700.9 7704.2 7716.1 7103.7 7168.6 7183.0 7193.1 7195.4 5123.6 5197.9 5312.7 5360.3 5575.8 5388.5 5426.0 5489.8 5558.2 5643.8 14:39:30 INFO - PROCESS | 30455 | 14:39:30 INFO - PROCESS | 30455 | [#4] prototype.html Cycles:180 Average:4619.31 Median:5287.13 stddev:1352.79 (25.6%) stddev-sans-first:1317.31 14:39:30 INFO - PROCESS | 30455 | Values: 307.9 313.7 323.7 324.7 325.3 5288.6 5314.8 5341.2 5350.2 5353.8 4963.9 5108.1 5108.2 5112.0 5227.5 4015.0 4042.4 4127.9 4142.3 4175.3 4127.9 4134.4 4156.6 4158.5 4162.6 4070.3 4074.0 4115.9 4118.2 4134.6 4084.7 4088.2 4095.8 4107.4 4114.5 3632.9 3638.0 3650.3 3652.8 3665.0 4963.6 5142.4 5143.8 5150.2 5153.9 4645.1 4649.0 4656.6 4679.3 4692.6 5475.9 5485.8 5494.2 5504.1 5512.4 3834.0 3908.3 3925.8 3937.1 3944.0 5691.9 5692.3 5701.6 5707.3 5725.1 3948.2 3958.9 3975.6 3985.2 4002.1 4044.5 4055.7 4056.2 4059.1 4060.3 4578.8 4600.6 4627.5 4661.4 4664.1 5464.8 5493.0 5493.8 5495.2 5496.3 1344.1 1403.3 1416.7 1421.5 1428.7 905.2 915.0 937.9 974.2 982.8 5231.4 5235.6 5243.5 5264.2 5329.6 5451.4 5565.5 5576.1 5576.6 5601.8 5193.5 5232.8 5241.1 5262.2 5264.4 2961.4 2988.4 2994.8 2995.3 3008.2 5682.8 5690.8 5740.1 5751.3 5761.0 5657.5 5662.5 5677.4 5693.3 5700.3 5805.7 5816.3 5819.5 5821.3 5849.6 5440.9 5563.6 5597.1 5602.8 5610.5 5503.6 5536.4 5536.9 5570.1 5591.3 5476.0 5692.4 5815.7 5824.2 5824.9 3961.8 3969.9 3970.9 3981.9 3991.1 5661.4 5663.7 5687.5 5693.4 5700.6 5397.8 5457.6 5486.3 5573.2 5573.5 5468.8 5469.2 5474.7 5477.3 5491.4 5253.4 5285.7 5457.5 5463.5 5480.0 5516.9 5525.2 5535.8 5542.0 5544.2 5406.4 5407.3 5415.8 5418.3 5422.0 14:39:30 INFO - PROCESS | 30455 | 14:39:30 INFO - PROCESS | 30455 | [#5] yui.html Cycles:180 Average:18630.86 Median:51064.86 stddev:25233.49 (49.4%) stddev-sans-first:25268.63 14:39:30 INFO - PROCESS | 30455 | Values: 768.5 773.4 776.9 817.6 897.4 15010.8 16320.6 16321.7 16342.6 16349.5 13428.0 13917.2 14031.9 14053.8 14114.2 655.9 794.1 812.7 813.0 814.3 783.5 806.8 812.9 813.5 813.6 857.0 859.0 860.0 861.0 861.1 675.6 850.9 857.9 858.8 859.1 598.7 619.9 621.9 623.0 623.1 13996.2 14130.9 14184.2 14186.5 14204.2 14252.5 14261.5 14691.7 14996.0 15194.3 12443.1 12513.2 12714.1 12748.0 12949.5 4375.8 4449.3 4507.3 4513.9 4633.9 72530.6 73220.0 75460.6 77385.0 78029.0 11668.1 11679.2 11774.6 11804.6 11812.2 22337.2 22381.4 22395.2 22396.8 22407.8 8625.8 8695.0 8737.7 8799.1 8839.8 4599.4 4701.4 4711.8 4867.2 4936.0 3392.6 3490.5 3499.4 3502.8 3580.8 573.4 578.7 582.1 593.4 593.6 586.5 649.4 654.9 658.4 664.2 8949.7 9231.7 9346.6 9402.8 9415.7 652.2 659.3 696.6 710.2 712.0 4397.4 4594.6 4664.2 4737.4 4764.2 64448.7 65606.7 65752.7 65757.3 77539.2 55924.7 65925.7 91625.5 94765.0 94786.0 83843.0 85085.0 88821.1 90461.0 91880.5 8356.2 8732.7 8817.3 8842.7 8847.2 46900.0 48376.5 49592.5 50101.2 52028.5 63163.7 71906.6 72376.0 72991.0 74698.0 12001.6 12074.0 12436.0 12582.0 12707.1 12743.0 12835.7 12923.4 13146.0 13269.9 11467.4 11809.2 12019.2 12161.8 12417.1 12199.7 12254.8 12292.7 12756.7 12773.4 11601.7 11958.3 12023.7 12388.8 12422.9 10092.5 10291.5 10399.7 10548.6 10853.0 9453.5 9625.4 9667.8 10356.1 10440.5 14:39:30 INFO - PROCESS | 30455 | -------- Summary: end -------- 14:39:30 INFO - PROCESS | 30455 | 14:39:30 INFO - TEST-INFO | 30455: exit 0 14:39:30 INFO - TEST-OK | dromaeo_css | took 1113562ms 14:39:30 INFO - TEST-START | kraken 14:39:30 INFO - operating with platform_type : linux_ 14:39:30 INFO - Initialising browser for kraken test... 14:39:30 INFO - TEST-INFO | started process 30646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNDR2_b/profile http://localhost:46983/getInfo.html) 14:39:34 INFO - PROCESS | 30646 | JavaScript error: , line 0: uncaught exception: undefined 14:39:34 INFO - PROCESS | 30646 | __metrics Screen width/height:1600/1200 14:39:34 INFO - PROCESS | 30646 | colorDepth:24 14:39:34 INFO - PROCESS | 30646 | Browser inner width/height: 1024/697 14:39:34 INFO - PROCESS | 30646 | __metrics 14:39:35 INFO - PROCESS | 30646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:39:35 INFO - PROCESS | 30646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:39:36 INFO - TEST-INFO | 30646: exit 0 14:39:36 INFO - Browser initialized. 14:39:36 INFO - Running cycle 1/1 for kraken test... 14:39:36 INFO - TEST-INFO | started process 30727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNDR2_b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:39:48 INFO - PROCESS | 30727 | RSS: Main: 157954048 14:39:48 INFO - PROCESS | 30727 | 14:39:51 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46983/tests/kraken/driver.html?testName=audio-beat-detection) 14:39:51 INFO - PROCESS | 30727 | RSS: Main: 213737472 14:39:51 INFO - PROCESS | 30727 | 14:39:54 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46983/tests/kraken/driver.html?testName=audio-dft) 14:39:55 INFO - PROCESS | 30727 | RSS: Main: 193064960 14:39:55 INFO - PROCESS | 30727 | 14:39:58 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46983/tests/kraken/driver.html?testName=audio-fft) 14:39:58 INFO - PROCESS | 30727 | RSS: Main: 271355904 14:39:58 INFO - PROCESS | 30727 | 14:40:00 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46983/tests/kraken/driver.html?testName=audio-oscillator) 14:40:01 INFO - PROCESS | 30727 | RSS: Main: 180785152 14:40:01 INFO - PROCESS | 30727 | 14:40:03 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46983/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:40:04 INFO - PROCESS | 30727 | RSS: Main: 185790464 14:40:04 INFO - PROCESS | 30727 | 14:40:07 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46983/tests/kraken/driver.html?testName=imaging-darkroom) 14:40:07 INFO - PROCESS | 30727 | RSS: Main: 220717056 14:40:07 INFO - PROCESS | 30727 | 14:40:11 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46983/tests/kraken/driver.html?testName=imaging-desaturate) 14:40:11 INFO - PROCESS | 30727 | RSS: Main: 221057024 14:40:11 INFO - PROCESS | 30727 | 14:40:14 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46983/tests/kraken/driver.html?testName=json-parse-financial) 14:40:15 INFO - PROCESS | 30727 | RSS: Main: 221536256 14:40:15 INFO - PROCESS | 30727 | 14:40:16 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46983/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:40:17 INFO - PROCESS | 30727 | RSS: Main: 185344000 14:40:17 INFO - PROCESS | 30727 | 14:40:18 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46983/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:40:19 INFO - PROCESS | 30727 | RSS: Main: 189968384 14:40:19 INFO - PROCESS | 30727 | 14:40:21 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46983/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:40:22 INFO - PROCESS | 30727 | RSS: Main: 196026368 14:40:22 INFO - PROCESS | 30727 | 14:40:24 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:40:25 INFO - PROCESS | 30727 | RSS: Main: 190885888 14:40:25 INFO - PROCESS | 30727 | 14:40:28 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:40:28 INFO - PROCESS | 30727 | RSS: Main: 194256896 14:40:28 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:46983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46983/tests/kraken/driver.html?testName=ai-astar) 14:40:30 INFO - PROCESS | 30727 | RSS: Main: 245116928 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | __start_tp_report 14:40:30 INFO - PROCESS | 30727 | _x_x_mozilla_page_load 14:40:30 INFO - PROCESS | 30727 | _x_x_mozilla_page_load_details 14:40:30 INFO - PROCESS | 30727 | |i|pagename|runs| 14:40:30 INFO - PROCESS | 30727 | |0;ai-astar;102;115;114;111;112;112;112;111;111;111 14:40:30 INFO - PROCESS | 30727 | |1;audio-beat-detection;146;117;118;178;119;117;152;119;156;122 14:40:30 INFO - PROCESS | 30727 | |2;audio-dft;160;159;159;159;161;159;160;160;163;163 14:40:30 INFO - PROCESS | 30727 | |3;audio-fft;74;75;74;121;75;75;73;74;110;74 14:40:30 INFO - PROCESS | 30727 | |4;audio-oscillator;83;84;110;84;82;83;120;83;82;122 14:40:30 INFO - PROCESS | 30727 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;117;117;117 14:40:30 INFO - PROCESS | 30727 | |6;imaging-darkroom;145;145;146;146;145;146;146;146;146;145 14:40:30 INFO - PROCESS | 30727 | |7;imaging-desaturate;95;95;94;95;95;94;95;95;94;94 14:40:30 INFO - PROCESS | 30727 | |8;json-parse-financial;51;51;52;52;54;55;53;52;52;51 14:40:30 INFO - PROCESS | 30727 | |9;json-stringify-tinderbox;61;61;62;61;62;61;62;62;61;61 14:40:30 INFO - PROCESS | 30727 | |10;stanford-crypto-aes;75;75;76;76;76;75;75;76;75;77 14:40:30 INFO - PROCESS | 30727 | |11;stanford-crypto-ccm;123;127;133;126;123;120;117;119;165;130 14:40:30 INFO - PROCESS | 30727 | |12;stanford-crypto-pbkdf2;154;153;156;159;161;156;156;160;158;155 14:40:30 INFO - PROCESS | 30727 | |13;stanford-crypto-sha256-iterative;72;63;63;64;65;63;62;65;64;61 14:40:30 INFO - PROCESS | 30727 | __end_tp_report 14:40:30 INFO - PROCESS | 30727 | __start_cc_report 14:40:30 INFO - PROCESS | 30727 | _x_x_mozilla_cycle_collect,1683 14:40:30 INFO - PROCESS | 30727 | __end_cc_report 14:40:30 INFO - PROCESS | 30727 | __startTimestamp1469482830624__endTimestamp 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | ------- Summary: start ------- 14:40:30 INFO - PROCESS | 30727 | Number of tests: 14 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.48 (3.1%) stddev-sans-first:1.45 14:40:30 INFO - PROCESS | 30727 | Values: 102.0 115.0 114.0 111.0 112.0 112.0 112.0 111.0 111.0 111.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:134.00 stddev:21.89 (16.3%) stddev-sans-first:22.82 14:40:30 INFO - PROCESS | 30727 | Values: 146.0 117.0 118.0 178.0 119.0 117.0 152.0 119.0 156.0 122.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.57 (1.0%) stddev-sans-first:1.66 14:40:30 INFO - PROCESS | 30727 | Values: 160.0 159.0 159.0 159.0 161.0 159.0 160.0 160.0 163.0 163.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.00 stddev:17.60 (23.8%) stddev-sans-first:18.39 14:40:30 INFO - PROCESS | 30727 | Values: 74.0 75.0 74.0 121.0 75.0 75.0 73.0 74.0 110.0 74.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:16.87 (20.3%) stddev-sans-first:17.48 14:40:30 INFO - PROCESS | 30727 | Values: 83.0 84.0 110.0 84.0 82.0 83.0 120.0 83.0 82.0 122.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 14:40:30 INFO - PROCESS | 30727 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:40:30 INFO - PROCESS | 30727 | Values: 145.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:40:30 INFO - PROCESS | 30727 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.34 (2.6%) stddev-sans-first:1.33 14:40:30 INFO - PROCESS | 30727 | Values: 51.0 51.0 52.0 52.0 54.0 55.0 53.0 52.0 52.0 51.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 14:40:30 INFO - PROCESS | 30727 | Values: 61.0 61.0 62.0 61.0 62.0 61.0 62.0 62.0 61.0 61.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:76.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 14:40:30 INFO - PROCESS | 30727 | Values: 75.0 75.0 76.0 76.0 76.0 75.0 75.0 76.0 75.0 77.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.50 stddev:13.82 (10.9%) stddev-sans-first:14.52 14:40:30 INFO - PROCESS | 30727 | Values: 123.0 127.0 133.0 126.0 123.0 120.0 117.0 119.0 165.0 130.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.00 stddev:2.62 (1.7%) stddev-sans-first:2.57 14:40:30 INFO - PROCESS | 30727 | Values: 154.0 153.0 156.0 159.0 161.0 156.0 156.0 160.0 158.0 155.0 14:40:30 INFO - PROCESS | 30727 | 14:40:30 INFO - PROCESS | 30727 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:3.01 (4.7%) stddev-sans-first:1.32 14:40:30 INFO - PROCESS | 30727 | Values: 72.0 63.0 63.0 64.0 65.0 63.0 62.0 65.0 64.0 61.0 14:40:30 INFO - PROCESS | 30727 | -------- Summary: end -------- 14:40:30 INFO - PROCESS | 30727 | 14:40:31 INFO - TEST-INFO | 30727: exit 0 14:40:31 INFO - TEST-OK | kraken | took 60753ms 14:40:31 INFO - SUITE-END | took 1174s 14:40:31 INFO - Completed test suite (00:19:34) 14:40:31 INFO - javascript benchmark 14:40:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.893568725095, 3053.2824786175247, 3086.120455670133, 3088.366884788618, 3098.7056229658174, 5294.49702278283, 5318.654287471317, 5371.248025276464, 5380.031594313027, 5423.159410291401, 5379.166229234465, 5439.0, 5441.347038355403, 5475.561955043597, 5525.060739674255, 4821.132196204681, 4886.291487734276, 4907.509249075082, 4923.704577725348, 5100.183970564711, 5038.874028149307, 5058.988202359525, 5061.139606266944, 5066.493350664922, 5070.61970352225, 4814.422269327685, 4875.24433712775, 4880.048390563841, 4933.605311575066, 4968.527989840959, 4880.8047678092835, 4910.754462276907, 4918.139325618003, 5012.548870601663, 5045.041442126021, 4844.20070688336, 4875.804967801284, 4878.219484882402, 4899.608031357483, 4930.063287975273, 5215.947840521584, 5298.814541491068, 5396.082665946798, 5402.594805389572, 5455.536279416255, 5704.714764261812, 5767.221425107598, 5791.218185544982, 5795.88408231833, 5797.043487824504, 5769.221155144044, 5831.591788574801, 5835.474807267324, 5838.766449342022, 5839.270091238595, 5246.632735708502, 5340.279062326575, 5369.382521010056, 5437.483439073321, 5439.347278326587, 5957.463828255478, 5958.285005799332, 5962.552808539377, 5965.463108320185, 5965.671888046112, 5727.31272247333, 5727.742251598688, 5731.254936858182, 5733.197352370671, 5735.77056917727, 5527.917081243784, 5661.575381846378, 5810.854728631818, 5817.94182058174, 5823.505002074787, 5672.177534257592, 5700.600957932905, 5710.885782284414, 5757.971210144006, 5763.567732420085, 5707.857303567444, 5751.079827227623, 5756.683382414008, 5758.1362795581, 5781.82654520365, 4344.478662560513, 4365.170617582649, 4393.802278897458, 4410.3825464435, 4457.754823484739, 3860.4981352424006, 3911.9022024449046, 3921.039345360405, 3934.6655534279334, 3955.5055618047745, 5410.431904650034, 5460.126379779295, 5463.508284254436, 5465.016297066487, 5473.534749546254, 5687.60186786921, 5776.480116789509, 5777.7977770777825, 5788.131780232999, 5826.82519524415, 5507.752151153208, 5556.138798486241, 5562.360328562187, 5565.860853478695, 5588.497035266845, 5048.444671086178, 5065.214891691794, 5066.974665126724, 5067.214581739762, 5108.259302401131, 5917.911231331534, 5952.464278214981, 6072.149899014142, 6072.180255665428, 6076.726547305293, 5778.624389414675, 5814.592978491465, 5819.5635327351465, 5837.09525023622, 5872.207252020922, 6009.278886533469, 6017.0, 6017.548683848817, 6020.488258498077, 6023.45788879003, 5544.75048622821, 5639.154126881001, 5667.971660141838, 5692.430756924275, 5716.571257155813, 5759.2512973313205, 5799.333076696234, 5831.533477321719, 5867.530597552271, 5879.941200587939, 5681.4034526374135, 5684.374718781013, 5684.971575142264, 5693.174489699053, 5695.288088988877, 5539.19681646151, 5562.777488900399, 5667.4332566743, 5680.971595142163, 5683.0, 5532.419095995024, 5580.274564306615, 5621.747021383966, 5662.66024038559, 5680.11958146488, 5664.150377443417, 5665.263515742927, 5717.542596592346, 5718.857028574319, 5726.4273572642405, 5354.732263386893, 5456.563474922076, 5534.778608855761, 5544.390117087037, 5559.58303127259], "value": 5333.932522898686, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.5740088435884, 598.3059650805066, 624.7001439309131, 631.1731631562656, 657.4970147836902, 42973.14053718924, 44049.339259911125, 44392.778036109776, 44477.332840007424, 49059.50940490594, 46080.53919460804, 46410.0, 46433.53566464334, 46487.30269045967, 46533.767331163384, 8975.730728078152, 9080.682176123837, 9114.726558203265, 9124.680636177734, 9133.041030691747, 8947.552622368856, 9102.0, 9107.544622768868, 9107.817843643123, 9111.635534578609, 9055.366124371296, 9103.408278461879, 9111.863322050142, 9114.225290850285, 9117.908820911773, 9055.0, 9097.590608422637, 9108.68119615817, 9110.225630821387, 9115.863262051074, 8927.330450216195, 9056.954715226448, 9065.546722663841, 9065.682701105496, 9065.909340906572, 43227.78386108081, 43549.34675979863, 43670.781646091884, 43699.0, 43700.0, 3552.2717842842158, 3690.2435000824767, 3892.9026774330587, 4081.10215752534, 4278.101598664284, 33482.3303533928, 34116.65883341184, 34486.48270275948, 34570.65429345725, 35192.824035879916, 4180.28935081037, 4296.398504209413, 4302.032042790347, 4372.672049596293, 4428.933565996513, 361240.0, 361991.0, 362326.5069397221, 364057.0, 364597.0, 57488.712556437786, 57937.420625794046, 58091.419085809444, 58116.12825807616, 58284.41715582875, 59545.0, 59612.40387596155, 59635.0, 59790.402095979356, 59981.70009150013, 16493.257803398876, 16738.581535461468, 16854.747178792328, 16894.74657880133, 16930.830691692925, 13223.206607603575, 13371.130876492996, 13423.523412424625, 13429.261390623415, 13430.395632196574, 13860.376283067084, 15825.446109386115, 15841.0, 15910.139105854485, 16016.919915400349, 6096.939030609726, 6224.719887605069, 6234.5635805494085, 6282.277538083179, 6301.8109456716375, 989.8911119776819, 1043.6712435582767, 1084.295208114716, 1114.331401159298, 1214.4717048084112, 32545.674543254263, 32632.0, 32863.83568082192, 33088.71249563168, 33168.83415582906, 952.5237381309346, 1125.6904351303458, 1126.718320419895, 1169.2692067457838, 1184.9407529623484, 16228.59428514273, 16627.334906603843, 16680.0, 16688.0, 16835.0, 566279.0, 570677.0, 571252.0, 571793.0, 571998.0, 58187.0, 58538.4146158533, 58566.707166464745, 58571.41428585745, 58609.0, 1234.672811704899, 1311.114997376767, 1387.5906607550796, 1390.5619729785287, 1403.8245219347582, 32698.673013270516, 33854.830725846216, 34202.553668023, 34253.0, 34420.82789586036, 49614.75192624014, 50162.0, 50179.24731128963, 50214.0, 50276.49723502865, 429228.0, 431321.0, 432154.9452801979, 432290.0, 433824.0, 27216.183514494598, 27588.44823103567, 27842.16473505798, 28763.28091797722, 28876.566851496824, 47762.522374777196, 47767.28349074697, 48794.512054879, 49091.75454122706, 49202.26196607125, 40800.59199407968, 41027.0, 42212.15575688407, 43215.13569728651, 43535.0, 41394.58605413907, 41582.79208603938, 42205.08180577501, 42879.3568096485, 43179.35230971475, 40763.0, 41816.0, 41846.37230441485, 42095.1580968385, 42177.36733948932, 34701.82649086738, 36515.26969460649, 37534.0, 37617.0, 37653.0, 28058.71941280561, 28223.0, 28326.291842704097, 34931.47602785909, 35461.46807797936], "value": 20391.20300382909, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.6720150260257, 370.8331250937079, 376.5819939866747, 379.9031247032007, 393.7539038101187, 14199.858001419983, 18351.63296734066, 19349.709754353695, 19372.51568710781, 20018.0, 18303.450896473092, 19106.713399298987, 19638.70541941872, 19906.303279385225, 19911.502212444695, 5646.068398714217, 5851.473367396933, 5852.151438041481, 5861.589688721791, 5863.8534036649, 5745.798897038604, 5769.740361683714, 5798.9130163047585, 5856.033754430514, 5861.648301101926, 5629.437056294379, 5758.798442054529, 5766.0486019806685, 5767.9423205768035, 5768.307803063638, 5183.222516622499, 5389.191621256804, 5390.380106287788, 5515.944840551583, 5755.366909639936, 5210.583153347723, 5342.893142137135, 5349.170878513836, 5455.481729235717, 5572.331320241557, 12881.613551593467, 13146.671333216651, 13328.266945318004, 13361.198328100345, 13373.531926382628, 2266.263464374085, 2270.2167752125656, 2343.2970108967243, 2352.6706261123454, 2678.906238281651, 9333.579988900516, 9569.712908612753, 9590.184834289093, 9818.116369526777, 9910.20718342538, 1860.38607259604, 1880.1163453176985, 1895.7440745499318, 1965.1451618545834, 1968.6948522978962, 81959.5902020492, 85012.57493712554, 86313.56843215744, 86622.0, 88695.0, 8968.955155224312, 9504.04959504044, 9506.809863802686, 9536.52317384128, 9685.903140968641, 12850.357482125857, 13001.219926804422, 13023.0, 13033.608991730263, 13040.673983150496, 7582.924170758332, 7731.342835858903, 7738.883916741253, 7884.17216192303, 7911.723089691834, 7671.0, 7778.572178530122, 7953.801154971172, 7970.800729981681, 7973.282404583615, 3891.747036442622, 3976.920461590752, 3997.620226078518, 4072.9592704073175, 4088.0, 1800.801911789702, 1836.8622353323553, 1858.6747319219082, 1880.0599700149926, 1942.873713208637, 926.4811705444972, 979.0601023017982, 992.4343124419012, 1006.7382480554962, 1041.8697662792151, 19483.610327793365, 20044.0, 20220.79779202189, 20327.695084573745, 20511.8974405127, 973.7273563402117, 980.0867342145264, 993.7962717643011, 1049.4700176411015, 1088.755030118217, 10603.204759643058, 11129.833052504218, 11150.442477876237, 11181.44092795357, 12122.27266364021, 526175.0, 538665.0, 543162.0, 544196.0, 545975.0, 69524.6523767378, 76458.61770691222, 96195.0, 99257.0, 99821.50089249652, 1019.2661283875598, 1019.6074511313197, 1052.6315789473622, 1053.5733028123468, 1056.2922841696081, 17129.74305385445, 17942.5514362142, 18041.278348865897, 18199.818001820342, 18244.90877545657, 42472.5752742481, 43519.564804351554, 43861.56138438575, 44196.11607767891, 44331.55668443274, 56869.43130568807, 60448.0, 61045.0, 61344.69327653333, 61627.69186154041, 7886.211378862068, 8098.919010809816, 8114.715984940499, 8435.91564084376, 8542.871856922275, 7927.881081783663, 12336.938315308365, 13236.470541178245, 13583.79624305656, 13769.31153442344, 11560.710982225512, 11669.88330116688, 11701.0, 11770.58802941893, 12131.514739410324, 11251.15616328795, 11325.943370283096, 11388.373639449579, 11409.657710268706, 11542.769144616892, 11088.501017454073, 11782.351970641697, 12135.878641213474, 12174.269543827399, 12341.519017717932, 8214.83570328602, 8282.337413007066, 8317.085120636846, 8491.702790402307, 8575.3997220194, 8429.241368276884, 10651.094656954245, 11611.709707257387, 11699.473523691624, 12044.457999390224], "value": 8919.957582008758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.4239183130833, 1494.5441640299707, 1593.2033983008496, 1698.5753561609597, 1782.304901088575, 8513.36149788766, 8990.325725570576, 9024.413413128143, 9032.68385606503, 9044.186023257906, 7784.3772498200005, 8012.198780121985, 8015.278624923756, 8187.05848827385, 8863.46819190849, 2253.481699209187, 2333.708286464192, 2335.637976113697, 2345.2495201535517, 2359.775821296974, 2367.4081479630095, 2401.891914863835, 2419.6491508731224, 2422.903083876643, 2423.1882319422925, 2377.4413012941945, 2388.10446082719, 2389.2712722619594, 2390.282915125464, 2393.270052633946, 2307.5846347657416, 2335.135999680112, 2336.5326934613145, 2339.1929784224417, 2341.063574570177, 2317.779810917977, 2321.1527792355837, 2345.0971376020184, 2348.3189874936247, 2350.8354415190943, 8844.0, 8990.05604411534, 9040.186383225542, 9052.411593246417, 9064.954675226647, 5057.367829021372, 5159.896802063975, 5174.301469301634, 5182.404023537304, 5190.32525771651, 3301.6533264007176, 3389.830508474591, 3456.3605732939236, 3461.16931936336, 3475.0617333320115, 1048.979020419595, 1160.4487868262593, 1164.8019836627793, 1168.299020587649, 1183.1363104933362, 12430.813537796941, 12432.689182770413, 12439.0, 12475.875241247562, 12510.18683785551, 4431.135928493977, 4722.338872557844, 4733.786979585927, 4740.620750339965, 4745.454272758608, 10653.147748180127, 10661.093807026335, 10661.253712240225, 10665.146788256921, 10671.679849604525, 5353.063213937623, 5361.785528578813, 5364.7049412282695, 5368.3826359968325, 5373.462653734595, 4220.430241917302, 4856.514348565186, 4858.222684370484, 4861.538153875376, 4920.40955085392, 3949.486566746362, 4093.16090201508, 4101.938470922939, 4108.753474791462, 4180.916381672349, 1284.537566476068, 1287.4270949427603, 1299.883010529057, 1306.372940988312, 1312.6783937935077, 969.7333233360741, 986.1716158426956, 995.328153496387, 1004.3823048825066, 1005.3264312910368, 6175.783847565313, 6176.258848938156, 6221.564490485713, 6243.812685619348, 6352.7776527822225, 943.688582767685, 998.5756053677159, 1005.5575546759402, 1022.805666923297, 1048.9475526223657, 4227.640650544677, 4317.827286908551, 4380.642000979707, 4391.3412988051405, 4408.669349798778, 10872.45637718111, 11039.448027598748, 11065.557377704963, 11070.667879963614, 11087.72280692989, 10924.344539327665, 10945.124390048777, 10956.178286628534, 10972.615958441416, 11001.339919604849, 7911.762647120596, 8178.959105204555, 8185.508869467851, 8351.1648835116, 8355.749327520305, 6158.938410616016, 6194.659293738888, 6209.223847019122, 6323.336049714714, 6467.320931302145, 10011.0, 10088.949555252177, 10197.54111064989, 10220.488975551341, 10352.430616316175, 10452.425116618355, 10467.267291289842, 10515.842262366225, 10594.258401911793, 10638.30850994714, 7648.502847314907, 7719.301753614196, 7864.21357864209, 7884.053913530183, 7987.440879138405, 8934.50860202695, 8990.100989900957, 8991.910080899108, 8996.325275604488, 9015.729528114167, 7714.614269286625, 7840.0, 7926.643301051351, 7933.484323519184, 8002.839943200987, 7556.886646700414, 7655.961720191363, 7700.8844867325915, 7704.19105993885, 7716.074071111502, 7103.680334384861, 7168.641567921687, 7183.0, 7193.136823581203, 7195.35241828217, 5123.6157288202785, 5197.896042079213, 5312.681239125664, 5360.3299587551555, 5575.804846830341, 5388.46115388458, 5426.0, 5489.780408783604, 5558.221848941071, 5643.830685079454], "value": 4736.2828445192135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.9360808406954, 313.722355715192, 323.6536905511104, 324.6558647833296, 325.2811287055607, 5288.576913846888, 5314.76083576239, 5341.172118321657, 5350.19747037944, 5353.812616558421, 4963.875903102425, 5108.131617625003, 5108.1826907694685, 5112.0, 5227.503387178212, 4014.9598504015025, 4042.3532234842432, 4127.876163715078, 4142.2543942090415, 4175.331946888498, 4127.8968025799295, 4134.441850350209, 4156.6051225133715, 4158.521769996444, 4162.646175075107, 4070.267351876661, 4073.96449704142, 4115.917681646365, 4118.155778065489, 4134.64855487284, 4084.6936479764136, 4088.1619268049976, 4095.815688294019, 4107.383892416146, 4114.485689288839, 3632.9273414531563, 3637.963620363789, 3650.251698401821, 3652.7625704329134, 3665.0470877571756, 4963.60291176705, 5142.357205349332, 5143.845684629429, 5150.175971844487, 5153.8919132386345, 4645.072294997606, 4648.953510464886, 4656.604188643969, 4679.251319788851, 4692.55420735033, 5475.878749113007, 5485.835424937259, 5494.203340515643, 5504.146857237095, 5512.448755124496, 3833.961660383416, 3908.2965066288057, 3925.7840818754958, 3937.114149316381, 3943.974566612673, 5691.943080569183, 5692.288463942007, 5701.629394089412, 5707.286589176353, 5725.08398656213, 3948.230095131422, 3958.940615890764, 3975.6421922027157, 3985.242803867256, 4002.0595160137345, 4044.4944381952255, 4055.7160998730396, 4056.229316429869, 4059.086705491241, 4060.2894493463527, 4578.793954272066, 4600.60894823937, 4627.514111018362, 4661.394018777605, 4664.137134630104, 5464.836054918359, 5493.0, 5493.763903121766, 5495.175723641486, 5496.31296087989, 1344.0793056756154, 1403.2983508245877, 1416.7037160997572, 1421.4527406948193, 1428.678547326843, 905.2124651553191, 914.9588268527932, 937.8511323628501, 974.1573538888952, 982.7837875667485, 5231.430570828737, 5235.633505654644, 5243.528082472596, 5264.236685680555, 5329.626926115212, 5451.371794298003, 5565.499105080562, 5576.079946808731, 5576.637518561281, 5601.80393686219, 5193.454687257859, 5232.790688372498, 5241.13521268994, 5262.184361423985, 5264.368275806928, 2961.392914452532, 2988.4321978823955, 2994.8053376530456, 2995.3260516384075, 3008.2028262510453, 5682.806610611818, 5690.829275121753, 5740.1102829061565, 5751.281089863767, 5760.971195143998, 5657.464084946908, 5662.462066103713, 5677.37548869624, 5693.345265294544, 5700.287464066992, 5805.7387417566315, 5816.302043754777, 5819.476247137778, 5821.330546987151, 5849.5612829037145, 5440.918386224131, 5563.610547261653, 5597.132444471114, 5602.803901863415, 5610.4670056344585, 5503.642263252876, 5536.446355364593, 5536.944630553643, 5570.136628822539, 5591.329040515164, 5475.972620136874, 5692.373838877637, 5815.709214539341, 5824.242848429846, 5824.9417505826095, 3961.8415263390293, 3969.861054863066, 3970.8881513176357, 3981.8651684271003, 3991.1219531702977, 5661.405552416937, 5663.669037776037, 5687.459691329317, 5693.402192769865, 5700.629459085146, 5397.8380648580605, 5457.645253058538, 5486.286782718381, 5573.219749235192, 5573.498385145194, 5468.808591699271, 5469.206964989975, 5474.698891561003, 5477.287952566141, 5491.395946445968, 5253.422123566328, 5285.68285902847, 5457.536109430743, 5463.48096930791, 5480.0, 5516.889662206653, 5525.198846167203, 5535.806246781504, 5541.972290138524, 5544.1960915666195, 5406.432324605859, 5407.297051383295, 5415.756290966995, 5418.295621569171, 5421.972890135682], "value": 4185.394025939156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.488954845028, 773.3542492019163, 776.9456138070337, 817.6402382951504, 897.412195012267, 15010.849891501082, 16320.591985200375, 16321.673566528678, 16342.591435214126, 16349.509514714548, 13428.0, 13917.23455209963, 14031.92984035081, 14053.789193162085, 14114.153150810958, 655.8655475627509, 794.0907660728462, 812.695239285268, 813.0121901889204, 814.2549567146054, 783.5416281475344, 806.7821688144197, 812.9349652027823, 813.4509206285763, 813.6419975210918, 856.9871451928226, 859.0292968945083, 859.9527026013567, 861.0184389795638, 861.104451370577, 675.6216518749467, 850.8936382952162, 857.8627419612864, 858.7938894665298, 859.072202021818, 598.6737228210636, 619.9132121502993, 621.940915613016, 623.0342968399009, 623.1338439569003, 13996.230207338593, 14130.858691413057, 14184.21986790726, 14186.503472378417, 14204.218767967757, 14252.501162459264, 14261.500847470288, 14691.706165876623, 14996.0, 15194.316255768517, 12443.128980971336, 12513.249205047727, 12714.110012299143, 12748.0, 12949.48202071916, 4375.846845360429, 4449.26587113126, 4507.256302710081, 4513.932291015637, 4633.8609841704465, 72530.63734681293, 73220.0, 75460.62269688671, 77385.0, 78029.0, 11668.124890633237, 11679.182457228082, 11774.587889423829, 11804.586839460577, 11812.232204906653, 22337.218197363014, 22381.44046398853, 22395.21616743406, 22396.776032239468, 22407.775922240897, 8625.827483450421, 8694.956525217334, 8737.650493980296, 8799.076097009849, 8839.779005524784, 4599.379083823641, 4701.412323459567, 4711.764411779397, 4867.245576935581, 4936.03747269279, 3392.6098498672477, 3490.47642853574, 3499.4225952718025, 3502.754807163474, 3580.820958952042, 573.4237091722875, 578.7308901360803, 582.0919365789298, 593.3888095261888, 593.5518683394096, 586.5014737473114, 649.4447247603325, 654.8657525207321, 658.3515237491067, 664.2062735031687, 8949.731508054638, 9231.723048308562, 9346.626134954526, 9402.764930876783, 9415.6704515343, 652.1815122021832, 659.3274859643137, 696.6447111972931, 710.2435905760349, 712.0494140322623, 4397.403076984488, 4594.609458196091, 4664.158734255109, 4737.360456338419, 4764.190087685102, 64448.677756610916, 65606.67196663986, 65752.67123664447, 65757.34242657608, 77539.2246077532, 55924.72037639867, 65925.67037164784, 91625.54187229155, 94765.0, 94786.0, 83843.0, 85085.0, 88821.11178888129, 90461.0, 91880.54059729658, 8356.206160414751, 8732.69435569752, 8817.338699597683, 8842.734717958472, 8847.159519845605, 46900.0, 48376.51623483861, 49592.504074960234, 50101.24848127354, 52028.47971520388, 63163.6841815788, 71906.64046679733, 72376.0, 72991.0, 74698.0, 12001.63995080149, 12074.0, 12436.0, 12582.0, 12707.110502265123, 12743.0, 12835.679108022374, 12923.353832308536, 13146.0, 13269.933650332072, 11467.4266286687, 11809.232399894323, 12019.21875078117, 12161.756764864476, 12417.06871984623, 12199.69500762488, 12254.75490490203, 12292.692682683004, 12756.681082973, 12773.361331933553, 11601.651950441163, 11958.342291174069, 12023.699407514881, 12388.752224955631, 12422.937885310515, 10092.526477153084, 10291.485425728533, 10399.740006499898, 10548.605001416536, 10853.023227909525, 9453.480058596568, 9625.422474651543, 9667.806643867223, 10356.119729822749, 10440.530176142243], "value": 7224.112271430154, "unit": "score"}], "name": "dromaeo_css", "value": 7196.855019250935, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 114.0, 111.0, 112.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 118.0, 178.0, 119.0, 117.0, 152.0, 119.0, 156.0, 122.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 159.0, 161.0, 159.0, 160.0, 160.0, 163.0, 163.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 121.0, 75.0, 75.0, 73.0, 74.0, 110.0, 74.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 110.0, 84.0, 82.0, 83.0, 120.0, 83.0, 82.0, 122.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 54.0, 55.0, 53.0, 52.0, 52.0, 51.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 76.0, 76.0, 75.0, 75.0, 76.0, 75.0, 77.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 133.0, 126.0, 123.0, 120.0, 117.0, 119.0, 165.0, 130.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 156.0, 159.0, 161.0, 156.0, 156.0, 160.0, 158.0, 155.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 63.0, 63.0, 64.0, 65.0, 63.0, 62.0, 65.0, 64.0, 61.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1477.3999999999999, "alertThreshold": 2.0}]} 14:40:31 INFO - Return code: 0 14:40:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:40:31 INFO - # TBPL SUCCESS # 14:40:31 INFO - Running post-action listener: _resource_record_post_action 14:40:31 INFO - [mozharness: 2016-07-25 21:40:31.905593Z] Finished run-tests step (success) 14:40:31 INFO - Running post-run listener: _resource_record_post_run 14:40:31 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 564957184; Read time: 12; Write time: 431680 14:40:31 INFO - TinderboxPrint: CPU usage
13.0% 14:40:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:40:31 INFO - TinderboxPrint: I/O write bytes / time
564,957,184 / 431,680 14:40:31 INFO - TinderboxPrint: CPU idle
8,277.0 (87.0%) 14:40:31 INFO - TinderboxPrint: CPU user
1,192.1 (12.5%) 14:40:31 INFO - TinderboxPrint: Swap in / out
0 / 0 14:40:31 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256770048; Read time: 0; Write time: 260048 14:40:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295620608; Read time: 0; Write time: 168052 14:40:32 INFO - Running post-run listener: _upload_blobber_files 14:40:32 INFO - Blob upload gear active. 14:40:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:40:32 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 14:40:32 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'] 14:40:32 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 14:40:32 INFO - (blobuploader) - INFO - Open directory for files ... 14:40:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:40:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:40:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:40:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:40:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:40:33 INFO - (blobuploader) - INFO - Done attempting. 14:40:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:40:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:40:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:40:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:40:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:40:46 INFO - (blobuploader) - INFO - Done attempting. 14:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:40:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:40:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:40:47 INFO - (blobuploader) - INFO - Done attempting. 14:40:47 INFO - (blobuploader) - INFO - Iteration through files over. 14:40:47 INFO - Return code: 0 14:40:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:40:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:40:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e318e2869771c1c9a61c1929660d6c8a4c54bfe193875daf7bf75112388cae3207f34fe76206d2234e0948bc697b3cb8af9938c5dfdccd73e33fb912551d26e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d10c998156e374983b72e1b3ae2293da6b4e3c455cb50f469c7e4cf99f49f55e194b60a4cf3b6c6ac01cbfe0f2c9ac0dd280007331a9f4d9556955c51b2f797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f058c0a315b2a0009060427566499f37fb21f49f67f3133251f3de45d08a0d627d2833079a2d5a7b9333c21ef895095c99e3e32e4c1339991cacec33f74be24"} 14:40:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:40:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:40:47 INFO - Contents: 14:40:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e318e2869771c1c9a61c1929660d6c8a4c54bfe193875daf7bf75112388cae3207f34fe76206d2234e0948bc697b3cb8af9938c5dfdccd73e33fb912551d26e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d10c998156e374983b72e1b3ae2293da6b4e3c455cb50f469c7e4cf99f49f55e194b60a4cf3b6c6ac01cbfe0f2c9ac0dd280007331a9f4d9556955c51b2f797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f058c0a315b2a0009060427566499f37fb21f49f67f3133251f3de45d08a0d627d2833079a2d5a7b9333c21ef895095c99e3e32e4c1339991cacec33f74be24"} 14:40:47 INFO - Running post-run listener: copy_logs_to_upload_dir 14:40:47 INFO - Copying logs to upload dir... 14:40:47 INFO - mkdir: /builds/slave/test/build/upload/logs 14:40:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.364768 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-25 14:40:47.544057) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 14:40:47.547653) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e318e2869771c1c9a61c1929660d6c8a4c54bfe193875daf7bf75112388cae3207f34fe76206d2234e0948bc697b3cb8af9938c5dfdccd73e33fb912551d26e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d10c998156e374983b72e1b3ae2293da6b4e3c455cb50f469c7e4cf99f49f55e194b60a4cf3b6c6ac01cbfe0f2c9ac0dd280007331a9f4d9556955c51b2f797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f058c0a315b2a0009060427566499f37fb21f49f67f3133251f3de45d08a0d627d2833079a2d5a7b9333c21ef895095c99e3e32e4c1339991cacec33f74be24"} build_url:https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/WcbABj3iT36PmXN0Rj96lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e318e2869771c1c9a61c1929660d6c8a4c54bfe193875daf7bf75112388cae3207f34fe76206d2234e0948bc697b3cb8af9938c5dfdccd73e33fb912551d26e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d10c998156e374983b72e1b3ae2293da6b4e3c455cb50f469c7e4cf99f49f55e194b60a4cf3b6c6ac01cbfe0f2c9ac0dd280007331a9f4d9556955c51b2f797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f058c0a315b2a0009060427566499f37fb21f49f67f3133251f3de45d08a0d627d2833079a2d5a7b9333c21ef895095c99e3e32e4c1339991cacec33f74be24"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 14:40:47.573485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 14:40:47.573821) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469480777.468622-1672551998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 14:40:47.656466) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 14:40:47.656988) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 14:40:47.657351) ========= ========= Total master_lag: 0.17 =========