builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1469585463.85 results: success (0) buildid: 20160726163046 builduid: a9c42adabbc34690a475e49ac181bcf8 revision: c8261ef537e0591497988faba7e8b3da5bdb65f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:03.846115) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:03.846649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:03.846979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:03.862687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:03.863307) ========= 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=d2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 19:11:04-- 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% 41.9M=0s 2016-07-26 19:11:04 (41.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:03.956542) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:03.957037) ========= 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=d2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017077 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:04.010686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 19:11:04.011098) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c8261ef537e0591497988faba7e8b3da5bdb65f8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c8261ef537e0591497988faba7e8b3da5bdb65f8 --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=d2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 19:11:04,325 truncating revision to first 12 chars 2016-07-26 19:11:04,325 Setting DEBUG logging. 2016-07-26 19:11:04,326 attempt 1/10 2016-07-26 19:11:04,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c8261ef537e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 19:11:05,301 unpacking tar archive at: mozilla-inbound-c8261ef537e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 19:11:05.337517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:05.338074) ========= script_repo_revision: c8261ef537e0591497988faba7e8b3da5bdb65f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:05.338673) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:05.339076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 19:11:05.349042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-26 19:11:05.349463) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=d2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:11:05 INFO - MultiFileLogger online at 20160726 19:11:05 in /builds/slave/test 19:11:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:11:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:11:05 INFO - {'append_to_log': False, 19:11:05 INFO - 'base_work_dir': '/builds/slave/test', 19:11:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:11:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:11:05 INFO - 'branch': 'Mozilla-Inbound', 19:11:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:11:05 INFO - 'config_files': ('talos/linux_config.py',), 19:11:05 INFO - 'default_actions': ('clobber', 19:11:05 INFO - 'read-buildbot-config', 19:11:05 INFO - 'download-and-extract', 19:11:05 INFO - 'populate-webroot', 19:11:05 INFO - 'create-virtualenv', 19:11:05 INFO - 'install', 19:11:05 INFO - 'run-tests'), 19:11:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:11:05 INFO - 'download_minidump_stackwalk': True, 19:11:05 INFO - 'download_symbols': 'ondemand', 19:11:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:11:05 INFO - 'tooltool.py': '/tools/tooltool.py', 19:11:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:11:05 INFO - '/tools/misc-python/virtualenv.py')}, 19:11:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:11:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:11:05 INFO - 'installer_path': 'installer.exe', 19:11:05 INFO - 'log_level': 'info', 19:11:05 INFO - 'log_name': 'talos', 19:11:05 INFO - 'log_to_console': True, 19:11:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:11:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:11:05 INFO - 'opt_config_files': (), 19:11:05 INFO - 'pip_index': False, 19:11:05 INFO - 'sps_profile': False, 19:11:05 INFO - 'sps_profile_interval': 0, 19:11:05 INFO - 'suite': 'dromaeojs', 19:11:05 INFO - 'system_bits': '32', 19:11:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:11:05 INFO - 'title': 'talos-linux64-ix-043', 19:11:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:11:05 INFO - 'use_talos_json': True, 19:11:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:11:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:11:05 INFO - 'work_dir': 'build'} 19:11:05 INFO - [mozharness: 2016-07-27 02:11:05.754742Z] Running clobber step. 19:11:05 INFO - Running pre-action listener: _resource_record_pre_action 19:11:05 INFO - Running main action method: clobber 19:11:05 INFO - rmtree: /builds/slave/test/build 19:11:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:11:06 INFO - Running post-action listener: _resource_record_post_action 19:11:06 INFO - [mozharness: 2016-07-27 02:11:06.228264Z] Finished clobber step (success) 19:11:06 INFO - [mozharness: 2016-07-27 02:11:06.228365Z] Running read-buildbot-config step. 19:11:06 INFO - Running pre-action listener: _resource_record_pre_action 19:11:06 INFO - Running main action method: read_buildbot_config 19:11:06 INFO - Using buildbot properties: 19:11:06 INFO - { 19:11:06 INFO - "project": "", 19:11:06 INFO - "product": "firefox", 19:11:06 INFO - "script_repo_revision": "production", 19:11:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:11:06 INFO - "repository": "", 19:11:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:11:06 INFO - "buildid": "20160726163046", 19:11:06 INFO - "pgo_build": "True", 19:11:06 INFO - "basedir": "/builds/slave/test", 19:11:06 INFO - "buildnumber": 1299, 19:11:06 INFO - "slavename": "talos-linux64-ix-043", 19:11:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:11:06 INFO - "platform": "ubuntu64_hw", 19:11:06 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:11:06 INFO - "branch": "mozilla-inbound", 19:11:06 INFO - "repo_path": "integration/mozilla-inbound", 19:11:06 INFO - "revision": "c8261ef537e0591497988faba7e8b3da5bdb65f8", 19:11:06 INFO - "stage_platform": "linux64-pgo", 19:11:06 INFO - "builduid": "a9c42adabbc34690a475e49ac181bcf8", 19:11:06 INFO - "slavebuilddir": "test" 19:11:06 INFO - } 19:11:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:11:06 INFO - Running post-action listener: _resource_record_post_action 19:11:06 INFO - [mozharness: 2016-07-27 02:11:06.230820Z] Finished read-buildbot-config step (success) 19:11:06 INFO - [mozharness: 2016-07-27 02:11:06.230910Z] Running download-and-extract step. 19:11:06 INFO - Running pre-action listener: _resource_record_pre_action 19:11:06 INFO - Running main action method: download_and_extract 19:11:06 INFO - mkdir: /builds/slave/test/build/tests 19:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:06 INFO - https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:11:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:11:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:11:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:11 INFO - Downloaded 1361 bytes. 19:11:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:11:11 INFO - Using the following test package requirements: 19:11:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:11:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:11:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:11 INFO - u'jsshell-linux-x86_64.zip'], 19:11:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:11:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:11:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:11:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:11:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:11:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:11: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')]} 19:11:11 INFO - https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:11:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:11:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:11:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:22 INFO - Downloaded 24315455 bytes. 19:11:22 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'] 19:11:22 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 19:11:23 INFO - Return code: 0 19:11:23 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 19:11: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')]} 19:11:23 INFO - https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:24 INFO - Downloaded 24315455 bytes. 19:11:24 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'] 19:11:24 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 19:11:26 INFO - Return code: 0 19:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:26 INFO - https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:27 INFO - Downloaded 14413725 bytes. 19:11:27 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'] 19:11:27 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 19:11:27 INFO - Return code: 0 19:11:27 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')]} 19:11:27 INFO - https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bejWiS7ZQwup5T25umjpGw/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 19:11:28 INFO - Downloaded 61017514 bytes. 19:11:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:28 INFO - mkdir: /builds/slave/test/properties 19:11:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:28 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:28 INFO - Contents: 19:11:28 INFO - build_url:https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:29 INFO - Running post-action listener: _resource_record_post_action 19:11:29 INFO - Running post-action listener: set_extra_try_arguments 19:11:29 INFO - [mozharness: 2016-07-27 02:11:29.309803Z] Finished download-and-extract step (success) 19:11:29 INFO - [mozharness: 2016-07-27 02:11:29.310035Z] Running populate-webroot step. 19:11:29 INFO - Running pre-action listener: _resource_record_pre_action 19:11:29 INFO - Running main action method: populate_webroot 19:11:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:29 INFO - '--tppagecycles', 19:11:29 INFO - '7'], 19:11:29 INFO - 'tests': ['tsvgm']}}, 19:11:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:11:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:11:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['damp', 'tps']}, 19:11:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'tests': ['damp', 'tps']}, 19:11:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['dromaeo_dom']}, 19:11:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['basic_compositor_video']}, 19:11:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:11:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other-e10s': {'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['tsvgx', 19:11:29 INFO - 'tsvgr_opacity', 19:11:29 INFO - 'tart', 19:11:29 INFO - 'tscrollx', 19:11:29 INFO - 'cart']}, 19:11:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:11:29 INFO - 'tsvgr_opacity', 19:11:29 INFO - 'tart', 19:11:29 INFO - 'tscrollx', 19:11:29 INFO - 'cart']}, 19:11:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--disable-e10s'], 19:11:29 INFO - 'tests': ['tp5o']}, 19:11:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'tests': ['tp5o']}, 19:11:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--disable-e10s', 19:11:29 INFO - '--xperf_path', 19:11:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:29 INFO - 'tests': ['tp5n']}, 19:11:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--xperf_path', 19:11:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:29 INFO - 'tests': ['tp5n']}}, 19:11:29 INFO - 'talos.zip': {'path': '', 19:11:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:29 INFO - Running post-action listener: _resource_record_post_action 19:11:29 INFO - [mozharness: 2016-07-27 02:11:29.330447Z] Finished populate-webroot step (success) 19:11:29 INFO - [mozharness: 2016-07-27 02:11:29.330536Z] Running create-virtualenv step. 19:11:29 INFO - Running pre-action listener: _resource_record_pre_action 19:11:29 INFO - Running main action method: create_virtualenv 19:11:29 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:29 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 19:11:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:29 INFO - Using real prefix '/usr' 19:11:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:29 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:31 INFO - Installing pip.................done. 19:11:31 INFO - Return code: 0 19:11:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:31 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 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11:31 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 19:11:31 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 19:11:31 INFO - Using env: {'DISPLAY': ':0', 19:11:31 INFO - 'HOME': '/home/cltbld', 19:11:31 INFO - 'LANG': 'en_US.UTF-8', 19:11:31 INFO - 'LANGUAGE': 'en_US:en', 19:11:31 INFO - 'LOGNAME': 'cltbld', 19:11:31 INFO - 'MAIL': '/var/mail/cltbld', 19:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:31 INFO - 'MOZ_NO_REMOTE': '1', 19:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:31 INFO - 'NO_EM_RESTART': '1', 19:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:31 INFO - 'PWD': '/builds/slave/test', 19:11:31 INFO - 'SHELL': '/bin/bash', 19:11:31 INFO - 'SHLVL': '1', 19:11:31 INFO - 'TERM': 'linux', 19:11:31 INFO - 'TMOUT': '86400', 19:11:31 INFO - 'USER': 'cltbld', 19:11:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:31 INFO - '_': '/tools/buildbot/bin/python'} 19:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:32 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 19:11:32 INFO - Cleaning up... 19:11:32 INFO - Return code: 0 19:11:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:11:32 INFO - Using env: {'DISPLAY': ':0', 19:11:32 INFO - 'HOME': '/home/cltbld', 19:11:32 INFO - 'LANG': 'en_US.UTF-8', 19:11:32 INFO - 'LANGUAGE': 'en_US:en', 19:11:32 INFO - 'LOGNAME': 'cltbld', 19:11:32 INFO - 'MAIL': '/var/mail/cltbld', 19:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:32 INFO - 'MOZ_NO_REMOTE': '1', 19:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:32 INFO - 'NO_EM_RESTART': '1', 19:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:32 INFO - 'PWD': '/builds/slave/test', 19:11:32 INFO - 'SHELL': '/bin/bash', 19:11:32 INFO - 'SHLVL': '1', 19:11:32 INFO - 'TERM': 'linux', 19:11:32 INFO - 'TMOUT': '86400', 19:11:32 INFO - 'USER': 'cltbld', 19:11:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:32 INFO - '_': '/tools/buildbot/bin/python'} 19:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:32 INFO - Downloading/unpacking psutil>=3.1.1 19:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:34 INFO - Installing collected packages: psutil 19:11:34 INFO - Running setup.py install for psutil 19:11:34 INFO - building 'psutil._psutil_linux' extension 19:11:34 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 19:11:34 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 19:11:34 INFO - building 'psutil._psutil_posix' extension 19:11:34 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 19:11:34 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 19:11:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:34 INFO - Successfully installed psutil 19:11:34 INFO - Cleaning up... 19:11:34 INFO - Return code: 0 19:11:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:11:34 INFO - Using env: {'DISPLAY': ':0', 19:11:34 INFO - 'HOME': '/home/cltbld', 19:11:34 INFO - 'LANG': 'en_US.UTF-8', 19:11:34 INFO - 'LANGUAGE': 'en_US:en', 19:11:34 INFO - 'LOGNAME': 'cltbld', 19:11:34 INFO - 'MAIL': '/var/mail/cltbld', 19:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:34 INFO - 'MOZ_NO_REMOTE': '1', 19:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:34 INFO - 'NO_EM_RESTART': '1', 19:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:34 INFO - 'PWD': '/builds/slave/test', 19:11:34 INFO - 'SHELL': '/bin/bash', 19:11:34 INFO - 'SHLVL': '1', 19:11:34 INFO - 'TERM': 'linux', 19:11:34 INFO - 'TMOUT': '86400', 19:11:34 INFO - 'USER': 'cltbld', 19:11:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:34 INFO - '_': '/tools/buildbot/bin/python'} 19:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:11:37 INFO - Installing collected packages: mozsystemmonitor 19:11:37 INFO - Running setup.py install for mozsystemmonitor 19:11:37 INFO - Successfully installed mozsystemmonitor 19:11:37 INFO - Cleaning up... 19:11:37 INFO - Return code: 0 19:11:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:11:37 INFO - Using env: {'DISPLAY': ':0', 19:11:37 INFO - 'HOME': '/home/cltbld', 19:11:37 INFO - 'LANG': 'en_US.UTF-8', 19:11:37 INFO - 'LANGUAGE': 'en_US:en', 19:11:37 INFO - 'LOGNAME': 'cltbld', 19:11:37 INFO - 'MAIL': '/var/mail/cltbld', 19:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:37 INFO - 'MOZ_NO_REMOTE': '1', 19:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:37 INFO - 'NO_EM_RESTART': '1', 19:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:37 INFO - 'PWD': '/builds/slave/test', 19:11:37 INFO - 'SHELL': '/bin/bash', 19:11:37 INFO - 'SHLVL': '1', 19:11:37 INFO - 'TERM': 'linux', 19:11:37 INFO - 'TMOUT': '86400', 19:11:37 INFO - 'USER': 'cltbld', 19:11:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:37 INFO - '_': '/tools/buildbot/bin/python'} 19:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:37 INFO - Downloading/unpacking jsonschema==2.5.1 19:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:39 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:39 INFO - warning: no files found matching '*.txt' 19:11:39 INFO - no previously-included directories found matching 'build' 19:11:39 INFO - no previously-included directories found matching 'dist' 19:11:39 INFO - no previously-included directories found matching '.git*' 19:11:39 INFO - Installing collected packages: jsonschema, functools32 19:11:39 INFO - Running setup.py install for functools32 19:11:39 INFO - warning: no files found matching '*.txt' 19:11:39 INFO - no previously-included directories found matching 'build' 19:11:39 INFO - no previously-included directories found matching 'dist' 19:11:39 INFO - no previously-included directories found matching '.git*' 19:11:39 INFO - Successfully installed jsonschema functools32 19:11:39 INFO - Cleaning up... 19:11:39 INFO - Return code: 0 19:11:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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', '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 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:11: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 functools32==3.2.3-2 19:11:39 INFO - Using env: {'DISPLAY': ':0', 19:11:39 INFO - 'HOME': '/home/cltbld', 19:11:39 INFO - 'LANG': 'en_US.UTF-8', 19:11:39 INFO - 'LANGUAGE': 'en_US:en', 19:11:39 INFO - 'LOGNAME': 'cltbld', 19:11:39 INFO - 'MAIL': '/var/mail/cltbld', 19:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:39 INFO - 'MOZ_NO_REMOTE': '1', 19:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:39 INFO - 'NO_EM_RESTART': '1', 19:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:39 INFO - 'PWD': '/builds/slave/test', 19:11:39 INFO - 'SHELL': '/bin/bash', 19:11:39 INFO - 'SHLVL': '1', 19:11:39 INFO - 'TERM': 'linux', 19:11:39 INFO - 'TMOUT': '86400', 19:11:39 INFO - 'USER': 'cltbld', 19:11:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:39 INFO - '_': '/tools/buildbot/bin/python'} 19:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:11:40 INFO - Cleaning up... 19:11:40 INFO - Return code: 0 19:11:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:11:40 INFO - Using env: {'DISPLAY': ':0', 19:11:40 INFO - 'HOME': '/home/cltbld', 19:11:40 INFO - 'LANG': 'en_US.UTF-8', 19:11:40 INFO - 'LANGUAGE': 'en_US:en', 19:11:40 INFO - 'LOGNAME': 'cltbld', 19:11:40 INFO - 'MAIL': '/var/mail/cltbld', 19:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:40 INFO - 'MOZ_NO_REMOTE': '1', 19:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:40 INFO - 'NO_EM_RESTART': '1', 19:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:40 INFO - 'PWD': '/builds/slave/test', 19:11:40 INFO - 'SHELL': '/bin/bash', 19:11:40 INFO - 'SHLVL': '1', 19:11:40 INFO - 'TERM': 'linux', 19:11:40 INFO - 'TMOUT': '86400', 19:11:40 INFO - 'USER': 'cltbld', 19:11:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:40 INFO - '_': '/tools/buildbot/bin/python'} 19:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:40 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:40 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 19:11:40 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 19:11:40 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 19:11:40 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 19:11:40 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 19:11:40 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 19:11:42 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:42 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 19:11:42 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 19:11:42 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 19:11:42 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 19:11:42 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 19:11:42 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 19:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:42 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 19:11:42 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 19:11:42 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 19:11:42 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 19:11:42 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 19:11:42 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 19:11:42 INFO - Downloading docopt-0.6.1.tar.gz 19:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:42 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:42 INFO - Running setup.py install for blobuploader 19:11:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:42 INFO - Running setup.py install for requests 19:11:43 INFO - Running setup.py install for docopt 19:11:43 INFO - Successfully installed blobuploader requests docopt 19:11:43 INFO - Cleaning up... 19:11:43 INFO - Return code: 0 19:11:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:43 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 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11:43 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 19:11:43 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 19:11:43 INFO - Using env: {'DISPLAY': ':0', 19:11:43 INFO - 'HOME': '/home/cltbld', 19:11:43 INFO - 'LANG': 'en_US.UTF-8', 19:11:43 INFO - 'LANGUAGE': 'en_US:en', 19:11:43 INFO - 'LOGNAME': 'cltbld', 19:11:43 INFO - 'MAIL': '/var/mail/cltbld', 19:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:43 INFO - 'MOZ_NO_REMOTE': '1', 19:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:43 INFO - 'NO_EM_RESTART': '1', 19:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:43 INFO - 'PWD': '/builds/slave/test', 19:11:43 INFO - 'SHELL': '/bin/bash', 19:11:43 INFO - 'SHLVL': '1', 19:11:43 INFO - 'TERM': 'linux', 19:11:43 INFO - 'TMOUT': '86400', 19:11:43 INFO - 'USER': 'cltbld', 19:11:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:43 INFO - '_': '/tools/buildbot/bin/python'} 19:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:43 INFO - Running setup.py (path:/tmp/pip-_nK4Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:43 INFO - Running setup.py (path:/tmp/pip-FUDgDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:43 INFO - Running setup.py (path:/tmp/pip-Dbu9Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:43 INFO - Running setup.py (path:/tmp/pip-bshaPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:44 INFO - Running setup.py (path:/tmp/pip-Qe7m_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:44 INFO - Running setup.py (path:/tmp/pip-f85R0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:44 INFO - Running setup.py (path:/tmp/pip-PP6cCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:44 INFO - Running setup.py (path:/tmp/pip-ZtpaHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:44 INFO - Running setup.py (path:/tmp/pip-RrNr53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:44 INFO - Running setup.py (path:/tmp/pip-vBJWQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:44 INFO - Running setup.py (path:/tmp/pip-ODGaH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:44 INFO - Running setup.py (path:/tmp/pip-iZIOqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:44 INFO - Running setup.py (path:/tmp/pip-noS6g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:44 INFO - Running setup.py (path:/tmp/pip-Hii0WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:44 INFO - Running setup.py (path:/tmp/pip-4Gbe9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:44 INFO - Running setup.py (path:/tmp/pip-BZ4xWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:44 INFO - Running setup.py (path:/tmp/pip-3XJbBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:45 INFO - Running setup.py install for manifestparser 19:11:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:45 INFO - Running setup.py install for mozcrash 19:11:45 INFO - Running setup.py install for mozdebug 19:11:45 INFO - Running setup.py install for mozdevice 19:11:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:45 INFO - Running setup.py install for mozfile 19:11:45 INFO - Running setup.py install for mozhttpd 19:11:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:45 INFO - Running setup.py install for mozinfo 19:11:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:45 INFO - Running setup.py install for mozInstall 19:11:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:45 INFO - Running setup.py install for mozleak 19:11:45 INFO - Running setup.py install for mozlog 19:11:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:46 INFO - Running setup.py install for moznetwork 19:11:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:46 INFO - Running setup.py install for mozprocess 19:11:46 INFO - Running setup.py install for mozprofile 19:11:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:46 INFO - Running setup.py install for mozrunner 19:11:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:46 INFO - Running setup.py install for mozscreenshot 19:11:46 INFO - Running setup.py install for moztest 19:11:46 INFO - Running setup.py install for mozversion 19:11:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:46 INFO - Cleaning up... 19:11:46 INFO - Return code: 0 19:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:46 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 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11:46 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 19:11:46 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 19:11:46 INFO - Using env: {'DISPLAY': ':0', 19:11:46 INFO - 'HOME': '/home/cltbld', 19:11:46 INFO - 'LANG': 'en_US.UTF-8', 19:11:46 INFO - 'LANGUAGE': 'en_US:en', 19:11:46 INFO - 'LOGNAME': 'cltbld', 19:11:46 INFO - 'MAIL': '/var/mail/cltbld', 19:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:46 INFO - 'MOZ_NO_REMOTE': '1', 19:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:46 INFO - 'NO_EM_RESTART': '1', 19:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:46 INFO - 'PWD': '/builds/slave/test', 19:11:46 INFO - 'SHELL': '/bin/bash', 19:11:46 INFO - 'SHLVL': '1', 19:11:46 INFO - 'TERM': 'linux', 19:11:46 INFO - 'TMOUT': '86400', 19:11:46 INFO - 'USER': 'cltbld', 19:11:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:46 INFO - '_': '/tools/buildbot/bin/python'} 19:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:47 INFO - Running setup.py (path:/tmp/pip-cawW1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:47 INFO - Running setup.py (path:/tmp/pip-uiREtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:47 INFO - Running setup.py (path:/tmp/pip-KTmsuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:47 INFO - Running setup.py (path:/tmp/pip-SzT_FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:47 INFO - Running setup.py (path:/tmp/pip-mlxxB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:47 INFO - Running setup.py (path:/tmp/pip-xgHykw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:47 INFO - Running setup.py (path:/tmp/pip-A03CQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:47 INFO - Running setup.py (path:/tmp/pip-4Ye1Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:47 INFO - Running setup.py (path:/tmp/pip-TVYPQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:47 INFO - Running setup.py (path:/tmp/pip-EXl0Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:47 INFO - Running setup.py (path:/tmp/pip-ueYgDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:47 INFO - Running setup.py (path:/tmp/pip-7xpYEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:47 INFO - Running setup.py (path:/tmp/pip-3G23bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:47 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)) 19:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:47 INFO - Running setup.py (path:/tmp/pip-BaFEOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:48 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)) 19:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:48 INFO - Running setup.py (path:/tmp/pip-MRWsrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:48 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)) 19:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:48 INFO - Running setup.py (path:/tmp/pip-Qxi_5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:48 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)) 19:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:48 INFO - Running setup.py (path:/tmp/pip-8rm5ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:48 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)) 19:11:48 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)) 19:11:48 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)) 19:11:48 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)) 19:11:48 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)) 19:11:48 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)) 19:11:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:50 INFO - Downloading blessings-1.6.tar.gz 19:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:50 INFO - Installing collected packages: blessings 19:11:50 INFO - Running setup.py install for blessings 19:11:50 INFO - Successfully installed blessings 19:11:50 INFO - Cleaning up... 19:11:50 INFO - Return code: 0 19:11:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:50 INFO - Reading from file tmpfile_stdout 19:11:50 INFO - Current package versions: 19:11:50 INFO - argparse == 1.2.1 19:11:50 INFO - blessings == 1.6 19:11:50 INFO - blobuploader == 1.2.4 19:11:50 INFO - docopt == 0.6.1 19:11:50 INFO - functools32 == 3.2.3-2 19:11:50 INFO - jsonschema == 2.5.1 19:11:50 INFO - manifestparser == 1.1 19:11:50 INFO - mozInstall == 1.12 19:11:50 INFO - mozcrash == 0.17 19:11:50 INFO - mozdebug == 0.1 19:11:50 INFO - mozdevice == 0.48 19:11:50 INFO - mozfile == 1.2 19:11:50 INFO - mozhttpd == 0.7 19:11:50 INFO - mozinfo == 0.9 19:11:50 INFO - mozleak == 0.1 19:11:50 INFO - mozlog == 3.3 19:11:50 INFO - moznetwork == 0.27 19:11:50 INFO - mozprocess == 0.23 19:11:50 INFO - mozprofile == 0.28 19:11:50 INFO - mozrunner == 6.12 19:11:50 INFO - mozscreenshot == 0.1 19:11:50 INFO - mozsystemmonitor == 0.3 19:11:50 INFO - moztest == 0.7 19:11:50 INFO - mozversion == 1.4 19:11:50 INFO - psutil == 3.1.1 19:11:50 INFO - requests == 1.2.3 19:11:50 INFO - wsgiref == 0.1.2 19:11:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:50 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')]} 19:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:50 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')]} 19:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:50 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 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11:50 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 19:11:50 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 19:11:50 INFO - Using env: {'DISPLAY': ':0', 19:11:50 INFO - 'HOME': '/home/cltbld', 19:11:50 INFO - 'LANG': 'en_US.UTF-8', 19:11:50 INFO - 'LANGUAGE': 'en_US:en', 19:11:50 INFO - 'LOGNAME': 'cltbld', 19:11:50 INFO - 'MAIL': '/var/mail/cltbld', 19:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:50 INFO - 'MOZ_NO_REMOTE': '1', 19:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:50 INFO - 'NO_EM_RESTART': '1', 19:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:50 INFO - 'PWD': '/builds/slave/test', 19:11:50 INFO - 'SHELL': '/bin/bash', 19:11:50 INFO - 'SHLVL': '1', 19:11:50 INFO - 'TERM': 'linux', 19:11:50 INFO - 'TMOUT': '86400', 19:11:50 INFO - 'USER': 'cltbld', 19:11:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:50 INFO - '_': '/tools/buildbot/bin/python'} 19:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:50 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)) 19:11:50 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)) 19:11:50 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)) 19:11:50 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)) 19:11:50 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)) 19:11:50 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)) 19:11:50 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)) 19:11:50 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)) 19:11:50 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)) 19:11:50 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)) 19:11:50 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)) 19:11:50 INFO - Cleaning up... 19:11:50 INFO - Return code: 0 19:11:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11:50 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')]} 19:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:50 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')]} 19:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:50 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 0x123f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, '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': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', '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 19:11:50 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 19:11:50 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 19:11:50 INFO - Using env: {'DISPLAY': ':0', 19:11:50 INFO - 'HOME': '/home/cltbld', 19:11:50 INFO - 'LANG': 'en_US.UTF-8', 19:11:50 INFO - 'LANGUAGE': 'en_US:en', 19:11:50 INFO - 'LOGNAME': 'cltbld', 19:11:50 INFO - 'MAIL': '/var/mail/cltbld', 19:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:50 INFO - 'MOZ_NO_REMOTE': '1', 19:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:50 INFO - 'NO_EM_RESTART': '1', 19:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:50 INFO - 'PWD': '/builds/slave/test', 19:11:50 INFO - 'SHELL': '/bin/bash', 19:11:50 INFO - 'SHLVL': '1', 19:11:50 INFO - 'TERM': 'linux', 19:11:50 INFO - 'TMOUT': '86400', 19:11:50 INFO - 'USER': 'cltbld', 19:11:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:50 INFO - '_': '/tools/buildbot/bin/python'} 19:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:51 INFO - Cleaning up... 19:11:51 INFO - Return code: 0 19:11:51 INFO - Running post-action listener: _resource_record_post_action 19:11:51 INFO - Running post-action listener: _start_resource_monitoring 19:11:51 INFO - Starting resource monitoring. 19:11:51 INFO - [mozharness: 2016-07-27 02:11:51.092111Z] Finished create-virtualenv step (success) 19:11:51 INFO - [mozharness: 2016-07-27 02:11:51.092598Z] Running install step. 19:11:51 INFO - Running pre-action listener: _resource_record_pre_action 19:11:51 INFO - Running main action method: install 19:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:51 INFO - Reading from file tmpfile_stdout 19:11:51 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:51 INFO - Reading from file tmpfile_stdout 19:11:51 INFO - Output received: 19:11:51 INFO - Usage: mozinstall [options] installer 19:11:51 INFO - Options: 19:11:51 INFO - -h, --help show this help message and exit 19:11:51 INFO - -d DEST, --destination=DEST 19:11:51 INFO - Directory to install application into. [default: 19:11:51 INFO - "/builds/slave/test"] 19:11:51 INFO - --app=APP Application being installed. [default: firefox] 19:11:51 INFO - mkdir: /builds/slave/test/build/application 19:11:51 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'] 19:11:51 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 19:12:08 INFO - Reading from file tmpfile_stdout 19:12:08 INFO - Output received: 19:12:08 INFO - /builds/slave/test/build/application/firefox/firefox 19:12:08 INFO - Running post-action listener: _resource_record_post_action 19:12:08 INFO - [mozharness: 2016-07-27 02:12:08.660291Z] Finished install step (success) 19:12:08 INFO - [mozharness: 2016-07-27 02:12:08.660568Z] Running run-tests step. 19:12:08 INFO - Running pre-action listener: _resource_record_pre_action 19:12:08 INFO - Running main action method: run_tests 19:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:12:08 INFO - Python 2.7.3 19:12:08 INFO - Return code: 0 19:12:08 INFO - grabbing minidump binary from tooltool 19:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe3b0>, '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 0x14ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:12:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:12:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:12:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:12:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:12:08 INFO - Return code: 0 19:12:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:12:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:12:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:12:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:12:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 19:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 19:12:08 INFO - Using env: {'DISPLAY': ':0', 19:12:08 INFO - 'HOME': '/home/cltbld', 19:12:08 INFO - 'LANG': 'en_US.UTF-8', 19:12:08 INFO - 'LANGUAGE': 'en_US:en', 19:12:08 INFO - 'LOGNAME': 'cltbld', 19:12:08 INFO - 'MAIL': '/var/mail/cltbld', 19:12:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:12:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:08 INFO - 'MOZ_NO_REMOTE': '1', 19:12:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:08 INFO - 'NO_EM_RESTART': '1', 19:12:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:08 INFO - 'PWD': '/builds/slave/test', 19:12:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:12:08 INFO - 'SHELL': '/bin/bash', 19:12:08 INFO - 'SHLVL': '1', 19:12:08 INFO - 'TERM': 'linux', 19:12:08 INFO - 'TMOUT': '86400', 19:12:08 INFO - 'USER': 'cltbld', 19:12:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182', 19:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:08 INFO - '_': '/tools/buildbot/bin/python'} 19:12:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 19:12:08 INFO - mozversion application_buildid: 20160726163046 19:12:08 INFO - mozversion application_changeset: c8261ef537e0591497988faba7e8b3da5bdb65f8 19:12:08 INFO - mozversion application_display_name: Nightly 19:12:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:12:08 INFO - mozversion application_name: Firefox 19:12:08 INFO - mozversion application_remotingname: firefox 19:12:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:12:08 INFO - mozversion application_vendor: Mozilla 19:12:08 INFO - mozversion application_version: 50.0a1 19:12:08 INFO - mozversion platform_buildid: 20160726163046 19:12:08 INFO - mozversion platform_changeset: c8261ef537e0591497988faba7e8b3da5bdb65f8 19:12:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:12:08 INFO - mozversion platform_version: 50.0a1 19:12:08 INFO - using testdate: 1469585528 19:12:08 INFO - actual date: 1469585528 19:12:08 INFO - starting webserver on 'localhost:57482' 19:12:08 INFO - SUITE-START | Running 2 tests 19:12:08 INFO - TEST-START | dromaeo_css 19:12:08 INFO - operating with platform_type : linux_ 19:12:08 INFO - Initialising browser for dromaeo_css test... 19:12:08 INFO - TEST-INFO | started process 22035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLhZFY1/profile http://localhost:57482/getInfo.html) 19:12:12 INFO - PROCESS | 22035 | JavaScript error: , line 0: uncaught exception: undefined 19:12:13 INFO - PROCESS | 22035 | __metrics Screen width/height:1600/1200 19:12:13 INFO - PROCESS | 22035 | colorDepth:24 19:12:13 INFO - PROCESS | 22035 | Browser inner width/height: 1024/697 19:12:13 INFO - PROCESS | 22035 | __metrics 19:12:14 INFO - PROCESS | 22035 | 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" 19:12:14 INFO - PROCESS | 22035 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:12:15 INFO - TEST-INFO | 22035: exit 0 19:12:15 INFO - Browser initialized. 19:12:15 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:15 INFO - TEST-INFO | started process 22114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLhZFY1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:26 INFO - PROCESS | 22114 | RSS: Main: 157859840 19:12:26 INFO - PROCESS | 22114 | 19:13:18 INFO - PROCESS | 22114 | 1469585598409 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] 19:15:26 INFO - PROCESS | 22114 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57482/tests/dromaeo/cssquery-ext.html) 19:15:27 INFO - PROCESS | 22114 | RSS: Main: 266022912 19:15:27 INFO - PROCESS | 22114 | 19:18:29 INFO - PROCESS | 22114 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-ext.html (next: http://localhost:57482/tests/dromaeo/cssquery-jquery.html) 19:18:30 INFO - PROCESS | 22114 | RSS: Main: 240009216 19:18:30 INFO - PROCESS | 22114 | 19:21:32 INFO - PROCESS | 22114 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57482/tests/dromaeo/cssquery-mootools.html) 19:21:32 INFO - PROCESS | 22114 | RSS: Main: 185856000 19:21:32 INFO - PROCESS | 22114 | 19:24:34 INFO - PROCESS | 22114 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57482/tests/dromaeo/cssquery-prototype.html) 19:24:35 INFO - PROCESS | 22114 | RSS: Main: 221458432 19:24:35 INFO - PROCESS | 22114 | 19:27:38 INFO - PROCESS | 22114 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57482/tests/dromaeo/cssquery-yui.html) 19:27:38 INFO - PROCESS | 22114 | RSS: Main: 182841344 19:27:38 INFO - PROCESS | 22114 | 19:30:41 INFO - PROCESS | 22114 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-yui.html (next: http://localhost:57482/tests/dromaeo/cssquery-dojo.html) 19:30:41 INFO - PROCESS | 22114 | RSS: Main: 279138304 19:30:41 INFO - PROCESS | 22114 | 19:30:41 INFO - PROCESS | 22114 | __start_tp_report 19:30:41 INFO - PROCESS | 22114 | _x_x_mozilla_page_load 19:30:41 INFO - PROCESS | 22114 | _x_x_mozilla_page_load_details 19:30:41 INFO - PROCESS | 22114 | |i|pagename|runs| 19:30:41 INFO - PROCESS | 22114 | |0;dojo.html;2991.5213565829463;3042.6348838139425;3064.6475655299632;3066.677998810125;3069.8158110513373;5196.116660167771;5260.289860868782;5326.147816349385;5411.458854114591;5432.755526001334;5342.679439233649;5373.220882971967;5378.1663842104535;5405.783768649249;5440.863978400542;4811.0618429406195;4862.63530235232;4894.290327902452;4898.02039592083;5036.194208926572;4926.162552366106;4974.651774375795;4978.477259887714;4986.401631804189;4998.350214472113;4767.404074490689;4821.083994041121;4823.155947709172;4837.32277481153;4929.8028078876805;4820.758962051918;4822.228443449031;4830.830920917786;4968.925466118011;4972.477889821553;4810;4835.371401717789;4844.079624871263;4865.245886887538;4890;5208.244804503326;5252.527272545489;5360.383555891083;5378.865528361822;5412;5673.404292549306;5761.0494268445655;5763.596548241625;5764.135379693038;5769.971150144264;5721.971390143064;5743.1959525666025;5778.797742079007;5787.50806181475;5791.623544469596;5182;5303.708296043755;5380.569554435636;5401.972990135064;5403.864903377408;5949.732262048218;5965.045592705146;5968.134620480093;5970.164177015221;5974.402559744078;5734.082546792493;5739.426057394311;5742.052561327418;5744.569157313134;5745.109508026263;5524;5623.831285061455;5684.857878553069;5806;5814.156947242626;5716.456936591017;5720.628159169641;5724.341700704389;5757.251557297608;5770.422957704196;5679.290088738908;5731.713414329267;5734.627249228787;5740.454656807597;5741.62679425836;4253.085586598896;4292.098659281523;4305.5048669402795;4367;4384.298512238027;3885.300645883768;3900.6684431823046;3931.488906442144;3948.7828169450954;3979.6816254699556;5425.131978883439;5434.3207099112615;5437.483439073281;5438.211459338374;5499.285092937893;5613.382527921925;5701.971490142523;5814.709264536757;5817.301923769175;5878.911816322759;5361.276227709287;5448.400675925645;5450.645708029045;5497.972510137423;5500.257465242221;4839.758012099381;4848.248521479177;4849.927251091236;4855.393075865517;4890.853274401702;5729.541636669056;5836.2412886325355;5947.702614869239;5962.195103661037;5964.642121472725;5728.169415434655;5760.567957403127;5772.105323674838;5785.82642520725;5819.039858423482;5923.911141332969;5940.049592065422;5952.76188952437;5953.613015154001;5956.315023772322;5507.586930980273;5525.557955363481;5620.775168993195;5671.801486947937;5685.0335442973965;5613.24221230145;5684.374718781013;5707.0583353747825;5734.3692193857805;5747.396523364986;5550.08423610116;5570.164475328733;5581.023320918905;5581.10702287632;5586.217929489793;5435.809746658848;5551.306086739158;5560.694161821139;5561.527270181918;5565.053940829987;5512.614117011771;5594.804181853616;5597.412271711411;5606.103023516381;5636.492715655447;5633.8309850704545;5645.802396916089;5691.8861622768145;5696.316442026983;5738.483536481736;5380.166074258496;5450.400455949922;5556.527695145958;5567.47109024642;5569.805056822992 19:30:41 INFO - PROCESS | 22114 | |1;ext.html;570.4580648384036;594.8661551150991;608.9817305480834;615.3108518459323;640.4396153365805;30247.395052098946;43267.567324326745;44372.112557748864;44400.33399499002;44453.33320000194;46703.76648116763;47231.76384118075;47246.52753472464;47264;47287.29069063967;8901.821963560726;9044.728658140233;9052.8642070369;9053;9054.4114632549;8943.552822358855;9027;9033.548322583878;9035.141661542142;9038.502882341469;9039.864402033974;9075.54622268884;9081.18269355758;9089.454632722025;9096.454212747256;9053.366264361497;9069.59186836594;9075.228605568534;9094.727158185233;9101.635934562642;8827.293816494664;8896.065913079163;8909.955450222773;8917.598708058153;8919.331050171199;43325.13349732988;43533.12933741308;43537.78231108856;43592.3461148083;43706.34440483395;3568.125809176768;3620.7284453665816;3671.7429779915415;3678.503402040717;3876.2635099331037;32841.83579082113;33086;33646;33907;34389.656103438894;3915.4126880968083;3919.8236079376497;4067.6542493888055;4075.1034772350035;4123.113530590937;353550;355731;356719;356995;357811;33724.325513489595;58794.41205587975;59175;59192;59292.703536482906;33840.830795846356;36028.27943441169;36037.459438108446;36198.45702314467;36267;15132.848671513364;15340.156291403857;15344.386224551115;15349.07905525672;15351.385944562317;11877.168598198215;11878.762424751456;11882.940585297018;11893.702657433634;11929.522819087313;8224.300934420522;8274.379421543408;8321.583920803936;8340.415321088974;8374.032102455918;3169.4453470643007;3176.8411579420936;3206.823624700664;3211.3595853991224;3214.421404147229;942.34036174678;997.7505623594102;1028.18773169197;1031.9484025798681;1036.439829186746;32146.839265803523;32242.699007893945;32452.188695282333;32580.674193258237;32808.50787238193;848.4442690038035;1004.3120462483076;1020.1787561013456;1022.2435397805571;1137.2380505061628;17094.743578846326;17103.14484275781;17234.91382543079;17239.913800430917;17257.137143142794;547220;548704;550584;552882;554513;60199.699001505585;60631.393686062576;60678.39321606728;60747.392526075055;60966.69516652388;1197.976040479203;1293.3985696651102;1298.363801737142;1357.2060344698461;1357.755603991291;32732.34535309233;33857.83071084629;34351.65648343584;34370.82814585911;34533.82733086318;49995;50841.23738144005;50854.237186441496;50964.74517627388;50983.490165099356;396171;397579;398437;398766;654899;45025;45279.320810187215;45607;45854.54145458636;45932;49494.50505494899;49968.25047624216;50234.24648630201;50901.49098509116;51265.23102153545;41898.79050604728;42571.14857702891;42595.3610695846;42752.57247427486;44550;41539.37690934578;42313.57686423096;43627.345589815544;44081.338779917685;44714.77642611766;41102.38346424866;41807.581924181584;42011;42520.5747942529;42902.35646465243;35741.642583574874;38087.52431092081;38280.42579361256;38677.419838703005;38733.418998715606;28873.278168045967;28924.16050297624;29019.56470652984;29080.272993174494;29101.85449072826 19:30:41 INFO - PROCESS | 22114 | |2;jquery.html;359.1524003352089;367.62502247707323;377.886634009797;381.23181788695774;385.87651951375574;14475.782863257047;18602;18943.147558359873;19081.332153374635;19817.10823012964;18185.727214091767;19134.904325478354;19602.215911363564;19752.407427777154;19769.209231630753;5541.861453463665;5741.598088133832;5746.770129194848;5747.137929310595;5747.597668163209;5454.836354909359;5649;5666.263385759866;5668.518175955049;5675.914861277084;5645.745941432645;5647.463490968352;5652.06740887753;5656.91514627281;5658.547316214693;5451.591130665196;5462.0987537056135;5483.396826349099;5492.835214943558;5634.32388113427;4879.609631229493;5027.195648696227;5029.597632189416;5029.974850125763;5032.370953630796;23446.64830027551;23464.530709385715;23602.93786779582;23746.40633984147;23794.76205237943;2400.9039638414442;2639.815212935095;3074.4158609864053;3108.2384815720293;3189.346184032268;9280.489573073479;9994.400335979864;10131.493425328705;14070.08544444618;14938.178400187986;1878.4083013850593;1893.9621207575772;1895.2324308655018;1933.4393026022437;1963.0577322884953;79750.60124699397;79884;80620.59689701514;82154;82756.58621706913;10309.53607087683;10440.68677939663;10496.790064198825;10625;10665.36007839532;14879.10725356482;14893.47872824446;14916.850831491547;14943.626409339853;14959.850401495845;7747.883781743279;7927.246911543394;7973.880391794128;8132.593370331578;8217.630206640715;8018.839623207503;8047.195280471906;8246.8350632987;8272.669093236324;8280.337572994267;4500.729956202638;4576.97711511447;4590.42619672541;4595.1728688835665;4632.420947381577;1867.2810967777502;1876.981230187708;1949.853760967933;1953.6874100144194;1974.5261137326938;846.0608724316004;882.1701186006562;957.5020989085637;962.7304354780673;1088.6625146204701;18648.81351186498;19490.805091949183;19500.902495487433;19591.412257632295;19957;966.6858271061792;1004.3170643962176;1004.9397036177853;1009.1825621246813;1010.686687126993;9598.712038638852;10745.24783265164;11208.103351731841;11379.54481820718;11796.52813887452;458107;458204;464628;497465;503710;92841.5357923206;93226;94174.52912735392;94194.52902735579;94650.52674736582;994.2642444591095;1032.896710328976;1051.9684409467882;1057.471264367816;1058.2169194795795;16538;16542.66914661724;17512;17572;17943.102844857967;33517.83241083779;43002;43346;44124.33813492736;44390.556094438645;58231;58309.4169058321;59353;60019.699901500215;60577.39422605718;7412.8146796328365;7545.396368290414;7555.962220188864;7570.886436703344;7814.804629884298;11487.827682584935;12181.33002684861;12198.268103913439;12504.874951250371;12555.309457979534;10263.948680256552;10887.564497420015;11008.834867477155;11035.22753407286;11176.16178786578;10346.534405951901;10617.628383006559;10713.357198567799;11113.277636953571;11187.608433704781;10303.124234439856;10682.252242342962;10801;10945.671629851116;11024.44877756125;7498.812529686801;7624.313811756969;7738;7755.418343624138;7757.185495523115;7972.083210430875;10149.188064954933;10204.285700000928;10476.0571548561;10584.153267738717 19:30:41 INFO - PROCESS | 22114 | |3;mootools.html;1333.146786056923;1443.1413309081097;1510.773383992401;1616.8221495635478;1753.850922671572;8559.272461840743;8891.288696904248;8921.732348029562;9123.817523649539;9130.22393096586;8950.552472376388;9043.457392556435;9049.2308153807;9049.276057915367;9054.04932482088;2351.2123438648073;2371.1345358944036;2373.537160253751;2376.3583832365252;2378.0368950575044;2318.48993221491;2358.5165041166606;2414.7343792182846;2418.262429958862;2418.806495480357;2313.791758741713;2335.1126571902737;2350.635651474024;2362.55111528809;2369.834111612188;2209.5359974405314;2222.5999320122373;2253.8873056347197;2254.7407048189502;2258.424101854025;2308.7806658367426;2330.860148391102;2332.5801355755957;2334.661474086248;2338.497223097025;8747.912520874774;9004.594793234255;9030.142136497023;9049.2308153807;9067.319951003636;5158.40678321994;5278.683279003272;5285.947140528584;5289.391719952217;5296.470352964711;3411.6588341165934;3437.106352348407;3479.599846017715;3491.0748651607346;3493.5109084727906;1176.705823544114;1182.8521434820648;1187.7327601289728;1216.8296438498617;1218.8293638890561;12115.212511186834;12202.572909948198;12214.083943704169;12230.877691223151;12257.325847078408;4323.718958267703;4453.153900758845;4591.977040114845;4592.380028696083;4608.216603177468;9632.229421646252;9639.228861691048;9658.855117173249;9660.565274562521;9666.806663866684;5200.869978250574;5207;5212.374515058217;5214.8957020860125;5233.790648374099;4240.681948853849;4717.457492388419;4828.8792780180775;4869.586085182728;4908.092002979389;3786.2427514497213;3861.9227615447535;3932.2528719543197;3956.149427873021;3979.6816254700134;1139.800534906388;1169.0647482014353;1171.262104873924;1182.2315494928366;1183.083110589283;804.2681160144358;838.9119142490073;880.1374652840252;924.2051835421532;948.0519480519481;5897.469227769521;5915.260592425947;5915.792947246826;6012.158297838306;6169.629822210682;979.5494072726625;983.2576404814463;991.667791289926;1000.2398177385094;1017.0592202212923;3949.940750888739;3961.485006949078;4135.503739551213;4278.465191851019;4284.121755040209;11080.337949307668;11188.552457901755;11355.772884542263;11355.97796198346;11357.716057098638;11266.605668801552;11291.322520648788;11303.717407064889;11398.658040258806;11429.085673146128;8057.234562716532;8427.578621069044;8466.06873243955;8490.787730306793;8514.957425212835;5940.584159108821;5954.136650185786;6033.42682445167;6056.818295451144;6198.969005154945;10196.38821670702;10246.897531024893;10259.897401025893;10400.635977740743;10412.47937603132;10610.628627997983;10646.361218326925;10651.57393704243;10679.733006674895;10680.359178449318;7019.5788252705;7831.921680783119;7884;7918.841623167619;8099.190080991853;8795.648174072965;9001.774955626162;9004.099590040943;9005.459672419676;9010.05394433575;7865.095514015733;7918.485298455582;8077.353811694933;8222.917770822454;8274.917250827655;7624.390048796194;7768.53388796674;7824.21757824213;7829.530228186327;7843.6862525498345;7158.534695244793;7291.927080729125;7294.416446684359;7295.7081716732855;7296.562206267641;5084.949150508448;5105.693658380509;5108.259302401206;5192.922106168335;5229.058769421541;5247.790088396574;5250.632455728062;5295.311609490742;5321.973390133179;5541.556675465872 19:30:41 INFO - PROCESS | 22114 | |4;prototype.html;313.16072924562167;320.43603258265455;324.5278120334913;327.98979144235756;328.36461447099856;5357.598180136486;5358.517733403998;5399.190121481774;5402.810901618444;5410.621256512046;5031.371078615173;5095.675124467637;5147.279380886679;5156.097682905495;5285.762140703668;4053.391991201314;4078.0620457294767;4162.646175075122;4164.354525048622;4197.7901104944785;4127.236461254663;4147.440095587087;4154.709170358076;4174.91650166998;4189.560096189886;4054.513458384998;4077;4114.979425102871;4143.689223308249;4168.937465937998;4111.342185250375;4129.690273229489;4135.8966025849295;4140.91718165635;4166.500019997589;3681.7975011374365;3704.1665625234104;3707.7404581679293;3710;3713.9415266649144;5110.182370820651;5220.086484865172;5225.033368826779;5225.477452254744;5228.163493840967;4685.367475390847;4707.929381059287;4714.434267887876;4733.786979585927;4756.3816703828625;5522;5534.557235421156;5541.362743284493;5566.582506312043;5573.916391254134;3956.7823769692654;4019.3970904364287;4048.7975601220114;4070.1859628074208;4071;5657.688827114548;5671.404502527258;5691.402402747734;5724.713764311809;5732.713364331767;4094.7747873867224;4108.67130629549;4118.052847845012;4152.792360381969;4161.396597493346;4084.1831633673382;4199.895002624898;4215.641670458045;4228.556001619847;4235.639970602471;4733.461624971829;4748.4539277982785;4759.666823322404;4768.856934291907;4799.3760811095035;5528.44715528444;5575.749091290902;5576.832695019156;5590.5248053915875;5623.381428042912;1336.939837707286;1421.3532842556613;1456.7450696128135;1461.7003514279547;1465.6116129225763;938.7277689470113;987.2200961240683;996.8305388083899;1000.4147573669339;1008.4503945349802;5274.815381461707;5275.868103297372;5282.2340760589495;5284.313039304866;5292.947070529245;5552.52803511706;5619.887602247933;5680.579855036241;5696.971515142398;5697.544196464273;5276.445973172838;5293.232481290268;5296.179092240709;5310.867228319323;5314.867128321745;2970.0495841331;2999.6250468691414;3001.519756838939;3001.639803223627;3010.5484177373132;5586.301712285965;5754.5971781975695;5795.39148389413;5803;5841.474267315962;5720.998825205573;5735.827925162252;5746.9425305747245;5759;5759.8560035999435;5739.713014349266;5779.508741756914;5787.565932555075;5795.710214489259;5802.65184088956;5413.511284396823;5664.677482232265;5683.204351390891;5697.173909783141;5709.25779648643;5650.378458369658;5663.9716801415725;5673.9432605675065;5682.488576028178;5717.599768016199;5673.404292549223;5853.853653658693;5874.206982057368;5888.381719919346;5935;4077.8164982575263;4093.7339072960162;4095.4061661058386;4112.581159499968;4148.522919864134;5826.854328641818;5828.358880523224;5828.388019258086;5846.50914016923;5851.093080572518;5464.3442786865835;5605.5795815313195;5616.241807355955;5619.623192317908;5687.374388817309;5609.887802244014;5617.634853734494;5617.775288988558;5618.325800903917;5689.573282003949;5325.204267759457;5387.622866399472;5459.508644222039;5557.888422315634;5597.272354593877;5437.646552974044;5557.277553917965;5646.576506762091;5646.757713303066;5652.6043176978865;5491.75287112073;5492.340919089735;5513.641613295123;5514.724263786875;5521.751521181637 19:30:41 INFO - PROCESS | 22114 | |5;yui.html;741.3624283116523;745.8135466133467;768.2164192523626;772;886.0209468537266;14711.632209194775;15204.046947793571;15525.146116963562;15537.53387398377;15562.455314063996;14465.710685786278;14492.710145797078;14564;14575.19836408997;14580.489682861102;650.4601181019766;792.9286364227219;795.6618437164211;796.6056801883047;801.0947629179034;793.2028311546916;801.4069588504523;801.5791709352608;826.5660528222671;828.0849661124461;863.6933888469565;866.1814585216972;866.9783255418633;867.0072766682146;867.4968518259394;673.1249375811475;856.3620103023287;856.6016802186982;857.5197889182078;858.1289990659454;606.9075663805133;610.8808782287456;611.3763960760044;622.3682961793783;623.8409205652575;13549.458021679122;13585.116967397087;13587.456501739918;13593.59219223425;13598.32008399576;14138.363773630108;14174.929125354307;14838.629034274121;14920.70158596822;14924;12557.56048538306;12587.748245035047;12821;12852.55016074433;12868;4405.9118817623785;4481.481113616252;4487.663425243087;4491.101779644085;4690.366800481926;77333;77421;78223.60888195579;82580.17419825785;82711.58644206861;10855.67432977012;11001.17491188164;11145;11445.54217831294;11566.149416093385;21678.674819877713;21951.341459756233;21960.780392196193;21973.890130549244;22002.119915203533;8441.788955276168;8464.915350846535;8712.738617841474;8798.604062817061;8881.689140880038;4611.308303754397;4810.2063159578975;4847.418309802776;4885.5358740919555;5118.155504341742;3517.296540691872;3569.036360182736;3613.1870329175727;3617.276544691072;3618.5115009473384;595.7527626035147;597.8116893178722;603.8399824046631;612.8192183305936;622.4429135923323;555.4723013137454;593.2525018476664;661.2990230355838;662.4534758823893;681.8977153426927;8985.415947963362;9476.363999400906;9515.78195809334;10023.849642255373;10064.194864410829;522.4618642797924;577.4254616656453;583.4253260538367;584.9502792262621;589.539403700282;4810.254410566298;4935.975320123448;4938.123513065012;4949.282354058641;4950.851474455772;65648;99131;110142.44928775304;110577;114057;60495.69752151299;77690;95409.52295238618;96342;100930;87421.56289218513;88445;89714.55142724245;90967.09032909587;92853;9170.945341285838;9264.72205833826;9435.716928492157;9520;9533.570989305359;42239.366409503265;49586.25620615766;49592.75203623959;51379.48620513747;54501;74111;76992.6150369267;77720.61139694265;78359.37809860075;79368;11421.828672569753;11445.569303837021;11731.00286475659;11885.22746021506;12099.911008009321;12826.422810973716;12873.935630321788;13026.739465210832;13545.661358466117;13551.661208469473;12078;12297.385130743249;12340.568080117153;12441;12454.377281136089;11586.304821710724;12042.819357709817;12141.082068325384;12467.127301088836;12713.93643031816;11742.119341049627;12153.149279550347;12229.633111006684;12270.141090123605;12703.618891433272;9946.303758736818;10048.246381521269;10344.172466202535;10369.688909332732;10423.218258630784;9969.35199212049;10588.523516441932;10667.466626668791;10671.46642667879;10775.676729698122 19:30:41 INFO - PROCESS | 22114 | __end_tp_report 19:30:41 INFO - PROCESS | 22114 | __start_cc_report 19:30:41 INFO - PROCESS | 22114 | _x_x_mozilla_cycle_collect,935 19:30:41 INFO - PROCESS | 22114 | __end_cc_report 19:30:41 INFO - PROCESS | 22114 | __startTimestamp1469586641971__endTimestamp 19:30:41 INFO - PROCESS | 22114 | 19:30:41 INFO - PROCESS | 22114 | ------- Summary: start ------- 19:30:41 INFO - PROCESS | 22114 | Number of tests: 6 19:30:41 INFO - PROCESS | 22114 | 19:30:41 INFO - PROCESS | 22114 | [#0] dojo.html Cycles:165 Average:5326.98 Median:5550.08 stddev:618.08 (11.1%) stddev-sans-first:592.20 19:30:41 INFO - PROCESS | 22114 | Values: 2991.5 3042.6 3064.6 3066.7 3069.8 5196.1 5260.3 5326.1 5411.5 5432.8 5342.7 5373.2 5378.2 5405.8 5440.9 4811.1 4862.6 4894.3 4898.0 5036.2 4926.2 4974.7 4978.5 4986.4 4998.4 4767.4 4821.1 4823.2 4837.3 4929.8 4820.8 4822.2 4830.8 4968.9 4972.5 4810.0 4835.4 4844.1 4865.2 4890.0 5208.2 5252.5 5360.4 5378.9 5412.0 5673.4 5761.0 5763.6 5764.1 5770.0 5722.0 5743.2 5778.8 5787.5 5791.6 5182.0 5303.7 5380.6 5402.0 5403.9 5949.7 5965.0 5968.1 5970.2 5974.4 5734.1 5739.4 5742.1 5744.6 5745.1 5524.0 5623.8 5684.9 5806.0 5814.2 5716.5 5720.6 5724.3 5757.3 5770.4 5679.3 5731.7 5734.6 5740.5 5741.6 4253.1 4292.1 4305.5 4367.0 4384.3 3885.3 3900.7 3931.5 3948.8 3979.7 5425.1 5434.3 5437.5 5438.2 5499.3 5613.4 5702.0 5814.7 5817.3 5878.9 5361.3 5448.4 5450.6 5498.0 5500.3 4839.8 4848.2 4849.9 4855.4 4890.9 5729.5 5836.2 5947.7 5962.2 5964.6 5728.2 5760.6 5772.1 5785.8 5819.0 5923.9 5940.0 5952.8 5953.6 5956.3 5507.6 5525.6 5620.8 5671.8 5685.0 5613.2 5684.4 5707.1 5734.4 5747.4 5550.1 5570.2 5581.0 5581.1 5586.2 5435.8 5551.3 5560.7 5561.5 5565.1 5512.6 5594.8 5597.4 5606.1 5636.5 5633.8 5645.8 5691.9 5696.3 5738.5 5380.2 5450.4 5556.5 5567.5 5569.8 19:30:41 INFO - PROCESS | 22114 | 19:30:41 INFO - PROCESS | 22114 | [#1] ext.html Cycles:180 Average:60911.86 Median:42583.25 stddev:123076.32 (289.0%) stddev-sans-first:123338.20 19:30:41 INFO - PROCESS | 22114 | Values: 570.5 594.9 609.0 615.3 640.4 30247.4 43267.6 44372.1 44400.3 44453.3 46703.8 47231.8 47246.5 47264.0 47287.3 8901.8 9044.7 9052.9 9053.0 9054.4 8943.6 9027.0 9033.5 9035.1 9038.5 9039.9 9075.5 9081.2 9089.5 9096.5 9053.4 9069.6 9075.2 9094.7 9101.6 8827.3 8896.1 8910.0 8917.6 8919.3 43325.1 43533.1 43537.8 43592.3 43706.3 3568.1 3620.7 3671.7 3678.5 3876.3 32841.8 33086.0 33646.0 33907.0 34389.7 3915.4 3919.8 4067.7 4075.1 4123.1 353550.0 355731.0 356719.0 356995.0 357811.0 33724.3 58794.4 59175.0 59192.0 59292.7 33840.8 36028.3 36037.5 36198.5 36267.0 15132.8 15340.2 15344.4 15349.1 15351.4 11877.2 11878.8 11882.9 11893.7 11929.5 8224.3 8274.4 8321.6 8340.4 8374.0 3169.4 3176.8 3206.8 3211.4 3214.4 942.3 997.8 1028.2 1031.9 1036.4 32146.8 32242.7 32452.2 32580.7 32808.5 848.4 1004.3 1020.2 1022.2 1137.2 17094.7 17103.1 17234.9 17239.9 17257.1 547220.0 548704.0 550584.0 552882.0 554513.0 60199.7 60631.4 60678.4 60747.4 60966.7 1198.0 1293.4 1298.4 1357.2 1357.8 32732.3 33857.8 34351.7 34370.8 34533.8 49995.0 50841.2 50854.2 50964.7 50983.5 396171.0 397579.0 398437.0 398766.0 654899.0 45025.0 45279.3 45607.0 45854.5 45932.0 49494.5 49968.3 50234.2 50901.5 51265.2 41898.8 42571.1 42595.4 42752.6 44550.0 41539.4 42313.6 43627.3 44081.3 44714.8 41102.4 41807.6 42011.0 42520.6 42902.4 35741.6 38087.5 38280.4 38677.4 38733.4 28873.3 28924.2 29019.6 29080.3 29101.9 19:30:41 INFO - PROCESS | 22114 | 19:30:41 INFO - PROCESS | 22114 | [#2] jquery.html Cycles:180 Average:28502.80 Median:16938.49 stddev:78807.87 (465.3%) stddev-sans-first:79000.61 19:30:41 INFO - PROCESS | 22114 | Values: 359.2 367.6 377.9 381.2 385.9 14475.8 18602.0 18943.1 19081.3 19817.1 18185.7 19134.9 19602.2 19752.4 19769.2 5541.9 5741.6 5746.8 5747.1 5747.6 5454.8 5649.0 5666.3 5668.5 5675.9 5645.7 5647.5 5652.1 5656.9 5658.5 5451.6 5462.1 5483.4 5492.8 5634.3 4879.6 5027.2 5029.6 5030.0 5032.4 23446.6 23464.5 23602.9 23746.4 23794.8 2400.9 2639.8 3074.4 3108.2 3189.3 9280.5 9994.4 10131.5 14070.1 14938.2 1878.4 1894.0 1895.2 1933.4 1963.1 79750.6 79884.0 80620.6 82154.0 82756.6 10309.5 10440.7 10496.8 10625.0 10665.4 14879.1 14893.5 14916.9 14943.6 14959.9 7747.9 7927.2 7973.9 8132.6 8217.6 8018.8 8047.2 8246.8 8272.7 8280.3 4500.7 4577.0 4590.4 4595.2 4632.4 1867.3 1877.0 1949.9 1953.7 1974.5 846.1 882.2 957.5 962.7 1088.7 18648.8 19490.8 19500.9 19591.4 19957.0 966.7 1004.3 1004.9 1009.2 1010.7 9598.7 10745.2 11208.1 11379.5 11796.5 458107.0 458204.0 464628.0 497465.0 503710.0 92841.5 93226.0 94174.5 94194.5 94650.5 994.3 1032.9 1052.0 1057.5 1058.2 16538.0 16542.7 17512.0 17572.0 17943.1 33517.8 43002.0 43346.0 44124.3 44390.6 58231.0 58309.4 59353.0 60019.7 60577.4 7412.8 7545.4 7556.0 7570.9 7814.8 11487.8 12181.3 12198.3 12504.9 12555.3 10263.9 10887.6 11008.8 11035.2 11176.2 10346.5 10617.6 10713.4 11113.3 11187.6 10303.1 10682.3 10801.0 10945.7 11024.4 7498.8 7624.3 7738.0 7755.4 7757.2 7972.1 10149.2 10204.3 10476.1 10584.2 19:30:41 INFO - PROCESS | 22114 | 19:30:41 INFO - PROCESS | 22114 | [#3] mootools.html Cycles:180 Average:5880.60 Median:4888.84 stddev:3371.17 (69.0%) stddev-sans-first:3363.30 19:30:41 INFO - PROCESS | 22114 | Values: 1333.1 1443.1 1510.8 1616.8 1753.9 8559.3 8891.3 8921.7 9123.8 9130.2 8950.6 9043.5 9049.2 9049.3 9054.0 2351.2 2371.1 2373.5 2376.4 2378.0 2318.5 2358.5 2414.7 2418.3 2418.8 2313.8 2335.1 2350.6 2362.6 2369.8 2209.5 2222.6 2253.9 2254.7 2258.4 2308.8 2330.9 2332.6 2334.7 2338.5 8747.9 9004.6 9030.1 9049.2 9067.3 5158.4 5278.7 5285.9 5289.4 5296.5 3411.7 3437.1 3479.6 3491.1 3493.5 1176.7 1182.9 1187.7 1216.8 1218.8 12115.2 12202.6 12214.1 12230.9 12257.3 4323.7 4453.2 4592.0 4592.4 4608.2 9632.2 9639.2 9658.9 9660.6 9666.8 5200.9 5207.0 5212.4 5214.9 5233.8 4240.7 4717.5 4828.9 4869.6 4908.1 3786.2 3861.9 3932.3 3956.1 3979.7 1139.8 1169.1 1171.3 1182.2 1183.1 804.3 838.9 880.1 924.2 948.1 5897.5 5915.3 5915.8 6012.2 6169.6 979.5 983.3 991.7 1000.2 1017.1 3949.9 3961.5 4135.5 4278.5 4284.1 11080.3 11188.6 11355.8 11356.0 11357.7 11266.6 11291.3 11303.7 11398.7 11429.1 8057.2 8427.6 8466.1 8490.8 8515.0 5940.6 5954.1 6033.4 6056.8 6199.0 10196.4 10246.9 10259.9 10400.6 10412.5 10610.6 10646.4 10651.6 10679.7 10680.4 7019.6 7831.9 7884.0 7918.8 8099.2 8795.6 9001.8 9004.1 9005.5 9010.1 7865.1 7918.5 8077.4 8222.9 8274.9 7624.4 7768.5 7824.2 7829.5 7843.7 7158.5 7291.9 7294.4 7295.7 7296.6 5084.9 5105.7 5108.3 5192.9 5229.1 5247.8 5250.6 5295.3 5322.0 5541.6 19:30:41 INFO - PROCESS | 22114 | 19:30:41 INFO - PROCESS | 22114 | [#4] prototype.html Cycles:180 Average:4687.88 Median:5312.87 stddev:1365.96 (25.7%) stddev-sans-first:1329.74 19:30:41 INFO - PROCESS | 22114 | Values: 313.2 320.4 324.5 328.0 328.4 5357.6 5358.5 5399.2 5402.8 5410.6 5031.4 5095.7 5147.3 5156.1 5285.8 4053.4 4078.1 4162.6 4164.4 4197.8 4127.2 4147.4 4154.7 4174.9 4189.6 4054.5 4077.0 4115.0 4143.7 4168.9 4111.3 4129.7 4135.9 4140.9 4166.5 3681.8 3704.2 3707.7 3710.0 3713.9 5110.2 5220.1 5225.0 5225.5 5228.2 4685.4 4707.9 4714.4 4733.8 4756.4 5522.0 5534.6 5541.4 5566.6 5573.9 3956.8 4019.4 4048.8 4070.2 4071.0 5657.7 5671.4 5691.4 5724.7 5732.7 4094.8 4108.7 4118.1 4152.8 4161.4 4084.2 4199.9 4215.6 4228.6 4235.6 4733.5 4748.5 4759.7 4768.9 4799.4 5528.4 5575.7 5576.8 5590.5 5623.4 1336.9 1421.4 1456.7 1461.7 1465.6 938.7 987.2 996.8 1000.4 1008.5 5274.8 5275.9 5282.2 5284.3 5292.9 5552.5 5619.9 5680.6 5697.0 5697.5 5276.4 5293.2 5296.2 5310.9 5314.9 2970.0 2999.6 3001.5 3001.6 3010.5 5586.3 5754.6 5795.4 5803.0 5841.5 5721.0 5735.8 5746.9 5759.0 5759.9 5739.7 5779.5 5787.6 5795.7 5802.7 5413.5 5664.7 5683.2 5697.2 5709.3 5650.4 5664.0 5673.9 5682.5 5717.6 5673.4 5853.9 5874.2 5888.4 5935.0 4077.8 4093.7 4095.4 4112.6 4148.5 5826.9 5828.4 5828.4 5846.5 5851.1 5464.3 5605.6 5616.2 5619.6 5687.4 5609.9 5617.6 5617.8 5618.3 5689.6 5325.2 5387.6 5459.5 5557.9 5597.3 5437.6 5557.3 5646.6 5646.8 5652.6 5491.8 5492.3 5513.6 5514.7 5521.8 19:30:41 INFO - PROCESS | 22114 | 19:30:41 INFO - PROCESS | 22114 | [#5] yui.html Cycles:180 Average:20017.82 Median:4937.05 stddev:28624.68 (579.8%) stddev-sans-first:28668.39 19:30:41 INFO - PROCESS | 22114 | Values: 741.4 745.8 768.2 772.0 886.0 14711.6 15204.0 15525.1 15537.5 15562.5 14465.7 14492.7 14564.0 14575.2 14580.5 650.5 792.9 795.7 796.6 801.1 793.2 801.4 801.6 826.6 828.1 863.7 866.2 867.0 867.0 867.5 673.1 856.4 856.6 857.5 858.1 606.9 610.9 611.4 622.4 623.8 13549.5 13585.1 13587.5 13593.6 13598.3 14138.4 14174.9 14838.6 14920.7 14924.0 12557.6 12587.7 12821.0 12852.6 12868.0 4405.9 4481.5 4487.7 4491.1 4690.4 77333.0 77421.0 78223.6 82580.2 82711.6 10855.7 11001.2 11145.0 11445.5 11566.1 21678.7 21951.3 21960.8 21973.9 22002.1 8441.8 8464.9 8712.7 8798.6 8881.7 4611.3 4810.2 4847.4 4885.5 5118.2 3517.3 3569.0 3613.2 3617.3 3618.5 595.8 597.8 603.8 612.8 622.4 555.5 593.3 661.3 662.5 681.9 8985.4 9476.4 9515.8 10023.8 10064.2 522.5 577.4 583.4 585.0 589.5 4810.3 4936.0 4938.1 4949.3 4950.9 65648.0 99131.0 110142.4 110577.0 114057.0 60495.7 77690.0 95409.5 96342.0 100930.0 87421.6 88445.0 89714.6 90967.1 92853.0 9170.9 9264.7 9435.7 9520.0 9533.6 42239.4 49586.3 49592.8 51379.5 54501.0 74111.0 76992.6 77720.6 78359.4 79368.0 11421.8 11445.6 11731.0 11885.2 12099.9 12826.4 12873.9 13026.7 13545.7 13551.7 12078.0 12297.4 12340.6 12441.0 12454.4 11586.3 12042.8 12141.1 12467.1 12713.9 11742.1 12153.1 12229.6 12270.1 12703.6 9946.3 10048.2 10344.2 10369.7 10423.2 9969.4 10588.5 10667.5 10671.5 10775.7 19:30:41 INFO - PROCESS | 22114 | -------- Summary: end -------- 19:30:41 INFO - PROCESS | 22114 | 19:30:42 INFO - TEST-INFO | 22114: exit 0 19:30:42 INFO - TEST-OK | dromaeo_css | took 1113838ms 19:30:42 INFO - TEST-START | kraken 19:30:42 INFO - operating with platform_type : linux_ 19:30:42 INFO - Initialising browser for kraken test... 19:30:42 INFO - TEST-INFO | started process 22312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDQyF2h/profile http://localhost:57482/getInfo.html) 19:30:46 INFO - PROCESS | 22312 | JavaScript error: , line 0: uncaught exception: undefined 19:30:46 INFO - PROCESS | 22312 | __metrics Screen width/height:1600/1200 19:30:46 INFO - PROCESS | 22312 | colorDepth:24 19:30:46 INFO - PROCESS | 22312 | Browser inner width/height: 1024/697 19:30:46 INFO - PROCESS | 22312 | __metrics 19:30:47 INFO - PROCESS | 22312 | 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" 19:30:47 INFO - PROCESS | 22312 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:30:48 INFO - TEST-INFO | 22312: exit 0 19:30:48 INFO - Browser initialized. 19:30:48 INFO - Running cycle 1/1 for kraken test... 19:30:48 INFO - TEST-INFO | started process 22395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDQyF2h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:00 INFO - PROCESS | 22395 | RSS: Main: 157736960 19:31:00 INFO - PROCESS | 22395 | 19:31:03 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-beat-detection) 19:31:04 INFO - PROCESS | 22395 | RSS: Main: 214192128 19:31:04 INFO - PROCESS | 22395 | 19:31:06 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-dft) 19:31:07 INFO - PROCESS | 22395 | RSS: Main: 188538880 19:31:07 INFO - PROCESS | 22395 | 19:31:10 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-fft) 19:31:11 INFO - PROCESS | 22395 | RSS: Main: 270462976 19:31:11 INFO - PROCESS | 22395 | 19:31:13 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-oscillator) 19:31:13 INFO - PROCESS | 22395 | RSS: Main: 180879360 19:31:13 INFO - PROCESS | 22395 | 19:31:15 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:16 INFO - PROCESS | 22395 | RSS: Main: 185503744 19:31:16 INFO - PROCESS | 22395 | 19:31:19 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57482/tests/kraken/driver.html?testName=imaging-darkroom) 19:31:20 INFO - PROCESS | 22395 | RSS: Main: 220114944 19:31:20 INFO - PROCESS | 22395 | 19:31:23 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57482/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:24 INFO - PROCESS | 22395 | RSS: Main: 220778496 19:31:24 INFO - PROCESS | 22395 | 19:31:26 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57482/tests/kraken/driver.html?testName=json-parse-financial) 19:31:27 INFO - PROCESS | 22395 | RSS: Main: 220504064 19:31:27 INFO - PROCESS | 22395 | 19:31:28 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:29 INFO - PROCESS | 22395 | RSS: Main: 185331712 19:31:29 INFO - PROCESS | 22395 | 19:31:31 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:31 INFO - PROCESS | 22395 | RSS: Main: 189698048 19:31:31 INFO - PROCESS | 22395 | 19:31:33 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:34 INFO - PROCESS | 22395 | RSS: Main: 195207168 19:31:34 INFO - PROCESS | 22395 | 19:31:37 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:37 INFO - PROCESS | 22395 | RSS: Main: 188465152 19:31:37 INFO - PROCESS | 22395 | 19:31:40 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:40 INFO - PROCESS | 22395 | RSS: Main: 193732608 19:31:40 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57482/tests/kraken/driver.html?testName=ai-astar) 19:31:42 INFO - PROCESS | 22395 | RSS: Main: 244535296 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | __start_tp_report 19:31:42 INFO - PROCESS | 22395 | _x_x_mozilla_page_load 19:31:42 INFO - PROCESS | 22395 | _x_x_mozilla_page_load_details 19:31:42 INFO - PROCESS | 22395 | |i|pagename|runs| 19:31:42 INFO - PROCESS | 22395 | |0;ai-astar;103;110;112;112;111;112;112;110;110;109 19:31:42 INFO - PROCESS | 22395 | |1;audio-beat-detection;143;120;122;193;118;119;148;119;171;116 19:31:42 INFO - PROCESS | 22395 | |2;audio-dft;161;162;161;161;161;161;160;162;162;161 19:31:42 INFO - PROCESS | 22395 | |3;audio-fft;74;75;76;116;75;76;74;75;97;75 19:31:42 INFO - PROCESS | 22395 | |4;audio-oscillator;84;84;113;85;84;85;129;83;83;133 19:31:42 INFO - PROCESS | 22395 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;117 19:31:42 INFO - PROCESS | 22395 | |6;imaging-darkroom;146;146;145;146;148;147;146;145;146;146 19:31:42 INFO - PROCESS | 22395 | |7;imaging-desaturate;95;95;95;95;95;94;96;94;94;94 19:31:42 INFO - PROCESS | 22395 | |8;json-parse-financial;51;50;51;53;51;51;51;49;60;49 19:31:42 INFO - PROCESS | 22395 | |9;json-stringify-tinderbox;62;63;62;62;63;62;63;63;63;63 19:31:42 INFO - PROCESS | 22395 | |10;stanford-crypto-aes;76;76;75;78;75;75;76;75;75;79 19:31:42 INFO - PROCESS | 22395 | |11;stanford-crypto-ccm;122;124;120;119;120;120;119;125;198;129 19:31:42 INFO - PROCESS | 22395 | |12;stanford-crypto-pbkdf2;155;153;153;156;154;153;153;159;153;156 19:31:42 INFO - PROCESS | 22395 | |13;stanford-crypto-sha256-iterative;66;62;62;62;62;63;63;61;61;62 19:31:42 INFO - PROCESS | 22395 | __end_tp_report 19:31:42 INFO - PROCESS | 22395 | __start_cc_report 19:31:42 INFO - PROCESS | 22395 | _x_x_mozilla_cycle_collect,1667 19:31:42 INFO - PROCESS | 22395 | __end_cc_report 19:31:42 INFO - PROCESS | 22395 | __startTimestamp1469586702821__endTimestamp 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | ------- Summary: start ------- 19:31:42 INFO - PROCESS | 22395 | Number of tests: 14 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:2.73 (2.4%) stddev-sans-first:1.17 19:31:42 INFO - PROCESS | 22395 | Values: 103.0 110.0 112.0 112.0 111.0 112.0 112.0 110.0 110.0 109.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:132.50 stddev:26.69 (20.1%) stddev-sans-first:28.22 19:31:42 INFO - PROCESS | 22395 | Values: 143.0 120.0 122.0 193.0 118.0 119.0 148.0 119.0 171.0 116.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 19:31:42 INFO - PROCESS | 22395 | Values: 161.0 162.0 161.0 161.0 161.0 161.0 160.0 162.0 162.0 161.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:14.03 (18.7%) stddev-sans-first:14.63 19:31:42 INFO - PROCESS | 22395 | Values: 74.0 75.0 76.0 116.0 75.0 76.0 74.0 75.0 97.0 75.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:84.00 stddev:20.43 (24.3%) stddev-sans-first:21.18 19:31:42 INFO - PROCESS | 22395 | Values: 84.0 84.0 113.0 85.0 84.0 85.0 129.0 83.0 83.0 133.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:31:42 INFO - PROCESS | 22395 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 19:31:42 INFO - PROCESS | 22395 | Values: 146.0 146.0 145.0 146.0 148.0 147.0 146.0 145.0 146.0 146.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:31:42 INFO - PROCESS | 22395 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 96.0 94.0 94.0 94.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.00 stddev:3.17 (6.2%) stddev-sans-first:3.35 19:31:42 INFO - PROCESS | 22395 | Values: 51.0 50.0 51.0 53.0 51.0 51.0 51.0 49.0 60.0 49.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 19:31:42 INFO - PROCESS | 22395 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 63.0 63.0 63.0 63.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:1.41 (1.9%) stddev-sans-first:1.50 19:31:42 INFO - PROCESS | 22395 | Values: 76.0 76.0 75.0 78.0 75.0 75.0 76.0 75.0 75.0 79.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:123.00 stddev:24.25 (19.7%) stddev-sans-first:25.56 19:31:42 INFO - PROCESS | 22395 | Values: 122.0 124.0 120.0 119.0 120.0 120.0 119.0 125.0 198.0 129.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:154.50 stddev:2.01 (1.3%) stddev-sans-first:2.13 19:31:42 INFO - PROCESS | 22395 | Values: 155.0 153.0 153.0 156.0 154.0 153.0 153.0 159.0 153.0 156.0 19:31:42 INFO - PROCESS | 22395 | 19:31:42 INFO - PROCESS | 22395 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.43 (2.3%) stddev-sans-first:0.71 19:31:42 INFO - PROCESS | 22395 | Values: 66.0 62.0 62.0 62.0 62.0 63.0 63.0 61.0 61.0 62.0 19:31:42 INFO - PROCESS | 22395 | -------- Summary: end -------- 19:31:42 INFO - PROCESS | 22395 | 19:31:43 INFO - TEST-INFO | 22395: exit 0 19:31:43 INFO - TEST-OK | kraken | took 61088ms 19:31:43 INFO - SUITE-END | took 1174s 19:31:43 INFO - Completed test suite (00:19:35) 19:31:43 INFO - javascript benchmark 19:31:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2991.5213565829463, 3042.6348838139425, 3064.6475655299632, 3066.677998810125, 3069.8158110513373, 5196.116660167771, 5260.289860868782, 5326.147816349385, 5411.458854114591, 5432.755526001334, 5342.679439233649, 5373.220882971967, 5378.1663842104535, 5405.783768649249, 5440.863978400542, 4811.0618429406195, 4862.63530235232, 4894.290327902452, 4898.02039592083, 5036.194208926572, 4926.162552366106, 4974.651774375795, 4978.477259887714, 4986.401631804189, 4998.350214472113, 4767.404074490689, 4821.083994041121, 4823.155947709172, 4837.32277481153, 4929.8028078876805, 4820.758962051918, 4822.228443449031, 4830.830920917786, 4968.925466118011, 4972.477889821553, 4810.0, 4835.371401717789, 4844.079624871263, 4865.245886887538, 4890.0, 5208.244804503326, 5252.527272545489, 5360.383555891083, 5378.865528361822, 5412.0, 5673.404292549306, 5761.0494268445655, 5763.596548241625, 5764.135379693038, 5769.971150144264, 5721.971390143064, 5743.1959525666025, 5778.797742079007, 5787.50806181475, 5791.623544469596, 5182.0, 5303.708296043755, 5380.569554435636, 5401.972990135064, 5403.864903377408, 5949.732262048218, 5965.045592705146, 5968.134620480093, 5970.164177015221, 5974.402559744078, 5734.082546792493, 5739.426057394311, 5742.052561327418, 5744.569157313134, 5745.109508026263, 5524.0, 5623.831285061455, 5684.857878553069, 5806.0, 5814.156947242626, 5716.456936591017, 5720.628159169641, 5724.341700704389, 5757.251557297608, 5770.422957704196, 5679.290088738908, 5731.713414329267, 5734.627249228787, 5740.454656807597, 5741.62679425836, 4253.085586598896, 4292.098659281523, 4305.5048669402795, 4367.0, 4384.298512238027, 3885.300645883768, 3900.6684431823046, 3931.488906442144, 3948.7828169450954, 3979.6816254699556, 5425.131978883439, 5434.3207099112615, 5437.483439073281, 5438.211459338374, 5499.285092937893, 5613.382527921925, 5701.971490142523, 5814.709264536757, 5817.301923769175, 5878.911816322759, 5361.276227709287, 5448.400675925645, 5450.645708029045, 5497.972510137423, 5500.257465242221, 4839.758012099381, 4848.248521479177, 4849.927251091236, 4855.393075865517, 4890.853274401702, 5729.541636669056, 5836.2412886325355, 5947.702614869239, 5962.195103661037, 5964.642121472725, 5728.169415434655, 5760.567957403127, 5772.105323674838, 5785.82642520725, 5819.039858423482, 5923.911141332969, 5940.049592065422, 5952.76188952437, 5953.613015154001, 5956.315023772322, 5507.586930980273, 5525.557955363481, 5620.775168993195, 5671.801486947937, 5685.0335442973965, 5613.24221230145, 5684.374718781013, 5707.0583353747825, 5734.3692193857805, 5747.396523364986, 5550.08423610116, 5570.164475328733, 5581.023320918905, 5581.10702287632, 5586.217929489793, 5435.809746658848, 5551.306086739158, 5560.694161821139, 5561.527270181918, 5565.053940829987, 5512.614117011771, 5594.804181853616, 5597.412271711411, 5606.103023516381, 5636.492715655447, 5633.8309850704545, 5645.802396916089, 5691.8861622768145, 5696.316442026983, 5738.483536481736, 5380.166074258496, 5450.400455949922, 5556.527695145958, 5567.47109024642, 5569.805056822992], "value": 5284.1339013612405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4580648384036, 594.8661551150991, 608.9817305480834, 615.3108518459323, 640.4396153365805, 30247.395052098946, 43267.567324326745, 44372.112557748864, 44400.33399499002, 44453.33320000194, 46703.76648116763, 47231.76384118075, 47246.52753472464, 47264.0, 47287.29069063967, 8901.821963560726, 9044.728658140233, 9052.8642070369, 9053.0, 9054.4114632549, 8943.552822358855, 9027.0, 9033.548322583878, 9035.141661542142, 9038.502882341469, 9039.864402033974, 9075.54622268884, 9081.18269355758, 9089.454632722025, 9096.454212747256, 9053.366264361497, 9069.59186836594, 9075.228605568534, 9094.727158185233, 9101.635934562642, 8827.293816494664, 8896.065913079163, 8909.955450222773, 8917.598708058153, 8919.331050171199, 43325.13349732988, 43533.12933741308, 43537.78231108856, 43592.3461148083, 43706.34440483395, 3568.125809176768, 3620.7284453665816, 3671.7429779915415, 3678.503402040717, 3876.2635099331037, 32841.83579082113, 33086.0, 33646.0, 33907.0, 34389.656103438894, 3915.4126880968083, 3919.8236079376497, 4067.6542493888055, 4075.1034772350035, 4123.113530590937, 353550.0, 355731.0, 356719.0, 356995.0, 357811.0, 33724.325513489595, 58794.41205587975, 59175.0, 59192.0, 59292.703536482906, 33840.830795846356, 36028.27943441169, 36037.459438108446, 36198.45702314467, 36267.0, 15132.848671513364, 15340.156291403857, 15344.386224551115, 15349.07905525672, 15351.385944562317, 11877.168598198215, 11878.762424751456, 11882.940585297018, 11893.702657433634, 11929.522819087313, 8224.300934420522, 8274.379421543408, 8321.583920803936, 8340.415321088974, 8374.032102455918, 3169.4453470643007, 3176.8411579420936, 3206.823624700664, 3211.3595853991224, 3214.421404147229, 942.34036174678, 997.7505623594102, 1028.18773169197, 1031.9484025798681, 1036.439829186746, 32146.839265803523, 32242.699007893945, 32452.188695282333, 32580.674193258237, 32808.50787238193, 848.4442690038035, 1004.3120462483076, 1020.1787561013456, 1022.2435397805571, 1137.2380505061628, 17094.743578846326, 17103.14484275781, 17234.91382543079, 17239.913800430917, 17257.137143142794, 547220.0, 548704.0, 550584.0, 552882.0, 554513.0, 60199.699001505585, 60631.393686062576, 60678.39321606728, 60747.392526075055, 60966.69516652388, 1197.976040479203, 1293.3985696651102, 1298.363801737142, 1357.2060344698461, 1357.755603991291, 32732.34535309233, 33857.83071084629, 34351.65648343584, 34370.82814585911, 34533.82733086318, 49995.0, 50841.23738144005, 50854.237186441496, 50964.74517627388, 50983.490165099356, 396171.0, 397579.0, 398437.0, 398766.0, 654899.0, 45025.0, 45279.320810187215, 45607.0, 45854.54145458636, 45932.0, 49494.50505494899, 49968.25047624216, 50234.24648630201, 50901.49098509116, 51265.23102153545, 41898.79050604728, 42571.14857702891, 42595.3610695846, 42752.57247427486, 44550.0, 41539.37690934578, 42313.57686423096, 43627.345589815544, 44081.338779917685, 44714.77642611766, 41102.38346424866, 41807.581924181584, 42011.0, 42520.5747942529, 42902.35646465243, 35741.642583574874, 38087.52431092081, 38280.42579361256, 38677.419838703005, 38733.418998715606, 28873.278168045967, 28924.16050297624, 29019.56470652984, 29080.272993174494, 29101.85449072826], "value": 19298.422701611034, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.1524003352089, 367.62502247707323, 377.886634009797, 381.23181788695774, 385.87651951375574, 14475.782863257047, 18602.0, 18943.147558359873, 19081.332153374635, 19817.10823012964, 18185.727214091767, 19134.904325478354, 19602.215911363564, 19752.407427777154, 19769.209231630753, 5541.861453463665, 5741.598088133832, 5746.770129194848, 5747.137929310595, 5747.597668163209, 5454.836354909359, 5649.0, 5666.263385759866, 5668.518175955049, 5675.914861277084, 5645.745941432645, 5647.463490968352, 5652.06740887753, 5656.91514627281, 5658.547316214693, 5451.591130665196, 5462.0987537056135, 5483.396826349099, 5492.835214943558, 5634.32388113427, 4879.609631229493, 5027.195648696227, 5029.597632189416, 5029.974850125763, 5032.370953630796, 23446.64830027551, 23464.530709385715, 23602.93786779582, 23746.40633984147, 23794.76205237943, 2400.9039638414442, 2639.815212935095, 3074.4158609864053, 3108.2384815720293, 3189.346184032268, 9280.489573073479, 9994.400335979864, 10131.493425328705, 14070.08544444618, 14938.178400187986, 1878.4083013850593, 1893.9621207575772, 1895.2324308655018, 1933.4393026022437, 1963.0577322884953, 79750.60124699397, 79884.0, 80620.59689701514, 82154.0, 82756.58621706913, 10309.53607087683, 10440.68677939663, 10496.790064198825, 10625.0, 10665.36007839532, 14879.10725356482, 14893.47872824446, 14916.850831491547, 14943.626409339853, 14959.850401495845, 7747.883781743279, 7927.246911543394, 7973.880391794128, 8132.593370331578, 8217.630206640715, 8018.839623207503, 8047.195280471906, 8246.8350632987, 8272.669093236324, 8280.337572994267, 4500.729956202638, 4576.97711511447, 4590.42619672541, 4595.1728688835665, 4632.420947381577, 1867.2810967777502, 1876.981230187708, 1949.853760967933, 1953.6874100144194, 1974.5261137326938, 846.0608724316004, 882.1701186006562, 957.5020989085637, 962.7304354780673, 1088.6625146204701, 18648.81351186498, 19490.805091949183, 19500.902495487433, 19591.412257632295, 19957.0, 966.6858271061792, 1004.3170643962176, 1004.9397036177853, 1009.1825621246813, 1010.686687126993, 9598.712038638852, 10745.24783265164, 11208.103351731841, 11379.54481820718, 11796.52813887452, 458107.0, 458204.0, 464628.0, 497465.0, 503710.0, 92841.5357923206, 93226.0, 94174.52912735392, 94194.52902735579, 94650.52674736582, 994.2642444591095, 1032.896710328976, 1051.9684409467882, 1057.471264367816, 1058.2169194795795, 16538.0, 16542.66914661724, 17512.0, 17572.0, 17943.102844857967, 33517.83241083779, 43002.0, 43346.0, 44124.33813492736, 44390.556094438645, 58231.0, 58309.4169058321, 59353.0, 60019.699901500215, 60577.39422605718, 7412.8146796328365, 7545.396368290414, 7555.962220188864, 7570.886436703344, 7814.804629884298, 11487.827682584935, 12181.33002684861, 12198.268103913439, 12504.874951250371, 12555.309457979534, 10263.948680256552, 10887.564497420015, 11008.834867477155, 11035.22753407286, 11176.16178786578, 10346.534405951901, 10617.628383006559, 10713.357198567799, 11113.277636953571, 11187.608433704781, 10303.124234439856, 10682.252242342962, 10801.0, 10945.671629851116, 11024.44877756125, 7498.812529686801, 7624.313811756969, 7738.0, 7755.418343624138, 7757.185495523115, 7972.083210430875, 10149.188064954933, 10204.285700000928, 10476.0571548561, 10584.153267738717], "value": 9034.057409611449, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.146786056923, 1443.1413309081097, 1510.773383992401, 1616.8221495635478, 1753.850922671572, 8559.272461840743, 8891.288696904248, 8921.732348029562, 9123.817523649539, 9130.22393096586, 8950.552472376388, 9043.457392556435, 9049.2308153807, 9049.276057915367, 9054.04932482088, 2351.2123438648073, 2371.1345358944036, 2373.537160253751, 2376.3583832365252, 2378.0368950575044, 2318.48993221491, 2358.5165041166606, 2414.7343792182846, 2418.262429958862, 2418.806495480357, 2313.791758741713, 2335.1126571902737, 2350.635651474024, 2362.55111528809, 2369.834111612188, 2209.5359974405314, 2222.5999320122373, 2253.8873056347197, 2254.7407048189502, 2258.424101854025, 2308.7806658367426, 2330.860148391102, 2332.5801355755957, 2334.661474086248, 2338.497223097025, 8747.912520874774, 9004.594793234255, 9030.142136497023, 9049.2308153807, 9067.319951003636, 5158.40678321994, 5278.683279003272, 5285.947140528584, 5289.391719952217, 5296.470352964711, 3411.6588341165934, 3437.106352348407, 3479.599846017715, 3491.0748651607346, 3493.5109084727906, 1176.705823544114, 1182.8521434820648, 1187.7327601289728, 1216.8296438498617, 1218.8293638890561, 12115.212511186834, 12202.572909948198, 12214.083943704169, 12230.877691223151, 12257.325847078408, 4323.718958267703, 4453.153900758845, 4591.977040114845, 4592.380028696083, 4608.216603177468, 9632.229421646252, 9639.228861691048, 9658.855117173249, 9660.565274562521, 9666.806663866684, 5200.869978250574, 5207.0, 5212.374515058217, 5214.8957020860125, 5233.790648374099, 4240.681948853849, 4717.457492388419, 4828.8792780180775, 4869.586085182728, 4908.092002979389, 3786.2427514497213, 3861.9227615447535, 3932.2528719543197, 3956.149427873021, 3979.6816254700134, 1139.800534906388, 1169.0647482014353, 1171.262104873924, 1182.2315494928366, 1183.083110589283, 804.2681160144358, 838.9119142490073, 880.1374652840252, 924.2051835421532, 948.0519480519481, 5897.469227769521, 5915.260592425947, 5915.792947246826, 6012.158297838306, 6169.629822210682, 979.5494072726625, 983.2576404814463, 991.667791289926, 1000.2398177385094, 1017.0592202212923, 3949.940750888739, 3961.485006949078, 4135.503739551213, 4278.465191851019, 4284.121755040209, 11080.337949307668, 11188.552457901755, 11355.772884542263, 11355.97796198346, 11357.716057098638, 11266.605668801552, 11291.322520648788, 11303.717407064889, 11398.658040258806, 11429.085673146128, 8057.234562716532, 8427.578621069044, 8466.06873243955, 8490.787730306793, 8514.957425212835, 5940.584159108821, 5954.136650185786, 6033.42682445167, 6056.818295451144, 6198.969005154945, 10196.38821670702, 10246.897531024893, 10259.897401025893, 10400.635977740743, 10412.47937603132, 10610.628627997983, 10646.361218326925, 10651.57393704243, 10679.733006674895, 10680.359178449318, 7019.5788252705, 7831.921680783119, 7884.0, 7918.841623167619, 8099.190080991853, 8795.648174072965, 9001.774955626162, 9004.099590040943, 9005.459672419676, 9010.05394433575, 7865.095514015733, 7918.485298455582, 8077.353811694933, 8222.917770822454, 8274.917250827655, 7624.390048796194, 7768.53388796674, 7824.21757824213, 7829.530228186327, 7843.6862525498345, 7158.534695244793, 7291.927080729125, 7294.416446684359, 7295.7081716732855, 7296.562206267641, 5084.949150508448, 5105.693658380509, 5108.259302401206, 5192.922106168335, 5229.058769421541, 5247.790088396574, 5250.632455728062, 5295.311609490742, 5321.973390133179, 5541.556675465872], "value": 4678.6002062252355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.16072924562167, 320.43603258265455, 324.5278120334913, 327.98979144235756, 328.36461447099856, 5357.598180136486, 5358.517733403998, 5399.190121481774, 5402.810901618444, 5410.621256512046, 5031.371078615173, 5095.675124467637, 5147.279380886679, 5156.097682905495, 5285.762140703668, 4053.391991201314, 4078.0620457294767, 4162.646175075122, 4164.354525048622, 4197.7901104944785, 4127.236461254663, 4147.440095587087, 4154.709170358076, 4174.91650166998, 4189.560096189886, 4054.513458384998, 4077.0, 4114.979425102871, 4143.689223308249, 4168.937465937998, 4111.342185250375, 4129.690273229489, 4135.8966025849295, 4140.91718165635, 4166.500019997589, 3681.7975011374365, 3704.1665625234104, 3707.7404581679293, 3710.0, 3713.9415266649144, 5110.182370820651, 5220.086484865172, 5225.033368826779, 5225.477452254744, 5228.163493840967, 4685.367475390847, 4707.929381059287, 4714.434267887876, 4733.786979585927, 4756.3816703828625, 5522.0, 5534.557235421156, 5541.362743284493, 5566.582506312043, 5573.916391254134, 3956.7823769692654, 4019.3970904364287, 4048.7975601220114, 4070.1859628074208, 4071.0, 5657.688827114548, 5671.404502527258, 5691.402402747734, 5724.713764311809, 5732.713364331767, 4094.7747873867224, 4108.67130629549, 4118.052847845012, 4152.792360381969, 4161.396597493346, 4084.1831633673382, 4199.895002624898, 4215.641670458045, 4228.556001619847, 4235.639970602471, 4733.461624971829, 4748.4539277982785, 4759.666823322404, 4768.856934291907, 4799.3760811095035, 5528.44715528444, 5575.749091290902, 5576.832695019156, 5590.5248053915875, 5623.381428042912, 1336.939837707286, 1421.3532842556613, 1456.7450696128135, 1461.7003514279547, 1465.6116129225763, 938.7277689470113, 987.2200961240683, 996.8305388083899, 1000.4147573669339, 1008.4503945349802, 5274.815381461707, 5275.868103297372, 5282.2340760589495, 5284.313039304866, 5292.947070529245, 5552.52803511706, 5619.887602247933, 5680.579855036241, 5696.971515142398, 5697.544196464273, 5276.445973172838, 5293.232481290268, 5296.179092240709, 5310.867228319323, 5314.867128321745, 2970.0495841331, 2999.6250468691414, 3001.519756838939, 3001.639803223627, 3010.5484177373132, 5586.301712285965, 5754.5971781975695, 5795.39148389413, 5803.0, 5841.474267315962, 5720.998825205573, 5735.827925162252, 5746.9425305747245, 5759.0, 5759.8560035999435, 5739.713014349266, 5779.508741756914, 5787.565932555075, 5795.710214489259, 5802.65184088956, 5413.511284396823, 5664.677482232265, 5683.204351390891, 5697.173909783141, 5709.25779648643, 5650.378458369658, 5663.9716801415725, 5673.9432605675065, 5682.488576028178, 5717.599768016199, 5673.404292549223, 5853.853653658693, 5874.206982057368, 5888.381719919346, 5935.0, 4077.8164982575263, 4093.7339072960162, 4095.4061661058386, 4112.581159499968, 4148.522919864134, 5826.854328641818, 5828.358880523224, 5828.388019258086, 5846.50914016923, 5851.093080572518, 5464.3442786865835, 5605.5795815313195, 5616.241807355955, 5619.623192317908, 5687.374388817309, 5609.887802244014, 5617.634853734494, 5617.775288988558, 5618.325800903917, 5689.573282003949, 5325.204267759457, 5387.622866399472, 5459.508644222039, 5557.888422315634, 5597.272354593877, 5437.646552974044, 5557.277553917965, 5646.576506762091, 5646.757713303066, 5652.6043176978865, 5491.75287112073, 5492.340919089735, 5513.641613295123, 5514.724263786875, 5521.751521181637], "value": 4251.26849413051, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.3624283116523, 745.8135466133467, 768.2164192523626, 772.0, 886.0209468537266, 14711.632209194775, 15204.046947793571, 15525.146116963562, 15537.53387398377, 15562.455314063996, 14465.710685786278, 14492.710145797078, 14564.0, 14575.19836408997, 14580.489682861102, 650.4601181019766, 792.9286364227219, 795.6618437164211, 796.6056801883047, 801.0947629179034, 793.2028311546916, 801.4069588504523, 801.5791709352608, 826.5660528222671, 828.0849661124461, 863.6933888469565, 866.1814585216972, 866.9783255418633, 867.0072766682146, 867.4968518259394, 673.1249375811475, 856.3620103023287, 856.6016802186982, 857.5197889182078, 858.1289990659454, 606.9075663805133, 610.8808782287456, 611.3763960760044, 622.3682961793783, 623.8409205652575, 13549.458021679122, 13585.116967397087, 13587.456501739918, 13593.59219223425, 13598.32008399576, 14138.363773630108, 14174.929125354307, 14838.629034274121, 14920.70158596822, 14924.0, 12557.56048538306, 12587.748245035047, 12821.0, 12852.55016074433, 12868.0, 4405.9118817623785, 4481.481113616252, 4487.663425243087, 4491.101779644085, 4690.366800481926, 77333.0, 77421.0, 78223.60888195579, 82580.17419825785, 82711.58644206861, 10855.67432977012, 11001.17491188164, 11145.0, 11445.54217831294, 11566.149416093385, 21678.674819877713, 21951.341459756233, 21960.780392196193, 21973.890130549244, 22002.119915203533, 8441.788955276168, 8464.915350846535, 8712.738617841474, 8798.604062817061, 8881.689140880038, 4611.308303754397, 4810.2063159578975, 4847.418309802776, 4885.5358740919555, 5118.155504341742, 3517.296540691872, 3569.036360182736, 3613.1870329175727, 3617.276544691072, 3618.5115009473384, 595.7527626035147, 597.8116893178722, 603.8399824046631, 612.8192183305936, 622.4429135923323, 555.4723013137454, 593.2525018476664, 661.2990230355838, 662.4534758823893, 681.8977153426927, 8985.415947963362, 9476.363999400906, 9515.78195809334, 10023.849642255373, 10064.194864410829, 522.4618642797924, 577.4254616656453, 583.4253260538367, 584.9502792262621, 589.539403700282, 4810.254410566298, 4935.975320123448, 4938.123513065012, 4949.282354058641, 4950.851474455772, 65648.0, 99131.0, 110142.44928775304, 110577.0, 114057.0, 60495.69752151299, 77690.0, 95409.52295238618, 96342.0, 100930.0, 87421.56289218513, 88445.0, 89714.55142724245, 90967.09032909587, 92853.0, 9170.945341285838, 9264.72205833826, 9435.716928492157, 9520.0, 9533.570989305359, 42239.366409503265, 49586.25620615766, 49592.75203623959, 51379.48620513747, 54501.0, 74111.0, 76992.6150369267, 77720.61139694265, 78359.37809860075, 79368.0, 11421.828672569753, 11445.569303837021, 11731.00286475659, 11885.22746021506, 12099.911008009321, 12826.422810973716, 12873.935630321788, 13026.739465210832, 13545.661358466117, 13551.661208469473, 12078.0, 12297.385130743249, 12340.568080117153, 12441.0, 12454.377281136089, 11586.304821710724, 12042.819357709817, 12141.082068325384, 12467.127301088836, 12713.93643031816, 11742.119341049627, 12153.149279550347, 12229.633111006684, 12270.141090123605, 12703.618891433272, 9946.303758736818, 10048.246381521269, 10344.172466202535, 10369.688909332732, 10423.218258630784, 9969.35199212049, 10588.523516441932, 10667.466626668791, 10671.46642667879, 10775.676729698122], "value": 7332.095151452282, "unit": "score"}], "name": "dromaeo_css", "value": 7156.7193066534655, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 112.0, 112.0, 111.0, 112.0, 112.0, 110.0, 110.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 122.0, 193.0, 118.0, 119.0, 148.0, 119.0, 171.0, 116.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0, 162.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 116.0, 75.0, 76.0, 74.0, 75.0, 97.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 85.0, 84.0, 85.0, 129.0, 83.0, 83.0, 133.0], "value": 96.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, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 148.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 53.0, 51.0, 51.0, 51.0, 49.0, 60.0, 49.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 78.0, 75.0, 75.0, 76.0, 75.0, 75.0, 79.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 120.0, 119.0, 120.0, 120.0, 119.0, 125.0, 198.0, 129.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 153.0, 153.0, 156.0, 154.0, 153.0, 153.0, 159.0, 153.0, 156.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 61.0, 61.0, 62.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1480.1, "alertThreshold": 2.0}]} 19:31:44 INFO - Return code: 0 19:31:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:31:44 INFO - # TBPL SUCCESS # 19:31:44 INFO - Running post-action listener: _resource_record_post_action 19:31:44 INFO - [mozharness: 2016-07-27 02:31:44.145732Z] Finished run-tests step (success) 19:31:44 INFO - Running post-run listener: _resource_record_post_run 19:31:44 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552648704; Read time: 16; Write time: 475792 19:31:44 INFO - TinderboxPrint: CPU usage
13.0% 19:31:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:31:44 INFO - TinderboxPrint: I/O write bytes / time
552,648,704 / 475,792 19:31:44 INFO - TinderboxPrint: CPU idle
8,284.1 (87.0%) 19:31:44 INFO - TinderboxPrint: CPU user
1,192.5 (12.5%) 19:31:44 INFO - TinderboxPrint: Swap in / out
0 / 0 19:31:44 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257359872; Read time: 0; Write time: 307404 19:31:44 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295288832; Read time: 0; Write time: 168388 19:31:44 INFO - Running post-run listener: _upload_blobber_files 19:31:44 INFO - Blob upload gear active. 19:31:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:31:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:48 INFO - (blobuploader) - INFO - Done attempting. 19:31:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:31:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:31:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:49 INFO - (blobuploader) - INFO - Done attempting. 19:31:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:31:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:50 INFO - (blobuploader) - INFO - Done attempting. 19:31:50 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:50 INFO - Return code: 0 19:31:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24646ea4da44b84ad36fe49fe6e6c74a275695cb447a55adbadf930713a09f6c5d0e53cd69ee5cd0829be54b27ccef350a483ae2a015568f821fc541a2666621", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4e3f3963627d49a5fff671909628b9548ba728dabe86806e31c96b3c635a2b91c6690ed75d690802efd35727ebf631804a7881122ece30e355526381ad7e818c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be49967c35f05c9c825823266add05eaeb4cfc023c8b40671c7ea10b399c75d21c2e0e8e43e40f30bf7d1ede64290a2f28d953b7b430528a715f2e4eb45c6ba7"} 19:31:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:50 INFO - Contents: 19:31:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24646ea4da44b84ad36fe49fe6e6c74a275695cb447a55adbadf930713a09f6c5d0e53cd69ee5cd0829be54b27ccef350a483ae2a015568f821fc541a2666621", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4e3f3963627d49a5fff671909628b9548ba728dabe86806e31c96b3c635a2b91c6690ed75d690802efd35727ebf631804a7881122ece30e355526381ad7e818c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be49967c35f05c9c825823266add05eaeb4cfc023c8b40671c7ea10b399c75d21c2e0e8e43e40f30bf7d1ede64290a2f28d953b7b430528a715f2e4eb45c6ba7"} 19:31:50 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:50 INFO - Copying logs to upload dir... 19:31:50 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.613824 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-26 19:31:49.976472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 19:31:49.979679) ========= 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=d2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24646ea4da44b84ad36fe49fe6e6c74a275695cb447a55adbadf930713a09f6c5d0e53cd69ee5cd0829be54b27ccef350a483ae2a015568f821fc541a2666621", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4e3f3963627d49a5fff671909628b9548ba728dabe86806e31c96b3c635a2b91c6690ed75d690802efd35727ebf631804a7881122ece30e355526381ad7e818c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be49967c35f05c9c825823266add05eaeb4cfc023c8b40671c7ea10b399c75d21c2e0e8e43e40f30bf7d1ede64290a2f28d953b7b430528a715f2e4eb45c6ba7"} build_url:https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/bejWiS7ZQwup5T25umjpGw/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/Mozilla-Inbound/sha512/24646ea4da44b84ad36fe49fe6e6c74a275695cb447a55adbadf930713a09f6c5d0e53cd69ee5cd0829be54b27ccef350a483ae2a015568f821fc541a2666621", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4e3f3963627d49a5fff671909628b9548ba728dabe86806e31c96b3c635a2b91c6690ed75d690802efd35727ebf631804a7881122ece30e355526381ad7e818c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be49967c35f05c9c825823266add05eaeb4cfc023c8b40671c7ea10b399c75d21c2e0e8e43e40f30bf7d1ede64290a2f28d953b7b430528a715f2e4eb45c6ba7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 19:31:50.005841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 19:31:50.006241) ========= 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=d2a8c569965ab8367867b893000001a1-1469585095.730344-1415955182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 19:31:50.088533) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 19:31:50.088843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 19:31:50.089146) ========= ========= Total master_lag: 0.17 =========