builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1469974502.57 results: success (0) buildid: 20160731043003 builduid: 89bc129067e44f92b1576a93dc26578d revision: 34f662c8a932551e07a6c66853b9f696b5906f42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:02.574683) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:02.575067) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:02.575360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:02.622314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:02.622621) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-31 07:15: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% 222M=0s 2016-07-31 07:15:04 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.241831 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:02.892018) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:02.892374) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019666 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:02.942310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:02.942659) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 34f662c8a932551e07a6c66853b9f696b5906f42 --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 34f662c8a932551e07a6c66853b9f696b5906f42 --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=82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-31 07:15:04,992 truncating revision to first 12 chars 2016-07-31 07:15:04,992 Setting DEBUG logging. 2016-07-31 07:15:04,992 attempt 1/10 2016-07-31 07:15:04,992 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/34f662c8a932?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-31 07:15:05,361 unpacking tar archive at: mozilla-inbound-34f662c8a932/testing/mozharness/ program finished with exit code 0 elapsedTime=0.704047 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:03.659788) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:03.660063) ========= script_repo_revision: 34f662c8a932551e07a6c66853b9f696b5906f42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:03.660454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:03.660736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 07:15:03.670260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-31 07:15:03.670560) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:05 INFO - MultiFileLogger online at 20160731 07:15:05 in /builds/slave/test 07:15: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 07:15:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:05 INFO - {'append_to_log': False, 07:15:05 INFO - 'base_work_dir': '/builds/slave/test', 07:15:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:15:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:05 INFO - 'branch': 'Mozilla-Inbound', 07:15:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:05 INFO - 'config_files': ('talos/linux_config.py',), 07:15:05 INFO - 'default_actions': ('clobber', 07:15:05 INFO - 'read-buildbot-config', 07:15:05 INFO - 'download-and-extract', 07:15:05 INFO - 'populate-webroot', 07:15:05 INFO - 'create-virtualenv', 07:15:05 INFO - 'install', 07:15:05 INFO - 'run-tests'), 07:15:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:05 INFO - 'download_minidump_stackwalk': True, 07:15:05 INFO - 'download_symbols': 'ondemand', 07:15:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:05 INFO - 'installer_path': 'installer.exe', 07:15:05 INFO - 'log_level': 'info', 07:15:05 INFO - 'log_name': 'talos', 07:15:05 INFO - 'log_to_console': True, 07:15:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:05 INFO - 'opt_config_files': (), 07:15:05 INFO - 'pip_index': False, 07:15:05 INFO - 'sps_profile': False, 07:15:05 INFO - 'sps_profile_interval': 0, 07:15:05 INFO - 'suite': 'dromaeojs', 07:15:05 INFO - 'system_bits': '32', 07:15:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:05 INFO - 'title': 'talos-linux64-ix-066', 07:15:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:05 INFO - 'use_talos_json': True, 07:15:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:05 INFO - 'work_dir': 'build'} 07:15:05 INFO - [mozharness: 2016-07-31 14:15:05.810932Z] Running clobber step. 07:15:05 INFO - Running pre-action listener: _resource_record_pre_action 07:15:05 INFO - Running main action method: clobber 07:15:05 INFO - rmtree: /builds/slave/test/build 07:15:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:06 INFO - Running post-action listener: _resource_record_post_action 07:15:06 INFO - [mozharness: 2016-07-31 14:15:06.266858Z] Finished clobber step (success) 07:15:06 INFO - [mozharness: 2016-07-31 14:15:06.266959Z] Running read-buildbot-config step. 07:15:06 INFO - Running pre-action listener: _resource_record_pre_action 07:15:06 INFO - Running main action method: read_buildbot_config 07:15:06 INFO - Using buildbot properties: 07:15:06 INFO - { 07:15:06 INFO - "project": "", 07:15:06 INFO - "product": "firefox", 07:15:06 INFO - "script_repo_revision": "production", 07:15:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:15:06 INFO - "repository": "", 07:15:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:15:06 INFO - "buildid": "20160731043003", 07:15:06 INFO - "pgo_build": "True", 07:15:06 INFO - "basedir": "/builds/slave/test", 07:15:06 INFO - "buildnumber": 1324, 07:15:06 INFO - "slavename": "talos-linux64-ix-066", 07:15:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:15:06 INFO - "platform": "ubuntu64_hw", 07:15:06 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:15:06 INFO - "branch": "mozilla-inbound", 07:15:06 INFO - "repo_path": "integration/mozilla-inbound", 07:15:06 INFO - "revision": "34f662c8a932551e07a6c66853b9f696b5906f42", 07:15:06 INFO - "stage_platform": "linux64-pgo", 07:15:06 INFO - "builduid": "89bc129067e44f92b1576a93dc26578d", 07:15:06 INFO - "slavebuilddir": "test" 07:15:06 INFO - } 07:15:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:15:06 INFO - Running post-action listener: _resource_record_post_action 07:15:06 INFO - [mozharness: 2016-07-31 14:15:06.269407Z] Finished read-buildbot-config step (success) 07:15:06 INFO - [mozharness: 2016-07-31 14:15:06.269497Z] Running download-and-extract step. 07:15:06 INFO - Running pre-action listener: _resource_record_pre_action 07:15:06 INFO - Running main action method: download_and_extract 07:15:06 INFO - mkdir: /builds/slave/test/build/tests 07:15: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')]} 07:15:06 INFO - https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:15:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:15:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:15:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:11 INFO - Downloaded 1361 bytes. 07:15:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:15:11 INFO - Using the following test package requirements: 07:15:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:15:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:15:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'jsshell-linux-x86_64.zip'], 07:15:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:15:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:15:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:15:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:15:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:15:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:15: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')]} 07:15:11 INFO - https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:22 INFO - Downloaded 21806788 bytes. 07:15: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'] 07:15: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 07:15:23 INFO - Return code: 0 07:15: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 07:15: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')]} 07:15:23 INFO - https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:24 INFO - Downloaded 21806788 bytes. 07:15: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'] 07:15: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 07:15:25 INFO - Return code: 0 07:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:25 INFO - https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:15:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:27 INFO - Downloaded 14413723 bytes. 07:15: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'] 07:15: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 07:15:27 INFO - Return code: 0 07:15: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')]} 07:15:27 INFO - https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:15:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GygZee4lSF-dy2cvn_5xdA/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 07:15:28 INFO - Downloaded 59369625 bytes. 07:15:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:28 INFO - mkdir: /builds/slave/test/properties 07:15:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:28 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:28 INFO - Contents: 07:15:28 INFO - build_url:https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:29 INFO - Running post-action listener: _resource_record_post_action 07:15:29 INFO - Running post-action listener: set_extra_try_arguments 07:15:29 INFO - [mozharness: 2016-07-31 14:15:29.324935Z] Finished download-and-extract step (success) 07:15:29 INFO - [mozharness: 2016-07-31 14:15:29.325166Z] Running populate-webroot step. 07:15:29 INFO - Running pre-action listener: _resource_record_pre_action 07:15:29 INFO - Running main action method: populate_webroot 07:15:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:29 INFO - '--tppagecycles', 07:15:29 INFO - '7'], 07:15:29 INFO - 'tests': ['tsvgm']}}, 07:15:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:29 INFO - 'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:29 INFO - 'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['damp', 'tps']}, 07:15:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:29 INFO - 'tests': ['damp', 'tps']}, 07:15:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['dromaeo_dom']}, 07:15:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['basic_compositor_video']}, 07:15:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:15:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['a11yr', 07:15:29 INFO - 'ts_paint', 07:15:29 INFO - 'tpaint', 07:15:29 INFO - 'sessionrestore', 07:15:29 INFO - 'sessionrestore_no_auto_restore', 07:15:29 INFO - 'tabpaint']}, 07:15:29 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:29 INFO - 'ts_paint', 07:15:29 INFO - 'tpaint', 07:15:29 INFO - 'sessionrestore', 07:15:29 INFO - 'sessionrestore_no_auto_restore', 07:15:29 INFO - 'tabpaint']}, 07:15:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:29 INFO - 'ts_paint', 07:15:29 INFO - 'tpaint', 07:15:29 INFO - 'sessionrestore', 07:15:29 INFO - 'sessionrestore_no_auto_restore', 07:15:29 INFO - 'tabpaint']}, 07:15:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:29 INFO - 'ts_paint', 07:15:29 INFO - 'tpaint', 07:15:29 INFO - 'sessionrestore', 07:15:29 INFO - 'sessionrestore_no_auto_restore', 07:15:29 INFO - 'tabpaint']}, 07:15:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['a11yr', 07:15:29 INFO - 'ts_paint', 07:15:29 INFO - 'tpaint', 07:15:29 INFO - 'sessionrestore', 07:15:29 INFO - 'sessionrestore_no_auto_restore', 07:15:29 INFO - 'tabpaint']}, 07:15:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['a11yr', 07:15:29 INFO - 'ts_paint', 07:15:29 INFO - 'tpaint', 07:15:29 INFO - 'sessionrestore', 07:15:29 INFO - 'sessionrestore_no_auto_restore', 07:15:29 INFO - 'tabpaint']}, 07:15:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['tsvgx', 07:15:29 INFO - 'tsvgr_opacity', 07:15:29 INFO - 'tart', 07:15:29 INFO - 'tscrollx', 07:15:29 INFO - 'cart']}, 07:15:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:29 INFO - 'tsvgr_opacity', 07:15:29 INFO - 'tart', 07:15:29 INFO - 'tscrollx', 07:15:29 INFO - 'cart']}, 07:15:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:29 INFO - 'talos_options': ['--disable-e10s'], 07:15:29 INFO - 'tests': ['tp5o']}, 07:15:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:29 INFO - 'tests': ['tp5o']}, 07:15:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:29 INFO - 'talos_options': ['--disable-e10s', 07:15:29 INFO - '--xperf_path', 07:15:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:29 INFO - 'tests': ['tp5n']}, 07:15:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:29 INFO - 'talos_options': ['--xperf_path', 07:15:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:29 INFO - 'tests': ['tp5n']}}, 07:15:29 INFO - 'talos.zip': {'path': '', 07:15:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:29 INFO - Running post-action listener: _resource_record_post_action 07:15:29 INFO - [mozharness: 2016-07-31 14:15:29.341107Z] Finished populate-webroot step (success) 07:15:29 INFO - [mozharness: 2016-07-31 14:15:29.341196Z] Running create-virtualenv step. 07:15:29 INFO - Running pre-action listener: _resource_record_pre_action 07:15:29 INFO - Running main action method: create_virtualenv 07:15:29 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15: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 07:15:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:29 INFO - Using real prefix '/usr' 07:15:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:29 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:31 INFO - Installing pip.................done. 07:15:31 INFO - Return code: 0 07:15:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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 07:15: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 07:15:31 INFO - Using env: {'DISPLAY': ':0', 07:15:31 INFO - 'HOME': '/home/cltbld', 07:15:31 INFO - 'LANG': 'en_US.UTF-8', 07:15:31 INFO - 'LANGUAGE': 'en_US:en', 07:15:31 INFO - 'LOGNAME': 'cltbld', 07:15:31 INFO - 'MAIL': '/var/mail/cltbld', 07:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:31 INFO - 'MOZ_NO_REMOTE': '1', 07:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:31 INFO - 'NO_EM_RESTART': '1', 07:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:31 INFO - 'PWD': '/builds/slave/test', 07:15:31 INFO - 'SHELL': '/bin/bash', 07:15:31 INFO - 'SHLVL': '1', 07:15:31 INFO - 'TERM': 'linux', 07:15:31 INFO - 'TMOUT': '86400', 07:15:31 INFO - 'USER': 'cltbld', 07:15:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:31 INFO - '_': '/tools/buildbot/bin/python'} 07:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15: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 07:15:32 INFO - Cleaning up... 07:15:32 INFO - Return code: 0 07:15:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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 07:15: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 07:15:32 INFO - Using env: {'DISPLAY': ':0', 07:15:32 INFO - 'HOME': '/home/cltbld', 07:15:32 INFO - 'LANG': 'en_US.UTF-8', 07:15:32 INFO - 'LANGUAGE': 'en_US:en', 07:15:32 INFO - 'LOGNAME': 'cltbld', 07:15:32 INFO - 'MAIL': '/var/mail/cltbld', 07:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:32 INFO - 'MOZ_NO_REMOTE': '1', 07:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:32 INFO - 'NO_EM_RESTART': '1', 07:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:32 INFO - 'PWD': '/builds/slave/test', 07:15:32 INFO - 'SHELL': '/bin/bash', 07:15:32 INFO - 'SHLVL': '1', 07:15:32 INFO - 'TERM': 'linux', 07:15:32 INFO - 'TMOUT': '86400', 07:15:32 INFO - 'USER': 'cltbld', 07:15:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:32 INFO - '_': '/tools/buildbot/bin/python'} 07:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:32 INFO - Downloading/unpacking psutil>=3.1.1 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:34 INFO - Installing collected packages: psutil 07:15:34 INFO - Running setup.py install for psutil 07:15:34 INFO - building 'psutil._psutil_linux' extension 07:15: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 07:15: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 07:15:34 INFO - building 'psutil._psutil_posix' extension 07:15: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 07:15: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 07:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:34 INFO - Successfully installed psutil 07:15:34 INFO - Cleaning up... 07:15:34 INFO - Return code: 0 07:15:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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 07:15: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 07:15:34 INFO - Using env: {'DISPLAY': ':0', 07:15:34 INFO - 'HOME': '/home/cltbld', 07:15:34 INFO - 'LANG': 'en_US.UTF-8', 07:15:34 INFO - 'LANGUAGE': 'en_US:en', 07:15:34 INFO - 'LOGNAME': 'cltbld', 07:15:34 INFO - 'MAIL': '/var/mail/cltbld', 07:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:34 INFO - 'MOZ_NO_REMOTE': '1', 07:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:34 INFO - 'NO_EM_RESTART': '1', 07:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:34 INFO - 'PWD': '/builds/slave/test', 07:15:34 INFO - 'SHELL': '/bin/bash', 07:15:34 INFO - 'SHLVL': '1', 07:15:34 INFO - 'TERM': 'linux', 07:15:34 INFO - 'TMOUT': '86400', 07:15:34 INFO - 'USER': 'cltbld', 07:15:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:34 INFO - '_': '/tools/buildbot/bin/python'} 07:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:15:37 INFO - Installing collected packages: mozsystemmonitor 07:15:37 INFO - Running setup.py install for mozsystemmonitor 07:15:37 INFO - Successfully installed mozsystemmonitor 07:15:37 INFO - Cleaning up... 07:15:37 INFO - Return code: 0 07:15:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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 07:15: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 07:15:37 INFO - Using env: {'DISPLAY': ':0', 07:15:37 INFO - 'HOME': '/home/cltbld', 07:15:37 INFO - 'LANG': 'en_US.UTF-8', 07:15:37 INFO - 'LANGUAGE': 'en_US:en', 07:15:37 INFO - 'LOGNAME': 'cltbld', 07:15:37 INFO - 'MAIL': '/var/mail/cltbld', 07:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:37 INFO - 'MOZ_NO_REMOTE': '1', 07:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:37 INFO - 'NO_EM_RESTART': '1', 07:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:37 INFO - 'PWD': '/builds/slave/test', 07:15:37 INFO - 'SHELL': '/bin/bash', 07:15:37 INFO - 'SHLVL': '1', 07:15:37 INFO - 'TERM': 'linux', 07:15:37 INFO - 'TMOUT': '86400', 07:15:37 INFO - 'USER': 'cltbld', 07:15:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:37 INFO - '_': '/tools/buildbot/bin/python'} 07:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:37 INFO - Downloading/unpacking jsonschema==2.5.1 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:39 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:39 INFO - warning: no files found matching '*.txt' 07:15:39 INFO - no previously-included directories found matching 'build' 07:15:39 INFO - no previously-included directories found matching 'dist' 07:15:39 INFO - no previously-included directories found matching '.git*' 07:15:39 INFO - Installing collected packages: jsonschema, functools32 07:15:39 INFO - Running setup.py install for functools32 07:15:39 INFO - warning: no files found matching '*.txt' 07:15:39 INFO - no previously-included directories found matching 'build' 07:15:39 INFO - no previously-included directories found matching 'dist' 07:15:39 INFO - no previously-included directories found matching '.git*' 07:15:39 INFO - Successfully installed jsonschema functools32 07:15:39 INFO - Cleaning up... 07:15:39 INFO - Return code: 0 07:15:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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 07:15: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 07:15:39 INFO - Using env: {'DISPLAY': ':0', 07:15:39 INFO - 'HOME': '/home/cltbld', 07:15:39 INFO - 'LANG': 'en_US.UTF-8', 07:15:39 INFO - 'LANGUAGE': 'en_US:en', 07:15:39 INFO - 'LOGNAME': 'cltbld', 07:15:39 INFO - 'MAIL': '/var/mail/cltbld', 07:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:39 INFO - 'MOZ_NO_REMOTE': '1', 07:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:39 INFO - 'NO_EM_RESTART': '1', 07:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:39 INFO - 'PWD': '/builds/slave/test', 07:15:39 INFO - 'SHELL': '/bin/bash', 07:15:39 INFO - 'SHLVL': '1', 07:15:39 INFO - 'TERM': 'linux', 07:15:39 INFO - 'TMOUT': '86400', 07:15:39 INFO - 'USER': 'cltbld', 07:15:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:39 INFO - '_': '/tools/buildbot/bin/python'} 07:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:15:39 INFO - Cleaning up... 07:15:39 INFO - Return code: 0 07:15:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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', '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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:15: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 blobuploader==1.2.4 07:15:39 INFO - Using env: {'DISPLAY': ':0', 07:15:39 INFO - 'HOME': '/home/cltbld', 07:15:39 INFO - 'LANG': 'en_US.UTF-8', 07:15:39 INFO - 'LANGUAGE': 'en_US:en', 07:15:39 INFO - 'LOGNAME': 'cltbld', 07:15:39 INFO - 'MAIL': '/var/mail/cltbld', 07:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:39 INFO - 'MOZ_NO_REMOTE': '1', 07:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:39 INFO - 'NO_EM_RESTART': '1', 07:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:39 INFO - 'PWD': '/builds/slave/test', 07:15:39 INFO - 'SHELL': '/bin/bash', 07:15:39 INFO - 'SHLVL': '1', 07:15:39 INFO - 'TERM': 'linux', 07:15:39 INFO - 'TMOUT': '86400', 07:15:39 INFO - 'USER': 'cltbld', 07:15:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:39 INFO - '_': '/tools/buildbot/bin/python'} 07:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:40 INFO - Downloading/unpacking blobuploader==1.2.4 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:42 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:42 INFO - Downloading docopt-0.6.1.tar.gz 07:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:42 INFO - Running setup.py install for blobuploader 07:15:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:42 INFO - Running setup.py install for requests 07:15:43 INFO - Running setup.py install for docopt 07:15:43 INFO - Successfully installed blobuploader requests docopt 07:15:43 INFO - Cleaning up... 07:15:43 INFO - Return code: 0 07:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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 07:15: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 07:15:43 INFO - Using env: {'DISPLAY': ':0', 07:15:43 INFO - 'HOME': '/home/cltbld', 07:15:43 INFO - 'LANG': 'en_US.UTF-8', 07:15:43 INFO - 'LANGUAGE': 'en_US:en', 07:15:43 INFO - 'LOGNAME': 'cltbld', 07:15:43 INFO - 'MAIL': '/var/mail/cltbld', 07:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:43 INFO - 'MOZ_NO_REMOTE': '1', 07:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:43 INFO - 'NO_EM_RESTART': '1', 07:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:43 INFO - 'PWD': '/builds/slave/test', 07:15:43 INFO - 'SHELL': '/bin/bash', 07:15:43 INFO - 'SHLVL': '1', 07:15:43 INFO - 'TERM': 'linux', 07:15:43 INFO - 'TMOUT': '86400', 07:15:43 INFO - 'USER': 'cltbld', 07:15:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:43 INFO - '_': '/tools/buildbot/bin/python'} 07:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:43 INFO - Running setup.py (path:/tmp/pip-2D9909-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:43 INFO - Running setup.py (path:/tmp/pip-pCgpLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:43 INFO - Running setup.py (path:/tmp/pip-KNnVUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:43 INFO - Running setup.py (path:/tmp/pip-XNZuVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:43 INFO - Running setup.py (path:/tmp/pip-qYzJVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:43 INFO - Running setup.py (path:/tmp/pip-Mt0uAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:44 INFO - Running setup.py (path:/tmp/pip-KXUbAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:44 INFO - Running setup.py (path:/tmp/pip-OW1TWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:44 INFO - Running setup.py (path:/tmp/pip-3EXfdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:44 INFO - Running setup.py (path:/tmp/pip-FR7MGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:44 INFO - Running setup.py (path:/tmp/pip-u4yzJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:44 INFO - Running setup.py (path:/tmp/pip-AGXKFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:44 INFO - Running setup.py (path:/tmp/pip-VafYVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:44 INFO - Running setup.py (path:/tmp/pip-nWlNgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:44 INFO - Running setup.py (path:/tmp/pip-K8A84r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:44 INFO - Running setup.py (path:/tmp/pip-PPRDNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:44 INFO - Running setup.py (path:/tmp/pip-ie15V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:44 INFO - Running setup.py install for manifestparser 07:15:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozcrash 07:15:45 INFO - Running setup.py install for mozdebug 07:15:45 INFO - Running setup.py install for mozdevice 07:15:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozfile 07:15:45 INFO - Running setup.py install for mozhttpd 07:15:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozinfo 07:15:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozInstall 07:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozleak 07:15:45 INFO - Running setup.py install for mozlog 07:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for moznetwork 07:15:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Running setup.py install for mozprocess 07:15:46 INFO - Running setup.py install for mozprofile 07:15:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Running setup.py install for mozrunner 07:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Running setup.py install for mozscreenshot 07:15:46 INFO - Running setup.py install for moztest 07:15:46 INFO - Running setup.py install for mozversion 07:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:46 INFO - Cleaning up... 07:15:46 INFO - Return code: 0 07:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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 07:15: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 07:15:46 INFO - Using env: {'DISPLAY': ':0', 07:15:46 INFO - 'HOME': '/home/cltbld', 07:15:46 INFO - 'LANG': 'en_US.UTF-8', 07:15:46 INFO - 'LANGUAGE': 'en_US:en', 07:15:46 INFO - 'LOGNAME': 'cltbld', 07:15:46 INFO - 'MAIL': '/var/mail/cltbld', 07:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:46 INFO - 'MOZ_NO_REMOTE': '1', 07:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:46 INFO - 'NO_EM_RESTART': '1', 07:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:46 INFO - 'PWD': '/builds/slave/test', 07:15:46 INFO - 'SHELL': '/bin/bash', 07:15:46 INFO - 'SHLVL': '1', 07:15:46 INFO - 'TERM': 'linux', 07:15:46 INFO - 'TMOUT': '86400', 07:15:46 INFO - 'USER': 'cltbld', 07:15:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:46 INFO - '_': '/tools/buildbot/bin/python'} 07:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:46 INFO - Running setup.py (path:/tmp/pip-FKmN22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:46 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)) 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:46 INFO - Running setup.py (path:/tmp/pip-e2HfP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:47 INFO - Running setup.py (path:/tmp/pip-WOfGLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:47 INFO - Running setup.py (path:/tmp/pip-kNOmK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:47 INFO - Running setup.py (path:/tmp/pip-E92ci2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:47 INFO - Running setup.py (path:/tmp/pip-9RqRIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:47 INFO - Running setup.py (path:/tmp/pip-3r3An8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:47 INFO - Running setup.py (path:/tmp/pip-DBTzYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:47 INFO - Running setup.py (path:/tmp/pip-giugwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:47 INFO - Running setup.py (path:/tmp/pip-4DC_wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:47 INFO - Running setup.py (path:/tmp/pip-KfWsQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:47 INFO - Running setup.py (path:/tmp/pip-pWipbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:47 INFO - Running setup.py (path:/tmp/pip-7xTLjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15: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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:47 INFO - Running setup.py (path:/tmp/pip-4g4tQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:47 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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:47 INFO - Running setup.py (path:/tmp/pip-ErrUVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:47 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)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:48 INFO - Running setup.py (path:/tmp/pip-CfIMih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15: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)) 07:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:48 INFO - Running setup.py (path:/tmp/pip-QQucLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:50 INFO - Downloading blessings-1.6.tar.gz 07:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:50 INFO - Installing collected packages: blessings 07:15:50 INFO - Running setup.py install for blessings 07:15:50 INFO - Successfully installed blessings 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:50 INFO - Reading from file tmpfile_stdout 07:15:50 INFO - Current package versions: 07:15:50 INFO - argparse == 1.2.1 07:15:50 INFO - blessings == 1.6 07:15:50 INFO - blobuploader == 1.2.4 07:15:50 INFO - docopt == 0.6.1 07:15:50 INFO - functools32 == 3.2.3-2 07:15:50 INFO - jsonschema == 2.5.1 07:15:50 INFO - manifestparser == 1.1 07:15:50 INFO - mozInstall == 1.12 07:15:50 INFO - mozcrash == 0.17 07:15:50 INFO - mozdebug == 0.1 07:15:50 INFO - mozdevice == 0.48 07:15:50 INFO - mozfile == 1.2 07:15:50 INFO - mozhttpd == 0.7 07:15:50 INFO - mozinfo == 0.9 07:15:50 INFO - mozleak == 0.1 07:15:50 INFO - mozlog == 3.3 07:15:50 INFO - moznetwork == 0.27 07:15:50 INFO - mozprocess == 0.23 07:15:50 INFO - mozprofile == 0.28 07:15:50 INFO - mozrunner == 6.12 07:15:50 INFO - mozscreenshot == 0.1 07:15:50 INFO - mozsystemmonitor == 0.3 07:15:50 INFO - moztest == 0.7 07:15:50 INFO - mozversion == 1.4 07:15:50 INFO - psutil == 3.1.1 07:15:50 INFO - requests == 1.2.3 07:15:50 INFO - wsgiref == 0.1.2 07:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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 07:15: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 07:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x223f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', '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 07:15: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 07:15: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 07:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Running post-action listener: _resource_record_post_action 07:15:50 INFO - Running post-action listener: _start_resource_monitoring 07:15:50 INFO - Starting resource monitoring. 07:15:50 INFO - [mozharness: 2016-07-31 14:15:50.945858Z] Finished create-virtualenv step (success) 07:15:50 INFO - [mozharness: 2016-07-31 14:15:50.946346Z] Running install step. 07:15:50 INFO - Running pre-action listener: _resource_record_pre_action 07:15:50 INFO - Running main action method: install 07:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:51 INFO - Reading from file tmpfile_stdout 07:15:51 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:51 INFO - Reading from file tmpfile_stdout 07:15:51 INFO - Output received: 07:15:51 INFO - Usage: mozinstall [options] installer 07:15:51 INFO - Options: 07:15:51 INFO - -h, --help show this help message and exit 07:15:51 INFO - -d DEST, --destination=DEST 07:15:51 INFO - Directory to install application into. [default: 07:15:51 INFO - "/builds/slave/test"] 07:15:51 INFO - --app=APP Application being installed. [default: firefox] 07:15:51 INFO - mkdir: /builds/slave/test/build/application 07:15: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'] 07:15: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 07:16:08 INFO - Reading from file tmpfile_stdout 07:16:08 INFO - Output received: 07:16:08 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:08 INFO - Running post-action listener: _resource_record_post_action 07:16:08 INFO - [mozharness: 2016-07-31 14:16:08.205969Z] Finished install step (success) 07:16:08 INFO - [mozharness: 2016-07-31 14:16:08.206241Z] Running run-tests step. 07:16:08 INFO - Running pre-action listener: _resource_record_pre_action 07:16:08 INFO - Running main action method: run_tests 07:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:08 INFO - Python 2.7.3 07:16:08 INFO - Return code: 0 07:16:08 INFO - grabbing minidump binary from tooltool 07:16: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')]} 07:16: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 0x24fe3b0>, '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 0x24ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ff740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16: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 07:16: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 07:16: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 07:16:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:08 INFO - Return code: 0 07:16:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16: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/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 07:16: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/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 07:16:08 INFO - Using env: {'DISPLAY': ':0', 07:16:08 INFO - 'HOME': '/home/cltbld', 07:16:08 INFO - 'LANG': 'en_US.UTF-8', 07:16:08 INFO - 'LANGUAGE': 'en_US:en', 07:16:08 INFO - 'LOGNAME': 'cltbld', 07:16:08 INFO - 'MAIL': '/var/mail/cltbld', 07:16:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:08 INFO - 'MOZ_NO_REMOTE': '1', 07:16:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:08 INFO - 'NO_EM_RESTART': '1', 07:16:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:08 INFO - 'PWD': '/builds/slave/test', 07:16:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:08 INFO - 'SHELL': '/bin/bash', 07:16:08 INFO - 'SHLVL': '1', 07:16:08 INFO - 'TERM': 'linux', 07:16:08 INFO - 'TMOUT': '86400', 07:16:08 INFO - 'USER': 'cltbld', 07:16:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147', 07:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:08 INFO - '_': '/tools/buildbot/bin/python'} 07:16: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/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 07:16:08 INFO - mozversion application_buildid: 20160731043003 07:16:08 INFO - mozversion application_changeset: 34f662c8a932551e07a6c66853b9f696b5906f42 07:16:08 INFO - mozversion application_display_name: Nightly 07:16:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:08 INFO - mozversion application_name: Firefox 07:16:08 INFO - mozversion application_remotingname: firefox 07:16:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:16:08 INFO - mozversion application_vendor: Mozilla 07:16:08 INFO - mozversion application_version: 50.0a1 07:16:08 INFO - mozversion platform_buildid: 20160731043003 07:16:08 INFO - mozversion platform_changeset: 34f662c8a932551e07a6c66853b9f696b5906f42 07:16:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:16:08 INFO - mozversion platform_version: 50.0a1 07:16:08 INFO - using testdate: 1469974568 07:16:08 INFO - actual date: 1469974568 07:16:08 INFO - starting webserver on 'localhost:59097' 07:16:08 INFO - SUITE-START | Running 2 tests 07:16:08 INFO - TEST-START | dromaeo_css 07:16:08 INFO - operating with platform_type : linux_ 07:16:08 INFO - Initialising browser for dromaeo_css test... 07:16:08 INFO - TEST-INFO | started process 14987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYen58/profile http://localhost:59097/getInfo.html) 07:16:12 INFO - PROCESS | 14987 | __metrics Screen width/height:1600/1200 07:16:12 INFO - PROCESS | 14987 | colorDepth:24 07:16:12 INFO - PROCESS | 14987 | Browser inner width/height: 1024/697 07:16:12 INFO - PROCESS | 14987 | __metrics 07:16:13 INFO - PROCESS | 14987 | 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" 07:16:13 INFO - PROCESS | 14987 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:16:14 INFO - TEST-INFO | 14987: exit 0 07:16:14 INFO - Browser initialized. 07:16:14 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:14 INFO - TEST-INFO | started process 15068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYen58/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:26 INFO - PROCESS | 15068 | RSS: Main: 156078080 07:16:26 INFO - PROCESS | 15068 | 07:17:17 INFO - PROCESS | 15068 | 1469974637025 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] 07:19:26 INFO - PROCESS | 15068 | Cycle 1(1): loaded http://localhost:59097/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59097/tests/dromaeo/cssquery-ext.html) 07:19:27 INFO - PROCESS | 15068 | RSS: Main: 264982528 07:19:27 INFO - PROCESS | 15068 | 07:22:29 INFO - PROCESS | 15068 | Cycle 1(1): loaded http://localhost:59097/tests/dromaeo/cssquery-ext.html (next: http://localhost:59097/tests/dromaeo/cssquery-jquery.html) 07:22:30 INFO - PROCESS | 15068 | RSS: Main: 239783936 07:22:30 INFO - PROCESS | 15068 | 07:25:32 INFO - PROCESS | 15068 | Cycle 1(1): loaded http://localhost:59097/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59097/tests/dromaeo/cssquery-mootools.html) 07:25:32 INFO - PROCESS | 15068 | RSS: Main: 184512512 07:25:32 INFO - PROCESS | 15068 | 07:28:34 INFO - PROCESS | 15068 | Cycle 1(1): loaded http://localhost:59097/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59097/tests/dromaeo/cssquery-prototype.html) 07:28:35 INFO - PROCESS | 15068 | RSS: Main: 182972416 07:28:35 INFO - PROCESS | 15068 | 07:31:38 INFO - PROCESS | 15068 | Cycle 1(1): loaded http://localhost:59097/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59097/tests/dromaeo/cssquery-yui.html) 07:31:38 INFO - PROCESS | 15068 | RSS: Main: 187768832 07:31:38 INFO - PROCESS | 15068 | 07:34:41 INFO - PROCESS | 15068 | Cycle 1(1): loaded http://localhost:59097/tests/dromaeo/cssquery-yui.html (next: http://localhost:59097/tests/dromaeo/cssquery-dojo.html) 07:34:41 INFO - PROCESS | 15068 | RSS: Main: 276074496 07:34:41 INFO - PROCESS | 15068 | 07:34:41 INFO - PROCESS | 15068 | __start_tp_report 07:34:41 INFO - PROCESS | 15068 | _x_x_mozilla_page_load 07:34:41 INFO - PROCESS | 15068 | _x_x_mozilla_page_load_details 07:34:41 INFO - PROCESS | 15068 | |i|pagename|runs| 07:34:41 INFO - PROCESS | 15068 | |0;dojo.html;2996.0712179224433;3017.7133172348617;3027.4399236141307;3043.3608942122155;3057.1898446911573;5090.287359769626;5146.871328216796;5189.688618682877;5274.894502109961;5341.1988201769755;5229.084910140729;5247.658902171365;5287;5292.285541451913;5293.867653308669;4694.6713730039;4774.546418090275;4792.233242681172;4807.134715751164;4913.852584422473;4866.075445665312;4868.56182943535;4876.97561512192;4888.437829649601;4915.950840491585;4662.347271382009;4721.787519561593;4833.444153922309;4860.076585448771;4869.63477739171;4751.857444276678;4754.857354279377;4757.6907501012665;4761.8095276188915;4809.75951202442;4769.165396055676;4803.56767890888;4806.735629540374;4811.350467686852;4848.030393921194;5113.360829896263;5159.045576568347;5288.68267903927;5288.762005709752;5317.521423071903;5611.438856114397;5632.04255276604;5634.7182640867795;5637.154426836008;5639.351474580394;5592.245046918654;5685.772569097231;5685.971570142123;5693.658380497183;5697.173909783059;5103.464136265676;5214.478552144793;5240.266362709223;5249.081410753103;5322.813701520467;5775.797847075332;5813.593048486566;5821.679807610622;5822.883542329129;5837.795677151279;5541.5843811714285;5576.10782274834;5596.972015139898;5606.074997625346;5614.887702245932;5396.622236443412;5529.4470552944385;5561.388247292794;5562.666240025612;5653.23681303027;5566.997940370691;5570.470805273492;5573.693446860461;5582.581306402036;5621.100623900156;5536;5570.387257401682;5576.247206627135;5580.079286917613;5618.6628802272;4179.059711564934;4210.957890421118;4251.914961700749;4290.163418133497;4414.09511050234;3859.7684138951754;3864.864729734502;3893.863714770026;3902.726809123334;3913.0608653922855;5264.6314757966575;5269.683818970874;5278.366596008504;5282.973585132127;5317.335333083364;5478.561715062785;5534.557235421156;5586.944130558642;5596.076647353222;5633;5305.734713264322;5310.044192045391;5324.227986941949;5325.227841962894;5338.91991620126;4907.312976183337;4909.582685471703;4920.6309526785635;4922.72924989129;4962.230854217602;5685.260916080883;5740.885182296331;5859.501942334864;5859.677717725481;5878.588498805043;5619.775208991595;5626.2967129108865;5631.915521267266;5654.85862853432;5676.687782171855;5889.587728858939;5892.086726557391;5894.587378883437;5897.233359663216;5900.675462849585;5343.064963631271;5482.314710661168;5527.53015993645;5556.972215138899;5561.249231353715;5647.491725744702;5688.459596338341;5691.971540142273;5722.971385143048;5737.426257374229;5515.944840551703;5524.33707955048;5540.91688624679;5547.41752116022;5549.972250138723;5279.208118782213;5397.514223719884;5470.097433923358;5528.834134975958;5535.612507124462;5444.537214336826;5459.508644222039;5469;5498.642588231752;5519.586031047607;5515.61390702647;5529.612927095065;5576.10782274834;5583.916241256466;5600.27196464457;5341.278927344914;5418.295621569171;5418.83743487696;5430.13117901134;5436.456354364532 07:34:41 INFO - PROCESS | 15068 | |1;ext.html;586.2027642406326;609.1958614628691;625.4808508937582;632.7469012395044;653.8626888353446;32773;34790.82604586973;34806.30387392254;34812.477812832825;35136.82431587842;36280.45579316312;36982.26035479289;45904.54095459053;46695;46871.296930545985;8840.469571825679;8978.41640293382;8979.910200898006;8980.955095224548;8984.775380615472;8892.066333035034;8977.281817454621;8981.820363592724;8985.820283594325;8992.05583413742;8074.071481779582;10687.83968240477;10937.56249750009;10954.452277386099;11224.551017959313;10860.239783215138;10897.128229741602;10908.836367454414;10923;10935.671929842118;10688.465576721133;10749.677509674722;10758.838617420744;10759.51582178796;10765.3540787553;33418.164545886306;43139.56860431387;43519.56480435187;43522.78238608818;46480.3027954581;3300.9174770630925;3309.3138523399157;3397.96602033979;3483.2685136121445;3782.5082739244;32916.341673166644;33326.50010249848;34156.14609634754;34162;34256.48615270773;4366.432363792686;4446.888827779331;4460.15257101153;4498.842540511099;4548.113117942003;371757.1412142949;372569;373016;376672;376951;58435.415645843;59166.40833591695;59262.70368648129;59360.703196483744;59419;62002.069968950505;62039;62110.689446552475;62121;62162;15430.151341676092;15833.050016999017;15858.841411585967;15863.12752798584;15870;12477.812832807514;12486.188397754117;12497.25016499013;12507.499700011898;12507.937460312822;14185.290735463186;14906.850931490762;15832.445864394691;15848.841511584968;15973.520794376187;6147.508199344042;6384.808455746335;6483.546151769331;6503.2521260054755;6599.142111525471;873.6199753107419;965.2519297544459;966.7196513011148;1030.7792472428855;1040.2641054027858;33084;33266;33400.498992514644;33655.99032029043;33960.83019584886;970.2819913264275;1069.893010698924;1100.5047728522197;1104.9558017679365;1144.6909334479644;16770.01379064034;17531.29874805019;17566.38517651876;17573.560660983578;17658.646827063385;542689;545634;547160;547471.7879231814;548230;53385.46614533805;60113.699431502566;60147.39852601506;60477;61342;1333.2134040915905;1337.411538922871;1341.5975207437925;1354.3025341948903;1378.8207533020643;29778.10665680033;30977.0706878794;31069.844650777504;31267.37465250637;32018;51536.48463515317;51943.48056519538;52054.73972630112;52270.215946760065;52298.477015229364;484843;498228;498333;677846;687973;26441.7355826447;26474.735252647228;26619;26788.732112678623;26823.463530729667;45214.77392613016;45341.093178136915;46700.53299466962;47170.76414618042;47246.291305629755;38899.61100389073;39332;39524.40713389244;40715.1856962865;41174;39136.2172756549;39252.41121383238;39878.2024359517;40030;41328.58671413247;38303.233935321696;39657.40513892236;40117.398239027025;40155.19689606133;40182.1963560733;32093.35813283768;35070.12324691801;35392.29215415729;36031.63968360388;36055.09862253465;26600.467990640467;26699.19902402931;26924.461510769284;26966.191014269603;27315.45369092567 07:34:41 INFO - PROCESS | 15068 | |2;jquery.html;348.2060901145386;360.9440536716808;369.5989851011651;380.9809509524524;381.8167279705741;14791.482298119568;18900.527486812818;19295.903520482378;20263.392098237076;20459.48851278719;18823.43529694108;20050.29823956162;20151.697724534144;20240.190392384324;20251.696224556606;5431.565474762029;5680.346760122577;5684.602077854552;5685.800996965107;5687.459691329317;5417.674939503642;5530.695811730353;5559.722013899309;5565.721713914309;5592.356878958911;5497.780088796443;5528.917066243989;5532.419095994923;5536.086545719952;5536.307961504812;5484.61607687462;5514.6691198528015;5522.116461366182;5548.99999999998;5578.748956296977;4959.876003099916;4963.40439147301;4965.577925876305;4967.801287948478;4968.503149685039;22534.21130260433;23771.16800911977;23781;24041.639375409384;24132.879335603386;2619.6594442722326;2666.5600175971135;2719.3065768228976;3042.6044614200014;3044.0563425338214;14264.928675356661;14797.482088126972;15420.383184672599;15617.141057241846;15675.843241567552;1875.165551329659;1937.321937321926;1976.5651556657513;1977.9319167649453;1991.7709463411747;53644;54218.72890635561;84677.57661211777;85159.57420212921;85253.14746852576;9842;9913.80172396548;10041.849372259421;10175.9491202545;11049.613263535737;14244.643883902985;14267.143971361751;14412.279386030867;14443;14504;7614.505057171266;7866.09539902907;7935.801604959922;8006.3995200360205;8029.116797152308;7671.53970761756;7687.192844751333;7688.846223075507;7986.840263194704;8008.479448835807;6263.846226607616;6300.338464461257;6370.936290637127;6430.967845160744;6517.706703198368;1736.2881218700272;1737.0967097109685;1744.1715185286887;1780.2433965564583;1783.3669047487956;777.4868586732729;932.3799673217235;948.3314263444394;972.1396564040875;1027.917766578672;20439.693404598944;21217.257395991066;21249.36251912445;21422.143114275565;21494.35516934463;977.4477420257674;981.40134517944;1004.8040632076821;1026.2149455666422;1030.5156576409076;11352.94323528377;11674.124440666814;12064.698382540506;12099.516019359304;12111.515539378326;476950;487953;490386;491435;491865;83541;87790.1220987782;90334.54832725794;90636.5468172655;91403;1021.6781713760141;1021.9795604087876;1035.063267742679;1040.6773900090845;1041.9895801042044;17991.820081799015;18182;18882.33911813135;18926.242950281834;19043.90478047601;43252;43570.56429435665;43726.34410483909;44344.55655443404;44778.77610611926;56695.14957275727;57516.42483575111;57908;62893.37106628875;63880.3611963893;8302.584870756316;8407.327413806759;8463.111373305961;8623.051464339043;8758.868616970623;13071.738565228832;13183.80224296617;13880.93059534696;13930.164190148624;14232.288385580887;11900.702482438008;11962.820557691468;12256.203346782431;12349.259044457362;12781.8082728761;11685.76628467443;11698.2981021139;11861.881381186078;11890.643280701594;12207.816882746944;11713.648590542298;12216.816747748613;12264.87735122673;12349.506019759108;12582;8504.744857654281;8537.103604121477;8710.564471776512;8714.259287960595;8980.236679882284;10271.794564108826;11609.187356884937;12113.636590902288;12314.692132696755;12458.563950261698 07:34:41 INFO - PROCESS | 15068 | |3;mootools.html;1360.3266383140344;1460.3574427252008;1527.579915523231;1673.7656728058066;1706.4368758309759;8556.74329770107;9187.402818816781;9196.126367995046;9207.447553146807;9228.953855230731;7480.401567874571;8442.240198382144;8696.173863482974;8702.956485217564;9031.72904812855;2351.423901144222;2374.81001519878;2384.5946189147885;2387.3554140382084;2387.510560335127;2318.976810231893;2336.8714720690355;2404.7835694787464;2411.40920474484;2413.456972181254;2381.868997205153;2384.7972922301624;2395.9760402395927;2399.1123284384716;2406.9037238510527;2312.7340355858955;2318.3392733070996;2322.0131444136173;2323.4075310795724;2365.976340236593;2275.4311422144465;2285.737140228878;2293.598620241451;2316.339843144696;2319.1998760427628;9131.863022054607;9247.630094796268;9266.629334826599;9271;9275;5218.660787048868;5384.461553844623;5389.137737961907;5391.730413479349;5394.786173111019;3276.4921437177277;3279.2785587170783;3295.8846440374473;3334.683205095512;3358.345122701074;1063.2663462211126;1093.3877028863783;1105;1123.6348186839227;1126.048489026771;12477.563285284972;12540.623781286486;12540.74918501634;12540.811887821781;12566.81149782754;4493.123840851068;4619.330197121466;4728.858134255978;4740.762961851894;4772.308015337757;10694.94652526748;10707.196960228013;10711;10713.946430267955;10714.46427678613;5421.674699517963;5426.67439953604;5427.104527752956;5429.511343979061;5435.347758268954;4293.763842988666;4751.904961900743;4849.733264670477;4893.217085266411;4977.402711674622;3956.9208615827524;3982.7411218270718;4083.571225021389;4085.1216988347055;4123.649489793341;1216.3796463803346;1218.872018438069;1257.591282833083;1263.3493750718387;1270.060155484953;783.3185128937747;948.5446985447024;969.6218474794836;974.8635191073255;989.223459584223;6173.629582225081;6178.351273116348;6299.275583307886;6438.3883531064475;6569.018642349568;920.1074957291551;943.4480828715141;945.4138434170858;951.5242378810594;953.9046095390405;4168.8332466701595;4400.647948164139;4413.7793110344355;4483.484399294058;4534.274516077412;11036.172287078502;11301.491432885376;11423.200375973602;11429.257098288585;11430.1998860079;11007.119430445546;11318.26431281964;11372;11399.259048162008;11508.19442639024;8344.457610255315;8380.790480238044;8381.371397145238;8472.872906906401;8518.48889066658;6131.785387511416;6136.5090792737365;6184.165137706532;6247.2815626201755;6294.842628934313;10158.238132140266;10386.48067596602;10402.27184097106;10494.632687856194;10505.684829454824;9998.650047248311;10264.846027309446;10402.167826573705;10609.363438193734;10611.257211995395;7075.398591119607;7841.176676448891;7994.120646728739;8137.186281371815;8232.34141268709;8770.649174032967;8796.164364385373;8821.558922054;8868.201861832466;8907.55462226899;7584.317411432998;7866.72466463671;7872.527648341118;8049.678012879419;8128.796780080545;7254.709811607477;7271.4182865369585;7308.269173082649;7371.447141464304;7383.741569045058;7269.273072692688;7401.96299018523;7415.036045314075;7415.3326200642205;7417.740379086706;4979.651424400402;5175.197844334134;5204.427512973645;5241.68549887008;5443.945560544502;5312.601554883322;5361.785528578969;5386.192071189353;5510.393856675682;5595.524380427709 07:34:41 INFO - PROCESS | 15068 | |4;prototype.html;311.06059699706884;316.1274881327535;317.67438375664943;320.5992509363296;320.9871605135796;5372.9194062089055;5424.240606315114;5433.4023257441695;5453.127499600065;5459.979807471232;5319.414864364927;5319.521243088121;5371.462853714626;5378.569714422846;5381.19282107684;3961.425593288964;4061.1724723874377;4062.939055914149;4075.7758323292205;4079.7348172368847;3570.535830342052;4103.384492326145;4110.335314197755;4150.675621651884;4151.252774500589;4055.634992850643;4056.675465962716;4069.837206511736;4077.532088448156;4077.7145599808027;3893.279743247508;4088.6115818997446;4096.692748043879;4108.931677763788;4111.876643700679;3556.5554305711785;3583.605803361628;3592.8203589820664;3596.8920932371807;3614.2410093880317;5134.0758663440565;5146.632549027415;5147.588192944556;5195.9480405195845;5254.686328417895;4653.840237009393;4717.599004084657;4721.716696998191;4725.31482934976;4729.793902554861;5382.569394448474;5481.972590137024;5511.751971161308;5521.978433989725;5527.613067085305;3938;3958.6635136013474;3963.8414463421427;3976.8011599419915;4009.218202450523;5576.275084239063;5620.85947851307;5891.469767720883;5894.97052514739;5898.970505147447;3627.510286111341;3824.0248736572553;3837.1558257183374;3840.135969406917;3855.5373355197557;3875.418687196943;4049.7367671101283;4051.169510250392;4083.2037752638544;4084.591540845892;4667.556582124693;4667.579917807414;4686.6485013624115;4689.742064186435;4735.176956871629;5417.984366608942;5511.641743286674;5587.217789509472;5590.97204513983;5643.238162848045;1402.3619253239751;1405.7539930512119;1408.6267139208119;1415.9575212743634;1418.9219592922489;881.4534988307163;915.6978197195043;922.5571725571763;929.762910457829;930.1256818590504;4703.084087865545;4726.763661816895;4734.4081989751285;4786.401699787527;4794.547925493639;5062.797683007903;5085.821996230188;5133.307003554547;5136.537711605899;5185.325907631984;4791.712497250176;4833.685810422311;4838.419389673261;4846.733429661332;5006.499350064964;3002.579638850563;3050.771192160597;3052.832094234838;3053.7709671774705;3054.129573071664;5964.910526342108;5978.790742323998;5994.730237139339;6005.279366475964;6023.849403764941;5645.9717701412055;5806.88386232273;5835.2122463466885;5850.635884366507;5876.588638795329;5673;5808.680522571215;5912.6452412854505;5958.285005799332;5972.790952316648;5703.714814259188;5705.515031222227;5758.222639943554;5778.624389414675;5781.335146458211;5519.475649813261;5688.63023903445;5714.885492367851;5720.48515633595;5727.255456790591;5874.206982057368;5882.029465138205;5882.382349853204;5953.76184952597;5989.970050149721;3954.5847685992558;3957.6438120569287;3972.3644216925154;3973.324534829144;3994.121293315466;5495.552731893342;5693.829185124453;5732.713364331683;5750.166225897305;5785.797497087582;5557.583181261502;5562.16567514876;5576.776928922797;5600.243967064394;5659.151127330933;5524.613277070566;5583.497485226349;5601.747921343631;5612.4387561245185;5636.464535869086;5354.732263386893;5518;5535.8892822142525;5543.2793736815565;5561.916571251353;5562.499375056264;5572.804951826666;5595.972020139873;5640.646244901112;5640.928223637496;5280.947190528045;5454.881749241316;5486.1222204447095;5502.257195278587;5512.283403157564 07:34:41 INFO - PROCESS | 15068 | |5;yui.html;706.6678661029316;740.7037185125951;743.3458556470305;789.1713700614354;813.5932033983005;16468.50594482166;17079.146042697877;17814.19836107375;18050.729239061424;18173.273069077222;15802.683946321067;15903.92048039761;15930.044197348167;15933.601659958478;15934.20328983552;809.1584751858061;835.1022650650544;841.0160112668193;841.6380956188837;842.1704620948361;678.3047376439165;801.5391150088693;822.0382152881114;822.8683410654296;832.0722394530115;879.0813599788237;880.8238352329528;881.3566096749377;882.1134759566627;882.2677177942293;873.5894129759004;873.8995015573163;876.8334016536869;877.3069275272527;877.7893305606673;509.1344713986238;621.4344946099028;627.1188979483833;633.0188208277152;641.3874749614107;14739.778903316459;14783.039102458306;14896.404143834234;14962.551123466314;14998.400063997537;14038.157710537298;14318.64203394913;14649;14721.411143554245;14872.776908346383;13679.794803077963;13726.588202353945;13829.30853457323;13984.790228146587;14342.856571434257;4595.425571803525;4644.76776161194;4692.436907571113;4751.667383283171;4777.140114779339;91321;91414;91917.54041229752;92862;92934;10160.13638840692;10210.948945255375;10482.266241363184;10547.208959328082;10569.682909512727;20765.792342076387;20931.26740564073;21015.78984210138;21016.159353625684;21088.78911210899;8252.46358986664;8368.288695460833;8478.703245386505;8499.150084991576;8559.40084194113;4481.686281960297;4493.775311234425;4529.9547004530195;4658.394408726844;4672;3536.1866770642896;3623.1847834237615;3647.8905632831056;3649.8905032849057;3653.50677658518;620.3641267700643;620.959637623553;624.9156363890908;645.7352485481024;656.4223483334634;600.9723373032164;607.6840043177523;694.6687404035832;717.996410017957;752.4695089961564;9597.712068637951;9672.903270967201;9998.400095994264;10050.381862529484;10307.123894469054;685.1538350137577;697.100740045346;703.7783098324012;720.3372896934833;728.7595093619093;4765.142274390573;4791;5035.77339019745;5044.495550444926;5046.7476626168545;115771;124551.37724311501;127759;128407;129715;110451.48043119755;111116.44441777901;111288.4435577833;113246.43376783228;114860;97827;99124.50437747766;99839.50080249697;99976;103259;8734.257588105082;8899.110088991049;9200.714734919022;9278.62885484573;9795.706128816148;50353.49646503488;51792.741036294574;54526.72736636292;54961.725191373785;55014.449855502535;67205;67296.66351668406;73799.63100184465;74654.62672686602;77718.61140694487;13323.200607963554;13785.655358615713;13801.585952421443;13835.271787216408;14150.716985660434;15522.84477155214;15764.527064188092;15847;16085.517434476984;16886.408975686285;14301.681528029689;14392.928035359757;14680.853191468375;15006.849931500981;15017.399304028153;14568.708625827212;14965.77551336709;15008.699826003638;15087.39650414015;15479.916405851482;14393.352299146773;14493.85506144925;14576;14733.631659208606;15009.32458039369;10761.970190268576;11056;11150.330980141218;11185.66443006711;11735.119866009913;10743.516541755484;10939.124810309037;11006.944965275123;11085.667429977113;11120.888791111985 07:34:41 INFO - PROCESS | 15068 | __end_tp_report 07:34:41 INFO - PROCESS | 15068 | __start_cc_report 07:34:41 INFO - PROCESS | 15068 | _x_x_mozilla_cycle_collect,983 07:34:41 INFO - PROCESS | 15068 | __end_cc_report 07:34:41 INFO - PROCESS | 15068 | __startTimestamp1469975681793__endTimestamp 07:34:41 INFO - PROCESS | 15068 | 07:34:41 INFO - PROCESS | 15068 | ------- Summary: start ------- 07:34:41 INFO - PROCESS | 15068 | Number of tests: 6 07:34:41 INFO - PROCESS | 15068 | 07:34:41 INFO - PROCESS | 15068 | [#0] dojo.html Cycles:165 Average:5231.01 Median:5430.13 stddev:592.32 (10.9%) stddev-sans-first:567.60 07:34:41 INFO - PROCESS | 15068 | Values: 2996.1 3017.7 3027.4 3043.4 3057.2 5090.3 5146.9 5189.7 5274.9 5341.2 5229.1 5247.7 5287.0 5292.3 5293.9 4694.7 4774.5 4792.2 4807.1 4913.9 4866.1 4868.6 4877.0 4888.4 4916.0 4662.3 4721.8 4833.4 4860.1 4869.6 4751.9 4754.9 4757.7 4761.8 4809.8 4769.2 4803.6 4806.7 4811.4 4848.0 5113.4 5159.0 5288.7 5288.8 5317.5 5611.4 5632.0 5634.7 5637.2 5639.4 5592.2 5685.8 5686.0 5693.7 5697.2 5103.5 5214.5 5240.3 5249.1 5322.8 5775.8 5813.6 5821.7 5822.9 5837.8 5541.6 5576.1 5597.0 5606.1 5614.9 5396.6 5529.4 5561.4 5562.7 5653.2 5567.0 5570.5 5573.7 5582.6 5621.1 5536.0 5570.4 5576.2 5580.1 5618.7 4179.1 4211.0 4251.9 4290.2 4414.1 3859.8 3864.9 3893.9 3902.7 3913.1 5264.6 5269.7 5278.4 5283.0 5317.3 5478.6 5534.6 5586.9 5596.1 5633.0 5305.7 5310.0 5324.2 5325.2 5338.9 4907.3 4909.6 4920.6 4922.7 4962.2 5685.3 5740.9 5859.5 5859.7 5878.6 5619.8 5626.3 5631.9 5654.9 5676.7 5889.6 5892.1 5894.6 5897.2 5900.7 5343.1 5482.3 5527.5 5557.0 5561.2 5647.5 5688.5 5692.0 5723.0 5737.4 5515.9 5524.3 5540.9 5547.4 5550.0 5279.2 5397.5 5470.1 5528.8 5535.6 5444.5 5459.5 5469.0 5498.6 5519.6 5515.6 5529.6 5576.1 5583.9 5600.3 5341.3 5418.3 5418.8 5430.1 5436.5 07:34:41 INFO - PROCESS | 15068 | 07:34:41 INFO - PROCESS | 15068 | [#1] ext.html Cycles:180 Average:64532.42 Median:376811.50 stddev:135165.03 (35.9%) stddev-sans-first:135458.93 07:34:41 INFO - PROCESS | 15068 | Values: 586.2 609.2 625.5 632.7 653.9 32773.0 34790.8 34806.3 34812.5 35136.8 36280.5 36982.3 45904.5 46695.0 46871.3 8840.5 8978.4 8979.9 8981.0 8984.8 8892.1 8977.3 8981.8 8985.8 8992.1 8074.1 10687.8 10937.6 10954.5 11224.6 10860.2 10897.1 10908.8 10923.0 10935.7 10688.5 10749.7 10758.8 10759.5 10765.4 33418.2 43139.6 43519.6 43522.8 46480.3 3300.9 3309.3 3398.0 3483.3 3782.5 32916.3 33326.5 34156.1 34162.0 34256.5 4366.4 4446.9 4460.2 4498.8 4548.1 371757.1 372569.0 373016.0 376672.0 376951.0 58435.4 59166.4 59262.7 59360.7 59419.0 62002.1 62039.0 62110.7 62121.0 62162.0 15430.2 15833.1 15858.8 15863.1 15870.0 12477.8 12486.2 12497.3 12507.5 12507.9 14185.3 14906.9 15832.4 15848.8 15973.5 6147.5 6384.8 6483.5 6503.3 6599.1 873.6 965.3 966.7 1030.8 1040.3 33084.0 33266.0 33400.5 33656.0 33960.8 970.3 1069.9 1100.5 1105.0 1144.7 16770.0 17531.3 17566.4 17573.6 17658.6 542689.0 545634.0 547160.0 547471.8 548230.0 53385.5 60113.7 60147.4 60477.0 61342.0 1333.2 1337.4 1341.6 1354.3 1378.8 29778.1 30977.1 31069.8 31267.4 32018.0 51536.5 51943.5 52054.7 52270.2 52298.5 484843.0 498228.0 498333.0 677846.0 687973.0 26441.7 26474.7 26619.0 26788.7 26823.5 45214.8 45341.1 46700.5 47170.8 47246.3 38899.6 39332.0 39524.4 40715.2 41174.0 39136.2 39252.4 39878.2 40030.0 41328.6 38303.2 39657.4 40117.4 40155.2 40182.2 32093.4 35070.1 35392.3 36031.6 36055.1 26600.5 26699.2 26924.5 26966.2 27315.5 07:34:41 INFO - PROCESS | 15068 | 07:34:41 INFO - PROCESS | 15068 | [#2] jquery.html Cycles:180 Average:29014.16 Median:3043.33 stddev:80244.69 (2636.7%) stddev-sans-first:80440.93 07:34:41 INFO - PROCESS | 15068 | Values: 348.2 360.9 369.6 381.0 381.8 14791.5 18900.5 19295.9 20263.4 20459.5 18823.4 20050.3 20151.7 20240.2 20251.7 5431.6 5680.3 5684.6 5685.8 5687.5 5417.7 5530.7 5559.7 5565.7 5592.4 5497.8 5528.9 5532.4 5536.1 5536.3 5484.6 5514.7 5522.1 5549.0 5578.7 4959.9 4963.4 4965.6 4967.8 4968.5 22534.2 23771.2 23781.0 24041.6 24132.9 2619.7 2666.6 2719.3 3042.6 3044.1 14264.9 14797.5 15420.4 15617.1 15675.8 1875.2 1937.3 1976.6 1977.9 1991.8 53644.0 54218.7 84677.6 85159.6 85253.1 9842.0 9913.8 10041.8 10175.9 11049.6 14244.6 14267.1 14412.3 14443.0 14504.0 7614.5 7866.1 7935.8 8006.4 8029.1 7671.5 7687.2 7688.8 7986.8 8008.5 6263.8 6300.3 6370.9 6431.0 6517.7 1736.3 1737.1 1744.2 1780.2 1783.4 777.5 932.4 948.3 972.1 1027.9 20439.7 21217.3 21249.4 21422.1 21494.4 977.4 981.4 1004.8 1026.2 1030.5 11352.9 11674.1 12064.7 12099.5 12111.5 476950.0 487953.0 490386.0 491435.0 491865.0 83541.0 87790.1 90334.5 90636.5 91403.0 1021.7 1022.0 1035.1 1040.7 1042.0 17991.8 18182.0 18882.3 18926.2 19043.9 43252.0 43570.6 43726.3 44344.6 44778.8 56695.1 57516.4 57908.0 62893.4 63880.4 8302.6 8407.3 8463.1 8623.1 8758.9 13071.7 13183.8 13880.9 13930.2 14232.3 11900.7 11962.8 12256.2 12349.3 12781.8 11685.8 11698.3 11861.9 11890.6 12207.8 11713.6 12216.8 12264.9 12349.5 12582.0 8504.7 8537.1 8710.6 8714.3 8980.2 10271.8 11609.2 12113.6 12314.7 12458.6 07:34:41 INFO - PROCESS | 15068 | 07:34:41 INFO - PROCESS | 15068 | [#3] mootools.html Cycles:180 Average:5939.68 Median:4811.02 stddev:3401.51 (70.7%) stddev-sans-first:3393.65 07:34:41 INFO - PROCESS | 15068 | Values: 1360.3 1460.4 1527.6 1673.8 1706.4 8556.7 9187.4 9196.1 9207.4 9229.0 7480.4 8442.2 8696.2 8703.0 9031.7 2351.4 2374.8 2384.6 2387.4 2387.5 2319.0 2336.9 2404.8 2411.4 2413.5 2381.9 2384.8 2396.0 2399.1 2406.9 2312.7 2318.3 2322.0 2323.4 2366.0 2275.4 2285.7 2293.6 2316.3 2319.2 9131.9 9247.6 9266.6 9271.0 9275.0 5218.7 5384.5 5389.1 5391.7 5394.8 3276.5 3279.3 3295.9 3334.7 3358.3 1063.3 1093.4 1105.0 1123.6 1126.0 12477.6 12540.6 12540.7 12540.8 12566.8 4493.1 4619.3 4728.9 4740.8 4772.3 10694.9 10707.2 10711.0 10713.9 10714.5 5421.7 5426.7 5427.1 5429.5 5435.3 4293.8 4751.9 4849.7 4893.2 4977.4 3956.9 3982.7 4083.6 4085.1 4123.6 1216.4 1218.9 1257.6 1263.3 1270.1 783.3 948.5 969.6 974.9 989.2 6173.6 6178.4 6299.3 6438.4 6569.0 920.1 943.4 945.4 951.5 953.9 4168.8 4400.6 4413.8 4483.5 4534.3 11036.2 11301.5 11423.2 11429.3 11430.2 11007.1 11318.3 11372.0 11399.3 11508.2 8344.5 8380.8 8381.4 8472.9 8518.5 6131.8 6136.5 6184.2 6247.3 6294.8 10158.2 10386.5 10402.3 10494.6 10505.7 9998.7 10264.8 10402.2 10609.4 10611.3 7075.4 7841.2 7994.1 8137.2 8232.3 8770.6 8796.2 8821.6 8868.2 8907.6 7584.3 7866.7 7872.5 8049.7 8128.8 7254.7 7271.4 7308.3 7371.4 7383.7 7269.3 7402.0 7415.0 7415.3 7417.7 4979.7 5175.2 5204.4 5241.7 5443.9 5312.6 5361.8 5386.2 5510.4 5595.5 07:34:41 INFO - PROCESS | 15068 | 07:34:41 INFO - PROCESS | 15068 | [#4] prototype.html Cycles:180 Average:4626.69 Median:5300.18 stddev:1384.21 (26.1%) stddev-sans-first:1349.66 07:34:41 INFO - PROCESS | 15068 | Values: 311.1 316.1 317.7 320.6 321.0 5372.9 5424.2 5433.4 5453.1 5460.0 5319.4 5319.5 5371.5 5378.6 5381.2 3961.4 4061.2 4062.9 4075.8 4079.7 3570.5 4103.4 4110.3 4150.7 4151.3 4055.6 4056.7 4069.8 4077.5 4077.7 3893.3 4088.6 4096.7 4108.9 4111.9 3556.6 3583.6 3592.8 3596.9 3614.2 5134.1 5146.6 5147.6 5195.9 5254.7 4653.8 4717.6 4721.7 4725.3 4729.8 5382.6 5482.0 5511.8 5522.0 5527.6 3938.0 3958.7 3963.8 3976.8 4009.2 5576.3 5620.9 5891.5 5895.0 5899.0 3627.5 3824.0 3837.2 3840.1 3855.5 3875.4 4049.7 4051.2 4083.2 4084.6 4667.6 4667.6 4686.6 4689.7 4735.2 5418.0 5511.6 5587.2 5591.0 5643.2 1402.4 1405.8 1408.6 1416.0 1418.9 881.5 915.7 922.6 929.8 930.1 4703.1 4726.8 4734.4 4786.4 4794.5 5062.8 5085.8 5133.3 5136.5 5185.3 4791.7 4833.7 4838.4 4846.7 5006.5 3002.6 3050.8 3052.8 3053.8 3054.1 5964.9 5978.8 5994.7 6005.3 6023.8 5646.0 5806.9 5835.2 5850.6 5876.6 5673.0 5808.7 5912.6 5958.3 5972.8 5703.7 5705.5 5758.2 5778.6 5781.3 5519.5 5688.6 5714.9 5720.5 5727.3 5874.2 5882.0 5882.4 5953.8 5990.0 3954.6 3957.6 3972.4 3973.3 3994.1 5495.6 5693.8 5732.7 5750.2 5785.8 5557.6 5562.2 5576.8 5600.2 5659.2 5524.6 5583.5 5601.7 5612.4 5636.5 5354.7 5518.0 5535.9 5543.3 5561.9 5562.5 5572.8 5596.0 5640.6 5640.9 5280.9 5454.9 5486.1 5502.3 5512.3 07:34:41 INFO - PROCESS | 15068 | 07:34:41 INFO - PROCESS | 15068 | [#5] yui.html Cycles:180 Average:22541.60 Median:4562.69 stddev:33419.33 (732.4%) stddev-sans-first:33472.87 07:34:41 INFO - PROCESS | 15068 | Values: 706.7 740.7 743.3 789.2 813.6 16468.5 17079.1 17814.2 18050.7 18173.3 15802.7 15903.9 15930.0 15933.6 15934.2 809.2 835.1 841.0 841.6 842.2 678.3 801.5 822.0 822.9 832.1 879.1 880.8 881.4 882.1 882.3 873.6 873.9 876.8 877.3 877.8 509.1 621.4 627.1 633.0 641.4 14739.8 14783.0 14896.4 14962.6 14998.4 14038.2 14318.6 14649.0 14721.4 14872.8 13679.8 13726.6 13829.3 13984.8 14342.9 4595.4 4644.8 4692.4 4751.7 4777.1 91321.0 91414.0 91917.5 92862.0 92934.0 10160.1 10210.9 10482.3 10547.2 10569.7 20765.8 20931.3 21015.8 21016.2 21088.8 8252.5 8368.3 8478.7 8499.2 8559.4 4481.7 4493.8 4530.0 4658.4 4672.0 3536.2 3623.2 3647.9 3649.9 3653.5 620.4 621.0 624.9 645.7 656.4 601.0 607.7 694.7 718.0 752.5 9597.7 9672.9 9998.4 10050.4 10307.1 685.2 697.1 703.8 720.3 728.8 4765.1 4791.0 5035.8 5044.5 5046.7 115771.0 124551.4 127759.0 128407.0 129715.0 110451.5 111116.4 111288.4 113246.4 114860.0 97827.0 99124.5 99839.5 99976.0 103259.0 8734.3 8899.1 9200.7 9278.6 9795.7 50353.5 51792.7 54526.7 54961.7 55014.4 67205.0 67296.7 73799.6 74654.6 77718.6 13323.2 13785.7 13801.6 13835.3 14150.7 15522.8 15764.5 15847.0 16085.5 16886.4 14301.7 14392.9 14680.9 15006.8 15017.4 14568.7 14965.8 15008.7 15087.4 15479.9 14393.4 14493.9 14576.0 14733.6 15009.3 10762.0 11056.0 11150.3 11185.7 11735.1 10743.5 10939.1 11006.9 11085.7 11120.9 07:34:41 INFO - PROCESS | 15068 | -------- Summary: end -------- 07:34:41 INFO - PROCESS | 15068 | 07:34:42 INFO - TEST-INFO | 15068: exit 0 07:34:42 INFO - TEST-OK | dromaeo_css | took 1114139ms 07:34:42 INFO - TEST-START | kraken 07:34:42 INFO - operating with platform_type : linux_ 07:34:42 INFO - Initialising browser for kraken test... 07:34:42 INFO - TEST-INFO | started process 15269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXMPHQ/profile http://localhost:59097/getInfo.html) 07:34:46 INFO - PROCESS | 15269 | __metrics Screen width/height:1600/1200 07:34:46 INFO - PROCESS | 15269 | colorDepth:24 07:34:46 INFO - PROCESS | 15269 | Browser inner width/height: 1024/697 07:34:46 INFO - PROCESS | 15269 | __metrics 07:34:47 INFO - PROCESS | 15269 | 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" 07:34:47 INFO - PROCESS | 15269 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:34:48 INFO - TEST-INFO | 15269: exit 0 07:34:48 INFO - Browser initialized. 07:34:48 INFO - Running cycle 1/1 for kraken test... 07:34:48 INFO - TEST-INFO | started process 15347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXMPHQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:00 INFO - PROCESS | 15347 | RSS: Main: 156119040 07:35:00 INFO - PROCESS | 15347 | 07:35:02 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59097/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:03 INFO - PROCESS | 15347 | RSS: Main: 212758528 07:35:03 INFO - PROCESS | 15347 | 07:35:06 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59097/tests/kraken/driver.html?testName=audio-dft) 07:35:07 INFO - PROCESS | 15347 | RSS: Main: 187056128 07:35:07 INFO - PROCESS | 15347 | 07:35:10 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59097/tests/kraken/driver.html?testName=audio-fft) 07:35:10 INFO - PROCESS | 15347 | RSS: Main: 269877248 07:35:10 INFO - PROCESS | 15347 | 07:35:12 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59097/tests/kraken/driver.html?testName=audio-oscillator) 07:35:13 INFO - PROCESS | 15347 | RSS: Main: 179499008 07:35:13 INFO - PROCESS | 15347 | 07:35:15 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59097/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:16 INFO - PROCESS | 15347 | RSS: Main: 184045568 07:35:16 INFO - PROCESS | 15347 | 07:35:19 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59097/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:19 INFO - PROCESS | 15347 | RSS: Main: 219586560 07:35:19 INFO - PROCESS | 15347 | 07:35:23 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59097/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:23 INFO - PROCESS | 15347 | RSS: Main: 219926528 07:35:23 INFO - PROCESS | 15347 | 07:35:26 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59097/tests/kraken/driver.html?testName=json-parse-financial) 07:35:27 INFO - PROCESS | 15347 | RSS: Main: 219901952 07:35:27 INFO - PROCESS | 15347 | 07:35:28 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59097/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:29 INFO - PROCESS | 15347 | RSS: Main: 184135680 07:35:29 INFO - PROCESS | 15347 | 07:35:31 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59097/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:31 INFO - PROCESS | 15347 | RSS: Main: 188973056 07:35:31 INFO - PROCESS | 15347 | 07:35:33 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59097/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:34 INFO - PROCESS | 15347 | RSS: Main: 194584576 07:35:34 INFO - PROCESS | 15347 | 07:35:36 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59097/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:37 INFO - PROCESS | 15347 | RSS: Main: 187527168 07:35:37 INFO - PROCESS | 15347 | 07:35:40 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59097/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:40 INFO - PROCESS | 15347 | RSS: Main: 192397312 07:35:40 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | Cycle 1(1): loaded http://localhost:59097/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59097/tests/kraken/driver.html?testName=ai-astar) 07:35:42 INFO - PROCESS | 15347 | RSS: Main: 243519488 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | __start_tp_report 07:35:42 INFO - PROCESS | 15347 | _x_x_mozilla_page_load 07:35:42 INFO - PROCESS | 15347 | _x_x_mozilla_page_load_details 07:35:42 INFO - PROCESS | 15347 | |i|pagename|runs| 07:35:42 INFO - PROCESS | 15347 | |0;ai-astar;105;114;114;113;129;134;116;112;111;111 07:35:42 INFO - PROCESS | 15347 | |1;audio-beat-detection;146;117;117;182;123;123;150;118;173;116 07:35:42 INFO - PROCESS | 15347 | |2;audio-dft;161;158;160;161;161;160;160;160;161;159 07:35:42 INFO - PROCESS | 15347 | |3;audio-fft;75;75;74;108;75;75;74;75;98;75 07:35:42 INFO - PROCESS | 15347 | |4;audio-oscillator;86;85;121;84;84;85;119;84;84;127 07:35:42 INFO - PROCESS | 15347 | |5;imaging-gaussian-blur;117;116;116;116;116;117;116;117;117;117 07:35:42 INFO - PROCESS | 15347 | |6;imaging-darkroom;146;146;145;145;145;146;145;146;145;146 07:35:42 INFO - PROCESS | 15347 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;94 07:35:42 INFO - PROCESS | 15347 | |8;json-parse-financial;54;53;52;54;54;56;52;53;53;52 07:35:42 INFO - PROCESS | 15347 | |9;json-stringify-tinderbox;62;63;62;61;62;63;62;62;66;63 07:35:42 INFO - PROCESS | 15347 | |10;stanford-crypto-aes;76;85;76;76;75;76;76;76;76;80 07:35:42 INFO - PROCESS | 15347 | |11;stanford-crypto-ccm;134;121;120;129;121;130;123;122;159;122 07:35:42 INFO - PROCESS | 15347 | |12;stanford-crypto-pbkdf2;157;159;155;156;158;160;157;165;156;157 07:35:42 INFO - PROCESS | 15347 | |13;stanford-crypto-sha256-iterative;66;65;65;61;63;64;66;62;66;61 07:35:42 INFO - PROCESS | 15347 | __end_tp_report 07:35:42 INFO - PROCESS | 15347 | __start_cc_report 07:35:42 INFO - PROCESS | 15347 | _x_x_mozilla_cycle_collect,1676 07:35:42 INFO - PROCESS | 15347 | __end_cc_report 07:35:42 INFO - PROCESS | 15347 | __startTimestamp1469975742670__endTimestamp 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | ------- Summary: start ------- 07:35:42 INFO - PROCESS | 15347 | Number of tests: 14 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#0] ai-astar Cycles:10 Average:115.90 Median:114.00 stddev:8.80 (7.7%) stddev-sans-first:8.40 07:35:42 INFO - PROCESS | 15347 | Values: 105.0 114.0 114.0 113.0 129.0 134.0 116.0 112.0 111.0 111.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:134.50 stddev:24.86 (18.5%) stddev-sans-first:26.13 07:35:42 INFO - PROCESS | 15347 | Values: 146.0 117.0 117.0 182.0 123.0 123.0 150.0 118.0 173.0 116.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:0.99 (0.6%) stddev-sans-first:1.00 07:35:42 INFO - PROCESS | 15347 | Values: 161.0 158.0 160.0 161.0 161.0 160.0 160.0 160.0 161.0 159.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:12.15 (16.2%) stddev-sans-first:12.73 07:35:42 INFO - PROCESS | 15347 | Values: 75.0 75.0 74.0 108.0 75.0 75.0 74.0 75.0 98.0 75.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:84.00 stddev:18.36 (21.9%) stddev-sans-first:19.12 07:35:42 INFO - PROCESS | 15347 | Values: 86.0 85.0 121.0 84.0 84.0 85.0 119.0 84.0 84.0 127.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:35:42 INFO - PROCESS | 15347 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:35:42 INFO - PROCESS | 15347 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:35:42 INFO - PROCESS | 15347 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:1.25 (2.3%) stddev-sans-first:1.30 07:35:42 INFO - PROCESS | 15347 | Values: 54.0 53.0 52.0 54.0 54.0 56.0 52.0 53.0 53.0 52.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.50 stddev:1.35 (2.2%) stddev-sans-first:1.41 07:35:42 INFO - PROCESS | 15347 | Values: 62.0 63.0 62.0 61.0 62.0 63.0 62.0 62.0 66.0 63.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.00 stddev:3.05 (4.0%) stddev-sans-first:3.20 07:35:42 INFO - PROCESS | 15347 | Values: 76.0 85.0 76.0 76.0 75.0 76.0 76.0 76.0 76.0 80.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:126.00 stddev:11.84 (9.4%) stddev-sans-first:12.36 07:35:42 INFO - PROCESS | 15347 | Values: 134.0 121.0 120.0 129.0 121.0 130.0 123.0 122.0 159.0 122.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:157.50 stddev:2.87 (1.8%) stddev-sans-first:3.02 07:35:42 INFO - PROCESS | 15347 | Values: 157.0 159.0 155.0 156.0 158.0 160.0 157.0 165.0 156.0 157.0 07:35:42 INFO - PROCESS | 15347 | 07:35:42 INFO - PROCESS | 15347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:65.00 stddev:2.02 (3.1%) stddev-sans-first:2.00 07:35:42 INFO - PROCESS | 15347 | Values: 66.0 65.0 65.0 61.0 63.0 64.0 66.0 62.0 66.0 61.0 07:35:42 INFO - PROCESS | 15347 | -------- Summary: end -------- 07:35:42 INFO - PROCESS | 15347 | 07:35:43 INFO - TEST-INFO | 15347: exit 0 07:35:43 INFO - TEST-OK | kraken | took 61079ms 07:35:43 INFO - SUITE-END | took 1175s 07:35:43 INFO - Completed test suite (00:19:35) 07:35:43 INFO - javascript benchmark 07:35:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2996.0712179224433, 3017.7133172348617, 3027.4399236141307, 3043.3608942122155, 3057.1898446911573, 5090.287359769626, 5146.871328216796, 5189.688618682877, 5274.894502109961, 5341.1988201769755, 5229.084910140729, 5247.658902171365, 5287.0, 5292.285541451913, 5293.867653308669, 4694.6713730039, 4774.546418090275, 4792.233242681172, 4807.134715751164, 4913.852584422473, 4866.075445665312, 4868.56182943535, 4876.97561512192, 4888.437829649601, 4915.950840491585, 4662.347271382009, 4721.787519561593, 4833.444153922309, 4860.076585448771, 4869.63477739171, 4751.857444276678, 4754.857354279377, 4757.6907501012665, 4761.8095276188915, 4809.75951202442, 4769.165396055676, 4803.56767890888, 4806.735629540374, 4811.350467686852, 4848.030393921194, 5113.360829896263, 5159.045576568347, 5288.68267903927, 5288.762005709752, 5317.521423071903, 5611.438856114397, 5632.04255276604, 5634.7182640867795, 5637.154426836008, 5639.351474580394, 5592.245046918654, 5685.772569097231, 5685.971570142123, 5693.658380497183, 5697.173909783059, 5103.464136265676, 5214.478552144793, 5240.266362709223, 5249.081410753103, 5322.813701520467, 5775.797847075332, 5813.593048486566, 5821.679807610622, 5822.883542329129, 5837.795677151279, 5541.5843811714285, 5576.10782274834, 5596.972015139898, 5606.074997625346, 5614.887702245932, 5396.622236443412, 5529.4470552944385, 5561.388247292794, 5562.666240025612, 5653.23681303027, 5566.997940370691, 5570.470805273492, 5573.693446860461, 5582.581306402036, 5621.100623900156, 5536.0, 5570.387257401682, 5576.247206627135, 5580.079286917613, 5618.6628802272, 4179.059711564934, 4210.957890421118, 4251.914961700749, 4290.163418133497, 4414.09511050234, 3859.7684138951754, 3864.864729734502, 3893.863714770026, 3902.726809123334, 3913.0608653922855, 5264.6314757966575, 5269.683818970874, 5278.366596008504, 5282.973585132127, 5317.335333083364, 5478.561715062785, 5534.557235421156, 5586.944130558642, 5596.076647353222, 5633.0, 5305.734713264322, 5310.044192045391, 5324.227986941949, 5325.227841962894, 5338.91991620126, 4907.312976183337, 4909.582685471703, 4920.6309526785635, 4922.72924989129, 4962.230854217602, 5685.260916080883, 5740.885182296331, 5859.501942334864, 5859.677717725481, 5878.588498805043, 5619.775208991595, 5626.2967129108865, 5631.915521267266, 5654.85862853432, 5676.687782171855, 5889.587728858939, 5892.086726557391, 5894.587378883437, 5897.233359663216, 5900.675462849585, 5343.064963631271, 5482.314710661168, 5527.53015993645, 5556.972215138899, 5561.249231353715, 5647.491725744702, 5688.459596338341, 5691.971540142273, 5722.971385143048, 5737.426257374229, 5515.944840551703, 5524.33707955048, 5540.91688624679, 5547.41752116022, 5549.972250138723, 5279.208118782213, 5397.514223719884, 5470.097433923358, 5528.834134975958, 5535.612507124462, 5444.537214336826, 5459.508644222039, 5469.0, 5498.642588231752, 5519.586031047607, 5515.61390702647, 5529.612927095065, 5576.10782274834, 5583.916241256466, 5600.27196464457, 5341.278927344914, 5418.295621569171, 5418.83743487696, 5430.13117901134, 5436.456354364532], "value": 5191.031522400721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.2027642406326, 609.1958614628691, 625.4808508937582, 632.7469012395044, 653.8626888353446, 32773.0, 34790.82604586973, 34806.30387392254, 34812.477812832825, 35136.82431587842, 36280.45579316312, 36982.26035479289, 45904.54095459053, 46695.0, 46871.296930545985, 8840.469571825679, 8978.41640293382, 8979.910200898006, 8980.955095224548, 8984.775380615472, 8892.066333035034, 8977.281817454621, 8981.820363592724, 8985.820283594325, 8992.05583413742, 8074.071481779582, 10687.83968240477, 10937.56249750009, 10954.452277386099, 11224.551017959313, 10860.239783215138, 10897.128229741602, 10908.836367454414, 10923.0, 10935.671929842118, 10688.465576721133, 10749.677509674722, 10758.838617420744, 10759.51582178796, 10765.3540787553, 33418.164545886306, 43139.56860431387, 43519.56480435187, 43522.78238608818, 46480.3027954581, 3300.9174770630925, 3309.3138523399157, 3397.96602033979, 3483.2685136121445, 3782.5082739244, 32916.341673166644, 33326.50010249848, 34156.14609634754, 34162.0, 34256.48615270773, 4366.432363792686, 4446.888827779331, 4460.15257101153, 4498.842540511099, 4548.113117942003, 371757.1412142949, 372569.0, 373016.0, 376672.0, 376951.0, 58435.415645843, 59166.40833591695, 59262.70368648129, 59360.703196483744, 59419.0, 62002.069968950505, 62039.0, 62110.689446552475, 62121.0, 62162.0, 15430.151341676092, 15833.050016999017, 15858.841411585967, 15863.12752798584, 15870.0, 12477.812832807514, 12486.188397754117, 12497.25016499013, 12507.499700011898, 12507.937460312822, 14185.290735463186, 14906.850931490762, 15832.445864394691, 15848.841511584968, 15973.520794376187, 6147.508199344042, 6384.808455746335, 6483.546151769331, 6503.2521260054755, 6599.142111525471, 873.6199753107419, 965.2519297544459, 966.7196513011148, 1030.7792472428855, 1040.2641054027858, 33084.0, 33266.0, 33400.498992514644, 33655.99032029043, 33960.83019584886, 970.2819913264275, 1069.893010698924, 1100.5047728522197, 1104.9558017679365, 1144.6909334479644, 16770.01379064034, 17531.29874805019, 17566.38517651876, 17573.560660983578, 17658.646827063385, 542689.0, 545634.0, 547160.0, 547471.7879231814, 548230.0, 53385.46614533805, 60113.699431502566, 60147.39852601506, 60477.0, 61342.0, 1333.2134040915905, 1337.411538922871, 1341.5975207437925, 1354.3025341948903, 1378.8207533020643, 29778.10665680033, 30977.0706878794, 31069.844650777504, 31267.37465250637, 32018.0, 51536.48463515317, 51943.48056519538, 52054.73972630112, 52270.215946760065, 52298.477015229364, 484843.0, 498228.0, 498333.0, 677846.0, 687973.0, 26441.7355826447, 26474.735252647228, 26619.0, 26788.732112678623, 26823.463530729667, 45214.77392613016, 45341.093178136915, 46700.53299466962, 47170.76414618042, 47246.291305629755, 38899.61100389073, 39332.0, 39524.40713389244, 40715.1856962865, 41174.0, 39136.2172756549, 39252.41121383238, 39878.2024359517, 40030.0, 41328.58671413247, 38303.233935321696, 39657.40513892236, 40117.398239027025, 40155.19689606133, 40182.1963560733, 32093.35813283768, 35070.12324691801, 35392.29215415729, 36031.63968360388, 36055.09862253465, 26600.467990640467, 26699.19902402931, 26924.461510769284, 26966.191014269603, 27315.45369092567], "value": 20173.99177586777, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.2060901145386, 360.9440536716808, 369.5989851011651, 380.9809509524524, 381.8167279705741, 14791.482298119568, 18900.527486812818, 19295.903520482378, 20263.392098237076, 20459.48851278719, 18823.43529694108, 20050.29823956162, 20151.697724534144, 20240.190392384324, 20251.696224556606, 5431.565474762029, 5680.346760122577, 5684.602077854552, 5685.800996965107, 5687.459691329317, 5417.674939503642, 5530.695811730353, 5559.722013899309, 5565.721713914309, 5592.356878958911, 5497.780088796443, 5528.917066243989, 5532.419095994923, 5536.086545719952, 5536.307961504812, 5484.61607687462, 5514.6691198528015, 5522.116461366182, 5548.99999999998, 5578.748956296977, 4959.876003099916, 4963.40439147301, 4965.577925876305, 4967.801287948478, 4968.503149685039, 22534.21130260433, 23771.16800911977, 23781.0, 24041.639375409384, 24132.879335603386, 2619.6594442722326, 2666.5600175971135, 2719.3065768228976, 3042.6044614200014, 3044.0563425338214, 14264.928675356661, 14797.482088126972, 15420.383184672599, 15617.141057241846, 15675.843241567552, 1875.165551329659, 1937.321937321926, 1976.5651556657513, 1977.9319167649453, 1991.7709463411747, 53644.0, 54218.72890635561, 84677.57661211777, 85159.57420212921, 85253.14746852576, 9842.0, 9913.80172396548, 10041.849372259421, 10175.9491202545, 11049.613263535737, 14244.643883902985, 14267.143971361751, 14412.279386030867, 14443.0, 14504.0, 7614.505057171266, 7866.09539902907, 7935.801604959922, 8006.3995200360205, 8029.116797152308, 7671.53970761756, 7687.192844751333, 7688.846223075507, 7986.840263194704, 8008.479448835807, 6263.846226607616, 6300.338464461257, 6370.936290637127, 6430.967845160744, 6517.706703198368, 1736.2881218700272, 1737.0967097109685, 1744.1715185286887, 1780.2433965564583, 1783.3669047487956, 777.4868586732729, 932.3799673217235, 948.3314263444394, 972.1396564040875, 1027.917766578672, 20439.693404598944, 21217.257395991066, 21249.36251912445, 21422.143114275565, 21494.35516934463, 977.4477420257674, 981.40134517944, 1004.8040632076821, 1026.2149455666422, 1030.5156576409076, 11352.94323528377, 11674.124440666814, 12064.698382540506, 12099.516019359304, 12111.515539378326, 476950.0, 487953.0, 490386.0, 491435.0, 491865.0, 83541.0, 87790.1220987782, 90334.54832725794, 90636.5468172655, 91403.0, 1021.6781713760141, 1021.9795604087876, 1035.063267742679, 1040.6773900090845, 1041.9895801042044, 17991.820081799015, 18182.0, 18882.33911813135, 18926.242950281834, 19043.90478047601, 43252.0, 43570.56429435665, 43726.34410483909, 44344.55655443404, 44778.77610611926, 56695.14957275727, 57516.42483575111, 57908.0, 62893.37106628875, 63880.3611963893, 8302.584870756316, 8407.327413806759, 8463.111373305961, 8623.051464339043, 8758.868616970623, 13071.738565228832, 13183.80224296617, 13880.93059534696, 13930.164190148624, 14232.288385580887, 11900.702482438008, 11962.820557691468, 12256.203346782431, 12349.259044457362, 12781.8082728761, 11685.76628467443, 11698.2981021139, 11861.881381186078, 11890.643280701594, 12207.816882746944, 11713.648590542298, 12216.816747748613, 12264.87735122673, 12349.506019759108, 12582.0, 8504.744857654281, 8537.103604121477, 8710.564471776512, 8714.259287960595, 8980.236679882284, 10271.794564108826, 11609.187356884937, 12113.636590902288, 12314.692132696755, 12458.563950261698], "value": 9386.776784585003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.3266383140344, 1460.3574427252008, 1527.579915523231, 1673.7656728058066, 1706.4368758309759, 8556.74329770107, 9187.402818816781, 9196.126367995046, 9207.447553146807, 9228.953855230731, 7480.401567874571, 8442.240198382144, 8696.173863482974, 8702.956485217564, 9031.72904812855, 2351.423901144222, 2374.81001519878, 2384.5946189147885, 2387.3554140382084, 2387.510560335127, 2318.976810231893, 2336.8714720690355, 2404.7835694787464, 2411.40920474484, 2413.456972181254, 2381.868997205153, 2384.7972922301624, 2395.9760402395927, 2399.1123284384716, 2406.9037238510527, 2312.7340355858955, 2318.3392733070996, 2322.0131444136173, 2323.4075310795724, 2365.976340236593, 2275.4311422144465, 2285.737140228878, 2293.598620241451, 2316.339843144696, 2319.1998760427628, 9131.863022054607, 9247.630094796268, 9266.629334826599, 9271.0, 9275.0, 5218.660787048868, 5384.461553844623, 5389.137737961907, 5391.730413479349, 5394.786173111019, 3276.4921437177277, 3279.2785587170783, 3295.8846440374473, 3334.683205095512, 3358.345122701074, 1063.2663462211126, 1093.3877028863783, 1105.0, 1123.6348186839227, 1126.048489026771, 12477.563285284972, 12540.623781286486, 12540.74918501634, 12540.811887821781, 12566.81149782754, 4493.123840851068, 4619.330197121466, 4728.858134255978, 4740.762961851894, 4772.308015337757, 10694.94652526748, 10707.196960228013, 10711.0, 10713.946430267955, 10714.46427678613, 5421.674699517963, 5426.67439953604, 5427.104527752956, 5429.511343979061, 5435.347758268954, 4293.763842988666, 4751.904961900743, 4849.733264670477, 4893.217085266411, 4977.402711674622, 3956.9208615827524, 3982.7411218270718, 4083.571225021389, 4085.1216988347055, 4123.649489793341, 1216.3796463803346, 1218.872018438069, 1257.591282833083, 1263.3493750718387, 1270.060155484953, 783.3185128937747, 948.5446985447024, 969.6218474794836, 974.8635191073255, 989.223459584223, 6173.629582225081, 6178.351273116348, 6299.275583307886, 6438.3883531064475, 6569.018642349568, 920.1074957291551, 943.4480828715141, 945.4138434170858, 951.5242378810594, 953.9046095390405, 4168.8332466701595, 4400.647948164139, 4413.7793110344355, 4483.484399294058, 4534.274516077412, 11036.172287078502, 11301.491432885376, 11423.200375973602, 11429.257098288585, 11430.1998860079, 11007.119430445546, 11318.26431281964, 11372.0, 11399.259048162008, 11508.19442639024, 8344.457610255315, 8380.790480238044, 8381.371397145238, 8472.872906906401, 8518.48889066658, 6131.785387511416, 6136.5090792737365, 6184.165137706532, 6247.2815626201755, 6294.842628934313, 10158.238132140266, 10386.48067596602, 10402.27184097106, 10494.632687856194, 10505.684829454824, 9998.650047248311, 10264.846027309446, 10402.167826573705, 10609.363438193734, 10611.257211995395, 7075.398591119607, 7841.176676448891, 7994.120646728739, 8137.186281371815, 8232.34141268709, 8770.649174032967, 8796.164364385373, 8821.558922054, 8868.201861832466, 8907.55462226899, 7584.317411432998, 7866.72466463671, 7872.527648341118, 8049.678012879419, 8128.796780080545, 7254.709811607477, 7271.4182865369585, 7308.269173082649, 7371.447141464304, 7383.741569045058, 7269.273072692688, 7401.96299018523, 7415.036045314075, 7415.3326200642205, 7417.740379086706, 4979.651424400402, 5175.197844334134, 5204.427512973645, 5241.68549887008, 5443.945560544502, 5312.601554883322, 5361.785528578969, 5386.192071189353, 5510.393856675682, 5595.524380427709], "value": 4723.744047203271, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.06059699706884, 316.1274881327535, 317.67438375664943, 320.5992509363296, 320.9871605135796, 5372.9194062089055, 5424.240606315114, 5433.4023257441695, 5453.127499600065, 5459.979807471232, 5319.414864364927, 5319.521243088121, 5371.462853714626, 5378.569714422846, 5381.19282107684, 3961.425593288964, 4061.1724723874377, 4062.939055914149, 4075.7758323292205, 4079.7348172368847, 3570.535830342052, 4103.384492326145, 4110.335314197755, 4150.675621651884, 4151.252774500589, 4055.634992850643, 4056.675465962716, 4069.837206511736, 4077.532088448156, 4077.7145599808027, 3893.279743247508, 4088.6115818997446, 4096.692748043879, 4108.931677763788, 4111.876643700679, 3556.5554305711785, 3583.605803361628, 3592.8203589820664, 3596.8920932371807, 3614.2410093880317, 5134.0758663440565, 5146.632549027415, 5147.588192944556, 5195.9480405195845, 5254.686328417895, 4653.840237009393, 4717.599004084657, 4721.716696998191, 4725.31482934976, 4729.793902554861, 5382.569394448474, 5481.972590137024, 5511.751971161308, 5521.978433989725, 5527.613067085305, 3938.0, 3958.6635136013474, 3963.8414463421427, 3976.8011599419915, 4009.218202450523, 5576.275084239063, 5620.85947851307, 5891.469767720883, 5894.97052514739, 5898.970505147447, 3627.510286111341, 3824.0248736572553, 3837.1558257183374, 3840.135969406917, 3855.5373355197557, 3875.418687196943, 4049.7367671101283, 4051.169510250392, 4083.2037752638544, 4084.591540845892, 4667.556582124693, 4667.579917807414, 4686.6485013624115, 4689.742064186435, 4735.176956871629, 5417.984366608942, 5511.641743286674, 5587.217789509472, 5590.97204513983, 5643.238162848045, 1402.3619253239751, 1405.7539930512119, 1408.6267139208119, 1415.9575212743634, 1418.9219592922489, 881.4534988307163, 915.6978197195043, 922.5571725571763, 929.762910457829, 930.1256818590504, 4703.084087865545, 4726.763661816895, 4734.4081989751285, 4786.401699787527, 4794.547925493639, 5062.797683007903, 5085.821996230188, 5133.307003554547, 5136.537711605899, 5185.325907631984, 4791.712497250176, 4833.685810422311, 4838.419389673261, 4846.733429661332, 5006.499350064964, 3002.579638850563, 3050.771192160597, 3052.832094234838, 3053.7709671774705, 3054.129573071664, 5964.910526342108, 5978.790742323998, 5994.730237139339, 6005.279366475964, 6023.849403764941, 5645.9717701412055, 5806.88386232273, 5835.2122463466885, 5850.635884366507, 5876.588638795329, 5673.0, 5808.680522571215, 5912.6452412854505, 5958.285005799332, 5972.790952316648, 5703.714814259188, 5705.515031222227, 5758.222639943554, 5778.624389414675, 5781.335146458211, 5519.475649813261, 5688.63023903445, 5714.885492367851, 5720.48515633595, 5727.255456790591, 5874.206982057368, 5882.029465138205, 5882.382349853204, 5953.76184952597, 5989.970050149721, 3954.5847685992558, 3957.6438120569287, 3972.3644216925154, 3973.324534829144, 3994.121293315466, 5495.552731893342, 5693.829185124453, 5732.713364331683, 5750.166225897305, 5785.797497087582, 5557.583181261502, 5562.16567514876, 5576.776928922797, 5600.243967064394, 5659.151127330933, 5524.613277070566, 5583.497485226349, 5601.747921343631, 5612.4387561245185, 5636.464535869086, 5354.732263386893, 5518.0, 5535.8892822142525, 5543.2793736815565, 5561.916571251353, 5562.499375056264, 5572.804951826666, 5595.972020139873, 5640.646244901112, 5640.928223637496, 5280.947190528045, 5454.881749241316, 5486.1222204447095, 5502.257195278587, 5512.283403157564], "value": 4182.9220439654255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.6678661029316, 740.7037185125951, 743.3458556470305, 789.1713700614354, 813.5932033983005, 16468.50594482166, 17079.146042697877, 17814.19836107375, 18050.729239061424, 18173.273069077222, 15802.683946321067, 15903.92048039761, 15930.044197348167, 15933.601659958478, 15934.20328983552, 809.1584751858061, 835.1022650650544, 841.0160112668193, 841.6380956188837, 842.1704620948361, 678.3047376439165, 801.5391150088693, 822.0382152881114, 822.8683410654296, 832.0722394530115, 879.0813599788237, 880.8238352329528, 881.3566096749377, 882.1134759566627, 882.2677177942293, 873.5894129759004, 873.8995015573163, 876.8334016536869, 877.3069275272527, 877.7893305606673, 509.1344713986238, 621.4344946099028, 627.1188979483833, 633.0188208277152, 641.3874749614107, 14739.778903316459, 14783.039102458306, 14896.404143834234, 14962.551123466314, 14998.400063997537, 14038.157710537298, 14318.64203394913, 14649.0, 14721.411143554245, 14872.776908346383, 13679.794803077963, 13726.588202353945, 13829.30853457323, 13984.790228146587, 14342.856571434257, 4595.425571803525, 4644.76776161194, 4692.436907571113, 4751.667383283171, 4777.140114779339, 91321.0, 91414.0, 91917.54041229752, 92862.0, 92934.0, 10160.13638840692, 10210.948945255375, 10482.266241363184, 10547.208959328082, 10569.682909512727, 20765.792342076387, 20931.26740564073, 21015.78984210138, 21016.159353625684, 21088.78911210899, 8252.46358986664, 8368.288695460833, 8478.703245386505, 8499.150084991576, 8559.40084194113, 4481.686281960297, 4493.775311234425, 4529.9547004530195, 4658.394408726844, 4672.0, 3536.1866770642896, 3623.1847834237615, 3647.8905632831056, 3649.8905032849057, 3653.50677658518, 620.3641267700643, 620.959637623553, 624.9156363890908, 645.7352485481024, 656.4223483334634, 600.9723373032164, 607.6840043177523, 694.6687404035832, 717.996410017957, 752.4695089961564, 9597.712068637951, 9672.903270967201, 9998.400095994264, 10050.381862529484, 10307.123894469054, 685.1538350137577, 697.100740045346, 703.7783098324012, 720.3372896934833, 728.7595093619093, 4765.142274390573, 4791.0, 5035.77339019745, 5044.495550444926, 5046.7476626168545, 115771.0, 124551.37724311501, 127759.0, 128407.0, 129715.0, 110451.48043119755, 111116.44441777901, 111288.4435577833, 113246.43376783228, 114860.0, 97827.0, 99124.50437747766, 99839.50080249697, 99976.0, 103259.0, 8734.257588105082, 8899.110088991049, 9200.714734919022, 9278.62885484573, 9795.706128816148, 50353.49646503488, 51792.741036294574, 54526.72736636292, 54961.725191373785, 55014.449855502535, 67205.0, 67296.66351668406, 73799.63100184465, 74654.62672686602, 77718.61140694487, 13323.200607963554, 13785.655358615713, 13801.585952421443, 13835.271787216408, 14150.716985660434, 15522.84477155214, 15764.527064188092, 15847.0, 16085.517434476984, 16886.408975686285, 14301.681528029689, 14392.928035359757, 14680.853191468375, 15006.849931500981, 15017.399304028153, 14568.708625827212, 14965.77551336709, 15008.699826003638, 15087.39650414015, 15479.916405851482, 14393.352299146773, 14493.85506144925, 14576.0, 14733.631659208606, 15009.32458039369, 10761.970190268576, 11056.0, 11150.330980141218, 11185.66443006711, 11735.119866009913, 10743.516541755484, 10939.124810309037, 11006.944965275123, 11085.667429977113, 11120.888791111985], "value": 7854.097737273765, "unit": "score"}], "name": "dromaeo_css", "value": 7309.905173219177, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 113.0, 129.0, 134.0, 116.0, 112.0, 111.0, 111.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 117.0, 182.0, 123.0, 123.0, 150.0, 118.0, 173.0, 116.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 108.0, 75.0, 75.0, 74.0, 75.0, 98.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 121.0, 84.0, 84.0, 85.0, 119.0, 84.0, 84.0, 127.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 54.0, 54.0, 56.0, 52.0, 53.0, 53.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0, 66.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 76.0, 76.0, 75.0, 76.0, 76.0, 76.0, 76.0, 80.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 121.0, 120.0, 129.0, 121.0, 130.0, 123.0, 122.0, 159.0, 122.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 155.0, 156.0, 158.0, 160.0, 157.0, 165.0, 156.0, 157.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 61.0, 63.0, 64.0, 66.0, 62.0, 66.0, 61.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1488.6, "alertThreshold": 2.0}]} 07:35:43 INFO - Return code: 0 07:35:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:35:43 INFO - # TBPL SUCCESS # 07:35:43 INFO - Running post-action listener: _resource_record_post_action 07:35:43 INFO - [mozharness: 2016-07-31 14:35:43.992698Z] Finished run-tests step (success) 07:35:43 INFO - Running post-run listener: _resource_record_post_run 07:35:44 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 5296128; Write bytes: 539906048; Read time: 3296; Write time: 550332 07:35:44 INFO - TinderboxPrint: CPU usage
13.1% 07:35:44 INFO - TinderboxPrint: I/O read bytes / time
5,296,128 / 3,296 07:35:44 INFO - TinderboxPrint: I/O write bytes / time
539,906,048 / 550,332 07:35:44 INFO - TinderboxPrint: CPU idle
8,276.8 (86.9%) 07:35:44 INFO - TinderboxPrint: CPU user
1,196.4 (12.6%) 07:35:44 INFO - TinderboxPrint: Swap in / out
0 / 0 07:35:44 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 247640064; Read time: 0; Write time: 353040 07:35:44 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5292032; Write bytes: 291889152; Read time: 3280; Write time: 197288 07:35:44 INFO - Running post-run listener: _upload_blobber_files 07:35:44 INFO - Blob upload gear active. 07:35:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35: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 07:35: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'] 07:35: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 07:35:45 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:35:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:49 INFO - (blobuploader) - INFO - Done attempting. 07:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:50 INFO - (blobuploader) - INFO - Done attempting. 07:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:51 INFO - (blobuploader) - INFO - Done attempting. 07:35:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:51 INFO - Return code: 0 07:35:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1472fe06f79320a90563d969e6c4b2792265facbf8b4bb63281d21eb1dff09342a0a2e06375d5f83f3cef59065a9f03d1ec7c785d0f62e28146f3a97205709d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6eefc03e9af743fed3212ae791300306f442baf052113b6becf356e5cb3d16b3e8b9405d2a455f5e23f84169c568be7a146500d9fde83697ceb394f59bbda4f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac31f5e394b75726be3a847b7e3b43898e738bce78efe5869099ca8ddf71849219a5ebfc0226057a6683c9082d57e722a7198076126502a452ab519bdc0ad67a"} 07:35:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:51 INFO - Contents: 07:35:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1472fe06f79320a90563d969e6c4b2792265facbf8b4bb63281d21eb1dff09342a0a2e06375d5f83f3cef59065a9f03d1ec7c785d0f62e28146f3a97205709d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6eefc03e9af743fed3212ae791300306f442baf052113b6becf356e5cb3d16b3e8b9405d2a455f5e23f84169c568be7a146500d9fde83697ceb394f59bbda4f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac31f5e394b75726be3a847b7e3b43898e738bce78efe5869099ca8ddf71849219a5ebfc0226057a6683c9082d57e722a7198076126502a452ab519bdc0ad67a"} 07:35:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:51 INFO - Copying logs to upload dir... 07:35:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.921534 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-31 07:35:49.585163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 07:35:49.588596) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147 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/1472fe06f79320a90563d969e6c4b2792265facbf8b4bb63281d21eb1dff09342a0a2e06375d5f83f3cef59065a9f03d1ec7c785d0f62e28146f3a97205709d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6eefc03e9af743fed3212ae791300306f442baf052113b6becf356e5cb3d16b3e8b9405d2a455f5e23f84169c568be7a146500d9fde83697ceb394f59bbda4f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac31f5e394b75726be3a847b7e3b43898e738bce78efe5869099ca8ddf71849219a5ebfc0226057a6683c9082d57e722a7198076126502a452ab519bdc0ad67a"} build_url:https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011474 build_url: 'https://queue.taskcluster.net/v1/task/GygZee4lSF-dy2cvn_5xdA/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/1472fe06f79320a90563d969e6c4b2792265facbf8b4bb63281d21eb1dff09342a0a2e06375d5f83f3cef59065a9f03d1ec7c785d0f62e28146f3a97205709d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6eefc03e9af743fed3212ae791300306f442baf052113b6becf356e5cb3d16b3e8b9405d2a455f5e23f84169c568be7a146500d9fde83697ceb394f59bbda4f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac31f5e394b75726be3a847b7e3b43898e738bce78efe5869099ca8ddf71849219a5ebfc0226057a6683c9082d57e722a7198076126502a452ab519bdc0ad67a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 07:35:49.614428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 07:35:49.614744) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469969653.809818-2002438147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 07:35:49.698512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 07:35:49.698826) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 07:35:49.699230) ========= ========= Total master_lag: 0.16 =========