builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1469984277.63 results: success (0) buildid: 20160731084126 builduid: 9f042430e880464cabfc8364d4ed5683 revision: 221b74c4836302adc88d0ab296ec9128e0df085f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:57.630332) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:57.630733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:57.631010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:57.670694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:57.670966) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-31 09:57:57-- 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% 89.8M=0s 2016-07-31 09:57:57 (89.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093902 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:57.778365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:57.778670) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020418 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:57.827872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:57.828184) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 221b74c4836302adc88d0ab296ec9128e0df085f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 221b74c4836302adc88d0ab296ec9128e0df085f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-31 09:57:57,908 truncating revision to first 12 chars 2016-07-31 09:57:57,908 Setting DEBUG logging. 2016-07-31 09:57:57,908 attempt 1/10 2016-07-31 09:57:57,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/221b74c48363?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-31 09:57:58,231 unpacking tar archive at: mozilla-central-221b74c48363/testing/mozharness/ program finished with exit code 0 elapsedTime=0.729898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:58.570819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:58.571092) ========= script_repo_revision: 221b74c4836302adc88d0ab296ec9128e0df085f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:58.571478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:58.571751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 09:57:58.587942) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-31 09:57:58.588201) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:58 INFO - MultiFileLogger online at 20160731 09:57:58 in /builds/slave/test 09:57:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:57:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:58 INFO - {'append_to_log': False, 09:57:58 INFO - 'base_work_dir': '/builds/slave/test', 09:57:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:57:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:58 INFO - 'branch': 'Firefox-Non-PGO', 09:57:58 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:58 INFO - 'config_files': ('talos/linux_config.py',), 09:57:58 INFO - 'default_actions': ('clobber', 09:57:58 INFO - 'read-buildbot-config', 09:57:58 INFO - 'download-and-extract', 09:57:58 INFO - 'populate-webroot', 09:57:58 INFO - 'create-virtualenv', 09:57:58 INFO - 'install', 09:57:58 INFO - 'run-tests'), 09:57:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:58 INFO - 'download_minidump_stackwalk': True, 09:57:58 INFO - 'download_symbols': 'ondemand', 09:57:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:58 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:58 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:58 INFO - 'installer_path': 'installer.exe', 09:57:58 INFO - 'log_level': 'info', 09:57:58 INFO - 'log_name': 'talos', 09:57:58 INFO - 'log_to_console': True, 09:57:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:58 INFO - 'opt_config_files': (), 09:57:58 INFO - 'pip_index': False, 09:57:58 INFO - 'sps_profile': False, 09:57:58 INFO - 'sps_profile_interval': 0, 09:57:58 INFO - 'suite': 'dromaeojs', 09:57:58 INFO - 'system_bits': '32', 09:57:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:58 INFO - 'title': 'talos-linux64-ix-027', 09:57:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:58 INFO - 'use_talos_json': True, 09:57:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:58 INFO - 'work_dir': 'build'} 09:57:58 INFO - [mozharness: 2016-07-31 16:57:58.762115Z] Running clobber step. 09:57:58 INFO - Running pre-action listener: _resource_record_pre_action 09:57:58 INFO - Running main action method: clobber 09:57:58 INFO - rmtree: /builds/slave/test/build 09:57:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:59 INFO - Running post-action listener: _resource_record_post_action 09:57:59 INFO - [mozharness: 2016-07-31 16:57:59.211364Z] Finished clobber step (success) 09:57:59 INFO - [mozharness: 2016-07-31 16:57:59.211466Z] Running read-buildbot-config step. 09:57:59 INFO - Running pre-action listener: _resource_record_pre_action 09:57:59 INFO - Running main action method: read_buildbot_config 09:57:59 INFO - Using buildbot properties: 09:57:59 INFO - { 09:57:59 INFO - "project": "", 09:57:59 INFO - "product": "firefox", 09:57:59 INFO - "script_repo_revision": "production", 09:57:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:57:59 INFO - "repository": "", 09:57:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:57:59 INFO - "buildid": "20160731084126", 09:57:59 INFO - "pgo_build": "False", 09:57:59 INFO - "basedir": "/builds/slave/test", 09:57:59 INFO - "buildnumber": 666, 09:57:59 INFO - "slavename": "talos-linux64-ix-027", 09:57:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:57:59 INFO - "platform": "ubuntu64_hw", 09:57:59 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:57:59 INFO - "branch": "mozilla-central", 09:57:59 INFO - "repo_path": "mozilla-central", 09:57:59 INFO - "revision": "221b74c4836302adc88d0ab296ec9128e0df085f", 09:57:59 INFO - "stage_platform": "linux64", 09:57:59 INFO - "builduid": "9f042430e880464cabfc8364d4ed5683", 09:57:59 INFO - "slavebuilddir": "test" 09:57:59 INFO - } 09:57:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:57:59 INFO - Running post-action listener: _resource_record_post_action 09:57:59 INFO - [mozharness: 2016-07-31 16:57:59.213912Z] Finished read-buildbot-config step (success) 09:57:59 INFO - [mozharness: 2016-07-31 16:57:59.214001Z] Running download-and-extract step. 09:57:59 INFO - Running pre-action listener: _resource_record_pre_action 09:57:59 INFO - Running main action method: download_and_extract 09:57:59 INFO - mkdir: /builds/slave/test/build/tests 09:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:59 INFO - https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:57:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:57:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:57:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:58:09 INFO - Downloaded 1361 bytes. 09:58:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:58:09 INFO - Using the following test package requirements: 09:58:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:58:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:58:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:09 INFO - u'jsshell-linux-x86_64.zip'], 09:58:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:58:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:58:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:58:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:58:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:58:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:58:09 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')]} 09:58:09 INFO - https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:58:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:58:12 INFO - Downloaded 20234384 bytes. 09:58:12 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'] 09:58:12 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 09:58:13 INFO - Return code: 0 09:58:13 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 09:58:13 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')]} 09:58:13 INFO - https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:58:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:58:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:58:23 INFO - Downloaded 20234384 bytes. 09:58:23 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'] 09:58:23 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 09:58:24 INFO - Return code: 0 09:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:24 INFO - https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:58:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:58:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:58:26 INFO - Downloaded 14413723 bytes. 09:58:26 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'] 09:58:26 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 09:58:26 INFO - Return code: 0 09:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:26 INFO - https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:58:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:58:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThH9h94UT0uiMg8j_fJGfw/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 09:58:27 INFO - Downloaded 55656632 bytes. 09:58:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:27 INFO - mkdir: /builds/slave/test/properties 09:58:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:27 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:27 INFO - Contents: 09:58:27 INFO - build_url:https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:28 INFO - Running post-action listener: _resource_record_post_action 09:58:28 INFO - Running post-action listener: set_extra_try_arguments 09:58:28 INFO - [mozharness: 2016-07-31 16:58:28.168058Z] Finished download-and-extract step (success) 09:58:28 INFO - [mozharness: 2016-07-31 16:58:28.168387Z] Running populate-webroot step. 09:58:28 INFO - Running pre-action listener: _resource_record_pre_action 09:58:28 INFO - Running main action method: populate_webroot 09:58:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:28 INFO - '--tppagecycles', 09:58:28 INFO - '7'], 09:58:28 INFO - 'tests': ['tsvgm']}}, 09:58:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['damp', 'tps']}, 09:58:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'tests': ['damp', 'tps']}, 09:58:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['dromaeo_dom']}, 09:58:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['basic_compositor_video']}, 09:58:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:58:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['tsvgx', 09:58:28 INFO - 'tsvgr_opacity', 09:58:28 INFO - 'tart', 09:58:28 INFO - 'tscrollx', 09:58:28 INFO - 'cart']}, 09:58:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:28 INFO - 'tsvgr_opacity', 09:58:28 INFO - 'tart', 09:58:28 INFO - 'tscrollx', 09:58:28 INFO - 'cart']}, 09:58:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['tp5o']}, 09:58:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'tests': ['tp5o']}, 09:58:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--disable-e10s', 09:58:28 INFO - '--xperf_path', 09:58:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:28 INFO - 'tests': ['tp5n']}, 09:58:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--xperf_path', 09:58:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:28 INFO - 'tests': ['tp5n']}}, 09:58:28 INFO - 'talos.zip': {'path': '', 09:58:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:28 INFO - Running post-action listener: _resource_record_post_action 09:58:28 INFO - [mozharness: 2016-07-31 16:58:28.186106Z] Finished populate-webroot step (success) 09:58:28 INFO - [mozharness: 2016-07-31 16:58:28.186197Z] Running create-virtualenv step. 09:58:28 INFO - Running pre-action listener: _resource_record_pre_action 09:58:28 INFO - Running main action method: create_virtualenv 09:58:28 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:28 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 09:58:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:28 INFO - Using real prefix '/usr' 09:58:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:30 INFO - Installing pip.................done. 09:58:30 INFO - Return code: 0 09:58:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:58:30 INFO - Using env: {'DISPLAY': ':0', 09:58:30 INFO - 'HOME': '/home/cltbld', 09:58:30 INFO - 'LANG': 'en_US.UTF-8', 09:58:30 INFO - 'LANGUAGE': 'en_US:en', 09:58:30 INFO - 'LOGNAME': 'cltbld', 09:58:30 INFO - 'MAIL': '/var/mail/cltbld', 09:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:30 INFO - 'MOZ_NO_REMOTE': '1', 09:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:30 INFO - 'NO_EM_RESTART': '1', 09:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:30 INFO - 'PWD': '/builds/slave/test', 09:58:30 INFO - 'SHELL': '/bin/bash', 09:58:30 INFO - 'SHLVL': '1', 09:58:30 INFO - 'TERM': 'linux', 09:58:30 INFO - 'TMOUT': '86400', 09:58:30 INFO - 'USER': 'cltbld', 09:58:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:30 INFO - '_': '/tools/buildbot/bin/python'} 09:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:30 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 09:58:30 INFO - Cleaning up... 09:58:30 INFO - Return code: 0 09:58:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:58:30 INFO - Using env: {'DISPLAY': ':0', 09:58:30 INFO - 'HOME': '/home/cltbld', 09:58:30 INFO - 'LANG': 'en_US.UTF-8', 09:58:30 INFO - 'LANGUAGE': 'en_US:en', 09:58:30 INFO - 'LOGNAME': 'cltbld', 09:58:30 INFO - 'MAIL': '/var/mail/cltbld', 09:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:30 INFO - 'MOZ_NO_REMOTE': '1', 09:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:30 INFO - 'NO_EM_RESTART': '1', 09:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:30 INFO - 'PWD': '/builds/slave/test', 09:58:30 INFO - 'SHELL': '/bin/bash', 09:58:30 INFO - 'SHLVL': '1', 09:58:30 INFO - 'TERM': 'linux', 09:58:30 INFO - 'TMOUT': '86400', 09:58:30 INFO - 'USER': 'cltbld', 09:58:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:30 INFO - '_': '/tools/buildbot/bin/python'} 09:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:31 INFO - Downloading/unpacking psutil>=3.1.1 09:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:33 INFO - Installing collected packages: psutil 09:58:33 INFO - Running setup.py install for psutil 09:58:33 INFO - building 'psutil._psutil_linux' extension 09:58:33 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 09:58:33 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 09:58:33 INFO - building 'psutil._psutil_posix' extension 09:58:33 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 09:58:33 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 09:58:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:33 INFO - Successfully installed psutil 09:58:33 INFO - Cleaning up... 09:58:33 INFO - Return code: 0 09:58:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58:33 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')]} 09:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:33 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')]} 09:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:33 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 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58:33 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 09:58:33 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 09:58:33 INFO - Using env: {'DISPLAY': ':0', 09:58:33 INFO - 'HOME': '/home/cltbld', 09:58:33 INFO - 'LANG': 'en_US.UTF-8', 09:58:33 INFO - 'LANGUAGE': 'en_US:en', 09:58:33 INFO - 'LOGNAME': 'cltbld', 09:58:33 INFO - 'MAIL': '/var/mail/cltbld', 09:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:33 INFO - 'MOZ_NO_REMOTE': '1', 09:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:33 INFO - 'NO_EM_RESTART': '1', 09:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:33 INFO - 'PWD': '/builds/slave/test', 09:58:33 INFO - 'SHELL': '/bin/bash', 09:58:33 INFO - 'SHLVL': '1', 09:58:33 INFO - 'TERM': 'linux', 09:58:33 INFO - 'TMOUT': '86400', 09:58:33 INFO - 'USER': 'cltbld', 09:58:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:33 INFO - '_': '/tools/buildbot/bin/python'} 09:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:36 INFO - Installing collected packages: mozsystemmonitor 09:58:36 INFO - Running setup.py install for mozsystemmonitor 09:58:36 INFO - Successfully installed mozsystemmonitor 09:58:36 INFO - Cleaning up... 09:58:36 INFO - Return code: 0 09:58:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58:36 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')]} 09:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:36 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')]} 09:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:36 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 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58:36 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 09:58:36 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 09:58:36 INFO - Using env: {'DISPLAY': ':0', 09:58:36 INFO - 'HOME': '/home/cltbld', 09:58:36 INFO - 'LANG': 'en_US.UTF-8', 09:58:36 INFO - 'LANGUAGE': 'en_US:en', 09:58:36 INFO - 'LOGNAME': 'cltbld', 09:58:36 INFO - 'MAIL': '/var/mail/cltbld', 09:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:36 INFO - 'MOZ_NO_REMOTE': '1', 09:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:36 INFO - 'NO_EM_RESTART': '1', 09:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:36 INFO - 'PWD': '/builds/slave/test', 09:58:36 INFO - 'SHELL': '/bin/bash', 09:58:36 INFO - 'SHLVL': '1', 09:58:36 INFO - 'TERM': 'linux', 09:58:36 INFO - 'TMOUT': '86400', 09:58:36 INFO - 'USER': 'cltbld', 09:58:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:36 INFO - '_': '/tools/buildbot/bin/python'} 09:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:36 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:39 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:39 INFO - warning: no files found matching '*.txt' 09:58:39 INFO - no previously-included directories found matching 'build' 09:58:39 INFO - no previously-included directories found matching 'dist' 09:58:39 INFO - no previously-included directories found matching '.git*' 09:58:39 INFO - Installing collected packages: jsonschema, functools32 09:58:39 INFO - Running setup.py install for functools32 09:58:39 INFO - warning: no files found matching '*.txt' 09:58:39 INFO - no previously-included directories found matching 'build' 09:58:39 INFO - no previously-included directories found matching 'dist' 09:58:39 INFO - no previously-included directories found matching '.git*' 09:58:39 INFO - Successfully installed jsonschema functools32 09:58:39 INFO - Cleaning up... 09:58:39 INFO - Return code: 0 09:58:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58: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 09:58: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 09:58:39 INFO - Using env: {'DISPLAY': ':0', 09:58:39 INFO - 'HOME': '/home/cltbld', 09:58:39 INFO - 'LANG': 'en_US.UTF-8', 09:58:39 INFO - 'LANGUAGE': 'en_US:en', 09:58:39 INFO - 'LOGNAME': 'cltbld', 09:58:39 INFO - 'MAIL': '/var/mail/cltbld', 09:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:39 INFO - 'MOZ_NO_REMOTE': '1', 09:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:39 INFO - 'NO_EM_RESTART': '1', 09:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:39 INFO - 'PWD': '/builds/slave/test', 09:58:39 INFO - 'SHELL': '/bin/bash', 09:58:39 INFO - 'SHLVL': '1', 09:58:39 INFO - 'TERM': 'linux', 09:58:39 INFO - 'TMOUT': '86400', 09:58:39 INFO - 'USER': 'cltbld', 09:58:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:39 INFO - '_': '/tools/buildbot/bin/python'} 09:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:58:40 INFO - Cleaning up... 09:58:40 INFO - Return code: 0 09:58:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:58:40 INFO - Using env: {'DISPLAY': ':0', 09:58:40 INFO - 'HOME': '/home/cltbld', 09:58:40 INFO - 'LANG': 'en_US.UTF-8', 09:58:40 INFO - 'LANGUAGE': 'en_US:en', 09:58:40 INFO - 'LOGNAME': 'cltbld', 09:58:40 INFO - 'MAIL': '/var/mail/cltbld', 09:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:40 INFO - 'MOZ_NO_REMOTE': '1', 09:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:40 INFO - 'NO_EM_RESTART': '1', 09:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:40 INFO - 'PWD': '/builds/slave/test', 09:58:40 INFO - 'SHELL': '/bin/bash', 09:58:40 INFO - 'SHLVL': '1', 09:58:40 INFO - 'TERM': 'linux', 09:58:40 INFO - 'TMOUT': '86400', 09:58:40 INFO - 'USER': 'cltbld', 09:58:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:40 INFO - '_': '/tools/buildbot/bin/python'} 09:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:42 INFO - Downloading docopt-0.6.1.tar.gz 09:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:42 INFO - Running setup.py install for blobuploader 09:58:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:43 INFO - Running setup.py install for requests 09:58:43 INFO - Running setup.py install for docopt 09:58:43 INFO - Successfully installed blobuploader requests docopt 09:58:43 INFO - Cleaning up... 09:58:43 INFO - Return code: 0 09:58:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58: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 09:58: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 09:58:43 INFO - Using env: {'DISPLAY': ':0', 09:58:43 INFO - 'HOME': '/home/cltbld', 09:58:43 INFO - 'LANG': 'en_US.UTF-8', 09:58:43 INFO - 'LANGUAGE': 'en_US:en', 09:58:43 INFO - 'LOGNAME': 'cltbld', 09:58:43 INFO - 'MAIL': '/var/mail/cltbld', 09:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:43 INFO - 'MOZ_NO_REMOTE': '1', 09:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:43 INFO - 'NO_EM_RESTART': '1', 09:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:43 INFO - 'PWD': '/builds/slave/test', 09:58:43 INFO - 'SHELL': '/bin/bash', 09:58:43 INFO - 'SHLVL': '1', 09:58:43 INFO - 'TERM': 'linux', 09:58:43 INFO - 'TMOUT': '86400', 09:58:43 INFO - 'USER': 'cltbld', 09:58:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:43 INFO - '_': '/tools/buildbot/bin/python'} 09:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:43 INFO - Running setup.py (path:/tmp/pip-uB2Dby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:43 INFO - Running setup.py (path:/tmp/pip-pE4k5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:43 INFO - Running setup.py (path:/tmp/pip-J9oGx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:43 INFO - Running setup.py (path:/tmp/pip-b2s5e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:44 INFO - Running setup.py (path:/tmp/pip-_uM61o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:44 INFO - Running setup.py (path:/tmp/pip-ySpvUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:44 INFO - Running setup.py (path:/tmp/pip-SyqWvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:44 INFO - Running setup.py (path:/tmp/pip-H_qNQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:44 INFO - Running setup.py (path:/tmp/pip-0VlMgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:44 INFO - Running setup.py (path:/tmp/pip-KfSClr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:44 INFO - Running setup.py (path:/tmp/pip-XqI_on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:44 INFO - Running setup.py (path:/tmp/pip-4CfbhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:44 INFO - Running setup.py (path:/tmp/pip-5eBuwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:44 INFO - Running setup.py (path:/tmp/pip-HQLUuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:44 INFO - Running setup.py (path:/tmp/pip-hFcqxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:44 INFO - Running setup.py (path:/tmp/pip-aIWPbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:44 INFO - Running setup.py (path:/tmp/pip-T0pNjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:44 INFO - Running setup.py install for manifestparser 09:58:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:45 INFO - Running setup.py install for mozcrash 09:58:45 INFO - Running setup.py install for mozdebug 09:58:45 INFO - Running setup.py install for mozdevice 09:58:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:45 INFO - Running setup.py install for mozfile 09:58:45 INFO - Running setup.py install for mozhttpd 09:58:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:45 INFO - Running setup.py install for mozinfo 09:58:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:45 INFO - Running setup.py install for mozInstall 09:58:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:45 INFO - Running setup.py install for mozleak 09:58:45 INFO - Running setup.py install for mozlog 09:58:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:46 INFO - Running setup.py install for moznetwork 09:58:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:46 INFO - Running setup.py install for mozprocess 09:58:46 INFO - Running setup.py install for mozprofile 09:58:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:46 INFO - Running setup.py install for mozrunner 09:58:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:46 INFO - Running setup.py install for mozscreenshot 09:58:46 INFO - Running setup.py install for moztest 09:58:46 INFO - Running setup.py install for mozversion 09:58:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:46 INFO - Cleaning up... 09:58:46 INFO - Return code: 0 09:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58: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 09:58: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 09:58:46 INFO - Using env: {'DISPLAY': ':0', 09:58:46 INFO - 'HOME': '/home/cltbld', 09:58:46 INFO - 'LANG': 'en_US.UTF-8', 09:58:46 INFO - 'LANGUAGE': 'en_US:en', 09:58:46 INFO - 'LOGNAME': 'cltbld', 09:58:46 INFO - 'MAIL': '/var/mail/cltbld', 09:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:46 INFO - 'MOZ_NO_REMOTE': '1', 09:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:46 INFO - 'NO_EM_RESTART': '1', 09:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:46 INFO - 'PWD': '/builds/slave/test', 09:58:46 INFO - 'SHELL': '/bin/bash', 09:58:46 INFO - 'SHLVL': '1', 09:58:46 INFO - 'TERM': 'linux', 09:58:46 INFO - 'TMOUT': '86400', 09:58:46 INFO - 'USER': 'cltbld', 09:58:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:46 INFO - '_': '/tools/buildbot/bin/python'} 09:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:46 INFO - Running setup.py (path:/tmp/pip-1WUNUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:47 INFO - Running setup.py (path:/tmp/pip-QSSvXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:47 INFO - Running setup.py (path:/tmp/pip-_0b_Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:47 INFO - Running setup.py (path:/tmp/pip-xLxdin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:47 INFO - Running setup.py (path:/tmp/pip-R0c_mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:47 INFO - Running setup.py (path:/tmp/pip-jvgzjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:47 INFO - Running setup.py (path:/tmp/pip-xjy_f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:47 INFO - Running setup.py (path:/tmp/pip-hmnreJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:47 INFO - Running setup.py (path:/tmp/pip-z0WRZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:47 INFO - Running setup.py (path:/tmp/pip-e02Ya6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:47 INFO - Running setup.py (path:/tmp/pip-HRNJjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:47 INFO - Running setup.py (path:/tmp/pip-doY_a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:47 INFO - Running setup.py (path:/tmp/pip-bL1DmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58: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)) 09:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:47 INFO - Running setup.py (path:/tmp/pip-uvuxOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:48 INFO - Running setup.py (path:/tmp/pip-BCgpBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:48 INFO - Running setup.py (path:/tmp/pip-R2Syyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58: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)) 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:48 INFO - Running setup.py (path:/tmp/pip-C06hPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:50 INFO - Downloading blessings-1.6.tar.gz 09:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:50 INFO - Installing collected packages: blessings 09:58:50 INFO - Running setup.py install for blessings 09:58:50 INFO - Successfully installed blessings 09:58:50 INFO - Cleaning up... 09:58:50 INFO - Return code: 0 09:58:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:50 INFO - Reading from file tmpfile_stdout 09:58:50 INFO - Current package versions: 09:58:50 INFO - argparse == 1.2.1 09:58:50 INFO - blessings == 1.6 09:58:50 INFO - blobuploader == 1.2.4 09:58:50 INFO - docopt == 0.6.1 09:58:50 INFO - functools32 == 3.2.3-2 09:58:50 INFO - jsonschema == 2.5.1 09:58:50 INFO - manifestparser == 1.1 09:58:50 INFO - mozInstall == 1.12 09:58:50 INFO - mozcrash == 0.17 09:58:50 INFO - mozdebug == 0.1 09:58:50 INFO - mozdevice == 0.48 09:58:50 INFO - mozfile == 1.2 09:58:50 INFO - mozhttpd == 0.7 09:58:50 INFO - mozinfo == 0.9 09:58:50 INFO - mozleak == 0.1 09:58:50 INFO - mozlog == 3.3 09:58:50 INFO - moznetwork == 0.27 09:58:50 INFO - mozprocess == 0.23 09:58:50 INFO - mozprofile == 0.28 09:58:50 INFO - mozrunner == 6.12 09:58:50 INFO - mozscreenshot == 0.1 09:58:50 INFO - mozsystemmonitor == 0.3 09:58:50 INFO - moztest == 0.7 09:58:50 INFO - mozversion == 1.4 09:58:50 INFO - psutil == 3.1.1 09:58:50 INFO - requests == 1.2.3 09:58:50 INFO - wsgiref == 0.1.2 09:58:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58: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 09:58: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 09:58:50 INFO - Using env: {'DISPLAY': ':0', 09:58:50 INFO - 'HOME': '/home/cltbld', 09:58:50 INFO - 'LANG': 'en_US.UTF-8', 09:58:50 INFO - 'LANGUAGE': 'en_US:en', 09:58:50 INFO - 'LOGNAME': 'cltbld', 09:58:50 INFO - 'MAIL': '/var/mail/cltbld', 09:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:50 INFO - 'MOZ_NO_REMOTE': '1', 09:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:50 INFO - 'NO_EM_RESTART': '1', 09:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:50 INFO - 'PWD': '/builds/slave/test', 09:58:50 INFO - 'SHELL': '/bin/bash', 09:58:50 INFO - 'SHLVL': '1', 09:58:50 INFO - 'TERM': 'linux', 09:58:50 INFO - 'TMOUT': '86400', 09:58:50 INFO - 'USER': 'cltbld', 09:58:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:50 INFO - '_': '/tools/buildbot/bin/python'} 09:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58: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)) 09:58:50 INFO - Cleaning up... 09:58:50 INFO - Return code: 0 09:58:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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 0x233e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', '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 09:58: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 09:58: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 09:58:50 INFO - Using env: {'DISPLAY': ':0', 09:58:50 INFO - 'HOME': '/home/cltbld', 09:58:50 INFO - 'LANG': 'en_US.UTF-8', 09:58:50 INFO - 'LANGUAGE': 'en_US:en', 09:58:50 INFO - 'LOGNAME': 'cltbld', 09:58:50 INFO - 'MAIL': '/var/mail/cltbld', 09:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:50 INFO - 'MOZ_NO_REMOTE': '1', 09:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:50 INFO - 'NO_EM_RESTART': '1', 09:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:50 INFO - 'PWD': '/builds/slave/test', 09:58:50 INFO - 'SHELL': '/bin/bash', 09:58:50 INFO - 'SHLVL': '1', 09:58:50 INFO - 'TERM': 'linux', 09:58:50 INFO - 'TMOUT': '86400', 09:58:50 INFO - 'USER': 'cltbld', 09:58:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:50 INFO - '_': '/tools/buildbot/bin/python'} 09:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:51 INFO - Cleaning up... 09:58:51 INFO - Return code: 0 09:58:51 INFO - Running post-action listener: _resource_record_post_action 09:58:51 INFO - Running post-action listener: _start_resource_monitoring 09:58:51 INFO - Starting resource monitoring. 09:58:51 INFO - [mozharness: 2016-07-31 16:58:51.052080Z] Finished create-virtualenv step (success) 09:58:51 INFO - [mozharness: 2016-07-31 16:58:51.052519Z] Running install step. 09:58:51 INFO - Running pre-action listener: _resource_record_pre_action 09:58:51 INFO - Running main action method: install 09:58:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:51 INFO - Reading from file tmpfile_stdout 09:58:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:51 INFO - Reading from file tmpfile_stdout 09:58:51 INFO - Output received: 09:58:51 INFO - Usage: mozinstall [options] installer 09:58:51 INFO - Options: 09:58:51 INFO - -h, --help show this help message and exit 09:58:51 INFO - -d DEST, --destination=DEST 09:58:51 INFO - Directory to install application into. [default: 09:58:51 INFO - "/builds/slave/test"] 09:58:51 INFO - --app=APP Application being installed. [default: firefox] 09:58:51 INFO - mkdir: /builds/slave/test/build/application 09:58: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'] 09:58: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 09:59:07 INFO - Reading from file tmpfile_stdout 09:59:07 INFO - Output received: 09:59:07 INFO - /builds/slave/test/build/application/firefox/firefox 09:59:07 INFO - Running post-action listener: _resource_record_post_action 09:59:07 INFO - [mozharness: 2016-07-31 16:59:07.335959Z] Finished install step (success) 09:59:07 INFO - [mozharness: 2016-07-31 16:59:07.336238Z] Running run-tests step. 09:59:07 INFO - Running pre-action listener: _resource_record_pre_action 09:59:07 INFO - Running main action method: run_tests 09:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:07 INFO - Python 2.7.3 09:59:07 INFO - Return code: 0 09:59:07 INFO - grabbing minidump binary from tooltool 09:59:07 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')]} 09:59:07 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 0x25fd3b0>, '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 0x25fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fe740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:07 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 09:59:07 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 09:59:07 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 09:59:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:07 INFO - Return code: 0 09:59:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:59:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:59:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:59:07 INFO - Using env: {'DISPLAY': ':0', 09:59:07 INFO - 'HOME': '/home/cltbld', 09:59:07 INFO - 'LANG': 'en_US.UTF-8', 09:59:07 INFO - 'LANGUAGE': 'en_US:en', 09:59:07 INFO - 'LOGNAME': 'cltbld', 09:59:07 INFO - 'MAIL': '/var/mail/cltbld', 09:59:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:07 INFO - 'MOZ_NO_REMOTE': '1', 09:59:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:07 INFO - 'NO_EM_RESTART': '1', 09:59:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:07 INFO - 'PWD': '/builds/slave/test', 09:59:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:07 INFO - 'SHELL': '/bin/bash', 09:59:07 INFO - 'SHLVL': '1', 09:59:07 INFO - 'TERM': 'linux', 09:59:07 INFO - 'TMOUT': '86400', 09:59:07 INFO - 'USER': 'cltbld', 09:59:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583', 09:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:07 INFO - '_': '/tools/buildbot/bin/python'} 09:59:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:59:07 INFO - mozversion application_buildid: 20160731084126 09:59:07 INFO - mozversion application_changeset: 221b74c4836302adc88d0ab296ec9128e0df085f 09:59:07 INFO - mozversion application_display_name: Nightly 09:59:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:07 INFO - mozversion application_name: Firefox 09:59:07 INFO - mozversion application_remotingname: firefox 09:59:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:59:07 INFO - mozversion application_vendor: Mozilla 09:59:07 INFO - mozversion application_version: 50.0a1 09:59:07 INFO - mozversion platform_buildid: 20160731084126 09:59:07 INFO - mozversion platform_changeset: 221b74c4836302adc88d0ab296ec9128e0df085f 09:59:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:59:07 INFO - mozversion platform_version: 50.0a1 09:59:07 INFO - using testdate: 1469984347 09:59:07 INFO - actual date: 1469984347 09:59:07 INFO - starting webserver on 'localhost:44096' 09:59:07 INFO - SUITE-START | Running 2 tests 09:59:07 INFO - TEST-START | dromaeo_css 09:59:07 INFO - operating with platform_type : linux_ 09:59:07 INFO - Initialising browser for dromaeo_css test... 09:59:07 INFO - TEST-INFO | started process 6084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYtTncH/profile http://localhost:44096/getInfo.html) 09:59:11 INFO - PROCESS | 6084 | __metrics Screen width/height:1600/1200 09:59:11 INFO - PROCESS | 6084 | colorDepth:24 09:59:11 INFO - PROCESS | 6084 | Browser inner width/height: 1024/697 09:59:11 INFO - PROCESS | 6084 | __metrics 09:59:12 INFO - PROCESS | 6084 | 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" 09:59:12 INFO - PROCESS | 6084 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:12 INFO - PROCESS | 6084 | console.error: PushService: 09:59:12 INFO - PROCESS | 6084 | stateChangeProcessEnqueue: Error transitioning state 09:59:12 INFO - PROCESS | 6084 | UnknownError 09:59:13 INFO - TEST-INFO | 6084: exit 0 09:59:13 INFO - Browser initialized. 09:59:13 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:13 INFO - TEST-INFO | started process 6164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYtTncH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:25 INFO - PROCESS | 6164 | RSS: Main: 157511680 09:59:25 INFO - PROCESS | 6164 | 10:00:17 INFO - PROCESS | 6164 | 1469984417359 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] 10:02:29 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44096/tests/dromaeo/cssquery-ext.html) 10:02:30 INFO - PROCESS | 6164 | RSS: Main: 246763520 10:02:30 INFO - PROCESS | 6164 | 10:05:32 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-ext.html (next: http://localhost:44096/tests/dromaeo/cssquery-jquery.html) 10:05:33 INFO - PROCESS | 6164 | RSS: Main: 248311808 10:05:33 INFO - PROCESS | 6164 | 10:08:35 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44096/tests/dromaeo/cssquery-mootools.html) 10:08:36 INFO - PROCESS | 6164 | RSS: Main: 214196224 10:08:36 INFO - PROCESS | 6164 | 10:11:38 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44096/tests/dromaeo/cssquery-prototype.html) 10:11:39 INFO - PROCESS | 6164 | RSS: Main: 190296064 10:11:39 INFO - PROCESS | 6164 | 10:14:42 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44096/tests/dromaeo/cssquery-yui.html) 10:14:42 INFO - PROCESS | 6164 | RSS: Main: 188624896 10:14:42 INFO - PROCESS | 6164 | 10:17:45 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-yui.html (next: http://localhost:44096/tests/dromaeo/cssquery-dojo.html) 10:17:46 INFO - PROCESS | 6164 | RSS: Main: 281231360 10:17:46 INFO - PROCESS | 6164 | 10:17:46 INFO - PROCESS | 6164 | __start_tp_report 10:17:46 INFO - PROCESS | 6164 | _x_x_mozilla_page_load 10:17:46 INFO - PROCESS | 6164 | _x_x_mozilla_page_load_details 10:17:46 INFO - PROCESS | 6164 | |i|pagename|runs| 10:17:46 INFO - PROCESS | 6164 | |0;dojo.html;2660.2152365052307;2662.4275780707144;2690.3274181454635;2690.5291573974564;2699.4331190450016;4650.627949764019;4713.693609915353;4713.8114475421025;4802.087603355364;4834.347363105984;4700.835470758524;4740.976295118519;4761.90476190476;4768.141734487791;4822;4326.113146804905;4334.501532323776;4393.758343291118;4445.444319460067;4527.071950250191;4455.353973673816;4479.484859241196;4512.368268442421;4533.274676051832;4539.6368290536675;4274.995376086617;4307.935380969288;4400.185965596343;4412.338149277602;4482.439695038121;4354.042110735633;4355.934660980088;4362.367456718758;4410.140022695576;4414.933775993362;4329.610335069859;4386.407834942306;4392.143532011259;4392.538783427726;4430;4633.976830115827;4748.406449193851;4797.376341075673;4811.326414302001;4814.5907597853875;5025.447200807908;5028.044671512437;5035.3454050973505;5044.117279476113;5063.215201643751;5100.311457953166;5105.872353191163;5122.231665250242;5131.974340128313;5135.6918584885025;4700.600448961876;4787.784549695272;4827.25177597473;4832.8791780205775;4836.637252206028;5300.12547929595;5303.28405665238;5366.302380690485;5368.355797304271;5375.220593013991;5108.693478391308;5113.284140220372;5117.744112794346;5163.8192663256605;5164;4991.800327986913;5066.138756411419;5183.300254465675;5193.480651934852;5242.7640756166065;5049.747512624354;5057.671251368649;5065.797368105234;5112.872178195575;5117.795288188431;5037.420696619935;5053.545180933734;5054.267131265946;5059.038782631362;5105;4142.482189726285;4170.645495132948;4247.532771395144;4251.404803327537;4303.096349766522;3677.9080522987138;3692.7599706019023;3705.2959937611768;3728.7389882708494;3788.0340513169517;4404.867853964386;4407.515173330931;4410.360497727812;4446.755428451402;4455.443069616298;4968.826091086795;5106.591472682177;5106.795728170831;5111.054454925777;5148.9485105149215;4402.471703395613;4406.779661016936;4413.7351758894565;4451.666125040635;4453.844115455943;4556.248219043887;4584.426946631671;4588.770561471913;4589.472210695746;4633.189191891405;4788;4826.975865120652;4837.782299796448;4841.346418233635;4881.877953051202;4952.356193694796;5058.620603454682;5115.590752739847;5115.9232611510115;5152.948470515397;4835.879103022453;4842.206215846357;4846.151923413459;4846.200376937766;4883.121038213014;5061.038402703622;5065.949340506548;5066.341375621146;5067.645264831426;5103.387593488805;4991.700497970133;5019.598432125348;5053.065182941167;5065.974670126626;5138.434772175133;4993.600511958962;5003.024410239968;5003.199488081889;5006.6495345325475;5054.545090941833;4990.201567749143;5004.4495105537635;5006.098902197494;5007.674501157413;5056.241563765465;4716.174669432904;4816.518348165156;4870.050340183772;4874.512548745097;4915.778789954389;4996.100701873697;5011.4487406386;5015.122353588181;5018.648694591489;5058.9494105058475;4899.534544218293;4922.187839006524;4922.335484709519;4924.335214745964;4971.055499455092 10:17:46 INFO - PROCESS | 6164 | |1;ext.html;554.52865064695;568.0598609301604;568.7838621323897;570.4067769519698;572.2360648534207;27197.592036119448;39291.695621091145;40669;40832.97917552059;44879.326810097795;42144.57855421445;42584.57415425845;42648.36027459591;42661.36007959883;42697;7330.706771729125;7792.376609871225;7939.920600794005;7944.443888927777;7950.681972721113;9839.311248212627;10073.69778906634;10076.496175191247;10499.632512862052;10513.894861051369;10218.642347517838;10280.22898282628;10291.845622315672;10324.122449591794;10356.948215258913;10110.039546243095;10122.848157277647;10151.086402223762;10158.238132140044;10169.135623472013;10034.448105354202;10110.797784044278;10115.696529104138;10116.14012808912;10123.79752404955;39320.60679393227;39611.20777584432;39631.40552891709;39685.20629587421;39703.40444893329;2941.2940894185454;3123.2660324823646;3177.8252196129206;3434.7423943204108;3547.840347184383;29716.40567188644;29809.701902981127;30281.848590756905;30357;30451.543226851616;3316.3698897209692;3361.8151001694896;3371.7471189660873;3400.931981360359;3403.8523834442153;264747;265529;266712;267145.6211659889;267476.9999999981;53397.46602533925;53586.464135358925;53603.46396536063;53672;53764.73117634465;57190;57215.71392143096;57278.427215728145;57331.42668573261;57347.42652573421;13814.171149731048;13969.301534923214;13982.58052258434;13993.440262389391;14000.579982600539;9916.702498925044;10760.3543787373;11096.33421994683;11133.387663678575;11192.720181995352;15909.284082216096;16078.196090195677;16081.758773618405;16210.918945405198;16343;6295.244570651551;6305.495560355161;6359.872802544016;6389.872202555923;6397.072424498421;775.9107702614272;823.1685997142929;930.8371035068836;981.7923953537047;1034.6482196053378;28207.71792282092;28489;28619.713802862123;28954.855225723735;29003.854980724962;939.0703203828161;942.2414955960518;954.2509130332655;956.5791051937125;1005.6027868991707;14933.477328293458;15156.24218789056;15244.46644367464;15548.689026219412;15580.454684086002;389487;396964;397852;398123;399151;50800;50864.74567627212;50961;51181.7440912793;51233.743831280604;1073.173656284672;1137.3005601554985;1147.8106112491346;1179.0685358566636;1199.040767386105;27703.58444623292;29113.85443072771;29158;29550.40899181961;29929;42843.57156428396;43330;43341.566584333756;43363.132737344444;43364;300344;301787;301839;302431;303207;24620.507589847744;25182.496350073263;25293;26463.60304595471;26693.19920402391;42537;42849.14301714011;42963.570364295956;43600;43790.34314485222;35361.82319088388;35424.46863297001;35652.82173589219;36059.81970090133;36220.81889590535;35594.28811423705;35672.821635891654;35890.46164307485;36112.094013046895;36498;36051;36432;36868.446973294886;37182.44226336553;37294.25411491809;30885.536716949715;32660.34679306353;33077.33845323032;33316.66683333136;33445.498317525744;24830.627540586545;25221.621675675247;25446.618300725873;25453.109141179968;25654.74345256598 10:17:46 INFO - PROCESS | 6164 | |2;jquery.html;340.23956457317905;357.2889949001488;367.64154948924795;368.123865200822;388.35533015194767;12468.251904885701;15993.440229591966;16409;16467.752983705253;17667.91166044171;16093.034417934932;16615.750763738553;17033.659326813457;17124.22940967656;17189.312427502886;4946.084974279761;4988.87527811804;5114.488551144893;5147.2021836615195;5153.922691159635;3653.4337177737493;5013.799448022075;5101.923471147936;5102.872428189288;5659.886802263953;5890.823275301726;5944.138099975501;5974.372690867462;5978.671173085479;6008.669523176223;5742.942570574303;5828.242328497311;5860.091685788667;5862.14998825168;5989.999999999978;5189.42916279209;5191.870203244911;5192.688438693691;5197.272381866542;5205.9219111713355;19230;19493.805061949482;20819.687704684442;20955.8952205238;21031.68452473214;1789.6868048091662;1874.46577725349;1894.043508028437;1901.1254822781536;2371.822113341489;9305;9490.525473726355;9601.087896649808;9703.66037188695;11080.501377438035;1707.5731067233191;1713.5801728576455;1728.680194164071;1741.7909850817982;1742.581780372714;72163.63918180375;72914.27085729128;73052.90420643748;74457;75898;9932.950335248423;10032.247581431422;10103.444310562989;10206.64276750325;10362.792744145076;14116.85883141176;14136.787948180785;14145.787813182811;14153.646158846112;14158;6554.475641948633;6728.798136055926;6808.9659551701925;6813.284605116491;6819.556728812611;6101.145839582462;6111.236095488064;6275.654838983808;6280.183576135165;6285.120083188357;4269.4449721536;4314.71954322968;4325.243082460557;4468.664850136252;4472.351509031172;1738.7304967730022;1843.3824668735856;1871.775386953547;1875.2967637136073;1879.8402135818608;781.6248200863618;820.971266005687;858.965641374338;866.2204016385177;901.977450563728;16133.354665813471;16593.83406165947;17089;17119.65760684779;17289.740653890203;817.4808996287401;823.9093699693029;837.250660658707;841.2386789955101;867.5922316511229;6907.551009184387;9678.854817177747;9736.95131524352;9738.951305243429;9871.358361706467;395731;398683;449779;452513;458141;85241;85864;87161;89096.55451722699;89390.55304723565;884.4207044385937;901.4996676844414;931.3340961212765;932.7388331267256;937.1097457415483;15792.684146317239;15920.52238432849;16315.755263671292;16587.91706041462;16920.32318707238;39368;39681.60318396779;40214.19571608493;40797.38803918003;41439.37840932449;53843.19235211553;54993;55837.44162558485;56001;56775;7606.125295590857;7626.237376262329;7770.9120723097685;7825.686972521263;7854.625440547996;8920.910790892009;11904.702382440508;12199.817002744789;12347.938260308641;12713.93643031779;9811.754706132404;10134.391936483835;10221.693349199535;10649.094826939798;10859.07697845692;10279.149753044523;10304.690859273935;10432.061114499731;10504.10715089226;10601.363918164934;9685.079917407835;10007.699769006942;10339.638112666322;10562.102221311274;10582.576696932036;7776;7885.763427097197;7961;8169.2647661710735;8361.372897032625;7680.961595191989;9359.953200233955;9848.261380396356;10224;10230.437325947145 10:17:46 INFO - PROCESS | 6164 | |3;mootools.html;1157.3981529604612;1291.5608693044367;1353.0596235616247;1361.6868120332324;1636.1982628512033;6349.746010159593;7077.186123595788;7314.634268286578;7376.55740655561;7624.69501219952;7429.182789893108;7481.40148788097;7484.700611975514;7485.925140748591;7495.362894154004;2186.999999999996;2209.2709405896017;2212.4468882779306;2213.712217411742;2214.9811086900045;2162.264829957814;2190.2772085211923;2192.451887028243;2195.5499122679894;2196.3410976707005;2143.6355819510723;2161.945951351213;2162.9242976495825;2162.9567408651897;2185;2110.3668899330214;2123.055240418015;2123.84071194661;2125.946851328714;2126.5002724359765;2093.9371818845457;2136.113512892148;2136.5513242219154;2136.9252076177413;2140.5076832328496;7206.927930720678;7463.477556571042;7467.55194688315;7549.811254718621;7552.8867066994035;4499.167653984024;4625.213713668684;4640.164770341337;4643.535646435329;4651.186042442559;2791.7627001704877;2949;2982.9850850745606;2983.701629837021;3000.0399872040957;887.3256325192835;893.5978809535735;900.8243392538458;906.5014242166782;908.0238743350858;10051.748706282327;10120.544575494121;10148.543315550818;10157.187425005981;10167.542460589291;3777.150141218259;3942.42834788954;4029.7582145071387;4082.693797965105;4090.4682391288943;8073.878891816627;8092.947916770782;8103.716369927024;8107.229813167857;8108.9594552026865;4493.415855938772;4503.076869241798;4504.954950450519;4511.255642818898;4515.525869783691;3558.9110272242883;3839;4074.1240633263396;4139.441175441337;4142.420061191436;3551.1654761131113;3675.5405574303213;3751.324761542894;3766.981165094212;3814.923701525954;1055.7571758495435;1186.9881301186876;1189.5241903238773;1191.4876603060768;1193.3198077096145;739.2275072549199;849.7323343146888;852.6504133305315;856.905740368559;894.3247847874812;5017.498250175026;5017.724025178651;5025.120603894304;5144.210395114047;5228.63399562027;422.8921624985609;426.81646891836186;429.9398084268205;431.5964573124139;432.5998451432412;3475.600305964796;3573.6069032406413;3594.263176048904;3600.4419315006216;3692.1692619161013;8648.654053837901;8852.734417967471;8932.19610235069;8944.329175311877;8952.731418057469;8913.643454261886;8914.55427228636;8926.642934282685;8927.464352138892;8933.46399216049;6681.198256209286;6880.58716477003;6883.208431030395;6951.339622735832;6969.30306969299;5090.592752579859;5232;5303.734813259399;5318.734063296897;5333.386660534088;8268.586570671563;8274.710385136492;8637.438566493158;8727.91272087271;8731.56342182901;8465;8502.74491765248;8768.912310877065;8812.515311657664;8817.294616430541;5727.341355744143;6323.336049714714;6334.9366506334345;6467.708953097216;6469.708863101266;6967.1291088613925;7249;7274.4907856449545;7278.454115941431;7302.160251571137;6315.463185629273;6364.977178960848;6391.488680905423;6415.262244841716;6529.477641788741;6431.774887879089;6525.086487891794;6550.443212327005;6565.048068030204;6565.507586931095;6226.844328891632;6346.048092786119;6355.872882542416;6362.3319551448285;6362.968185159045;4614.930776038429;4726.834560790356;4756.524347565354;4758.524147585353;4783.115123702126;4630.76846157684;4641.443026836801;4683.578477937002;4709.081729062937;4914.754262286943 10:17:46 INFO - PROCESS | 6164 | |4;prototype.html;282.5704928508668;287.2706308025685;293.8868535613788;297.41706255738745;297.79005800910363;4875.634327425444;4881.511848815126;4907.190313598257;4933.555979961803;4935.383077115361;4548.976480291933;4704.106219818232;4704.882377940553;4710.717356958585;4822.541858523444;3636.8363423646;3689.889303320898;3691.187938653492;3806.5241844769403;3809.923801523968;3788.8484460621544;3795.6773674237725;3826.2730081284467;3834.6357096075967;3839.8464061437508;3667.9816600916956;3772.8113594320175;3776.546029778541;3806.9340584636348;3815.8473661053526;3606.1165014571466;3676.4301533262387;3691.2248427830186;3692.1138926657677;3752.5496940367193;3259.96740032599;3271.8200498972546;3352.8826491072696;3358.9664103358896;3365.478350855621;4687.835925742583;4690.132325519789;4692.366530518405;4698.506656801055;4698.694584852008;3981.482407287034;4331.436913201295;4333.566643335673;4335.1329734053;4335.934960975588;4905.3132561441425;4944.208926571731;4949.331840201563;5004.049230646166;5032.2703208035;3506.264399122451;3507.421275489541;3514.771539849927;3525.6298088700573;3526.3828829954914;5374.785008599691;5401.351837779453;5415.187721841716;5416.945830541684;5420.485053919911;3509.9298014039578;3680.116771974707;3681.4537894084547;3692.095436618046;3695.4848512109907;3736.7197460190596;3745.569259535134;3758.8684396046006;3763.7365384423374;3768.436099018931;4313.460817397825;4315.4605674290715;4316.374125751749;4318.589733975267;4329.783510824446;5055.443901170868;5079;5137.383513978347;5189;5192.662476938987;1285.8555885262124;1302.4204229117952;1303.3352989974992;1305.9281739504418;1307.1307580458888;793.8293266947519;803.7140575079826;827.1769589258726;832.1803024021334;833.4540875726409;4000.179963107556;4002.3596224604507;4037.273290807624;4065.288574499451;4066.7763273019677;4579.5878370946775;4614.976925115353;4623.42207224097;4629.888826681572;4689.695169813951;4090.6727461802984;4093.672506199497;4093.7543747375253;4097.549269580344;4112.979435102805;2513.6229565564945;2638.9736102639113;2765.834049957009;2789.693133755326;2791.776657867366;4934.67924584908;4957.851264462;4958.768554150574;4963.6277279204205;4980.530743430624;5228.398734145622;5344.706041167773;5373;5385.384384684658;5388.084025715638;4899.363082799213;4912.1158191525865;4956.4547899731;4980.900381992267;4983.700977941335;5220.269162317354;5232.267482552522;5236.711980841091;5254.3169387979315;5259.63182577216;4878.585100375195;5105.8723531912;5127.948720512896;5154.355705536808;5160.277561141368;4930.654854160174;4939.357883475125;4992.72540010303;4994.600431965507;5002.474740152232;3731.6268373162466;3744.681702055356;3775.7356985010783;3776.6789822864266;3780.3195424822698;5040.420351659606;5225.16397376418;5247.868803279948;5248.8425347239645;5252.1596544552685;5062.949370506248;5068;5068.189089745771;5069.062223488666;5074.67014644047;5055.6713813602;5069.2902993581665;5089.6691715038405;5118.744062796771;5123.820666276812;4730.172219861442;4937.506249375034;4946.653734238569;4992.001599680151;4996.200607902863;4903.387076615423;4983.750812459435;5092.388913330424;5119.795208191631;5129.461406552258;5010.198368261061;5011.599072074152;5013.24801279811;5015.3480047593575;5025.6482046256415 10:17:46 INFO - PROCESS | 6164 | |5;yui.html;630.4830039367719;666.7099811581962;674.1707699529576;713.2546488919081;714.8641758065967;12139.332336721487;12981.805272920901;13051.086423950328;13098;13098.476060957573;12831.42258598363;12906.677333066678;12931.935340323309;12965.935170324135;12967.805482917764;612.7916508387148;739.1499775258442;741.2624438683517;759.1270039454616;766.3830616353833;756.0549313358302;766.7814672818248;767.17528656694;767.7850201943464;767.8003719033036;805.6535689653476;811.9472234304751;812.1431889356726;812.5165526511746;812.5774597209447;647.5661306924372;774.156169774948;794.7417089445895;807.4267270238167;808.3290868579095;586.0974099886171;586.9207656966298;587.1398401342012;587.1984740828781;587.2571197435248;12159.148859579833;12214.511419543207;12243.938780306042;12297.385130743427;12298.75402491954;12375.443105060203;12456.190347627375;12474.750504989941;12713.491460341667;13014.609561713163;11330.886691133066;11357.015435507104;11644.88355116455;11846.111541634413;12250.44872980709;3926.666233370167;3976.960230397688;4001.619036673175;4099.590040995907;4100.34394496882;51392.486075139146;53739.731301343636;53756.73121634406;59912.101318480694;60634.69682651559;10033.498325083716;10275.332103413255;10415.791684166274;10421.5831366746;10440.582376704999;18747.34384296543;18756.71864922027;18775.248990040247;18785.34251301198;18792.90603547001;6897.206821215524;6905.896411553831;7076.575405475688;7126.251743566954;7154.213036565973;3589;3600.9279814403567;3619.420892657215;3625.510556074896;3693.076730817296;2980.508216144312;3045.771567132474;3059.2963618367453;3063.3720087382035;3068.1102480280915;497.63672519060566;498.7132398870664;500.30457663847284;506.6478797235959;511.16679811907096;501.623044742185;549.2365611799602;593.3147214966721;597.3071237364636;597.9671118088547;7754.573498457639;7803.648835802403;7910.762677119696;8056.133056132971;8245.381596380295;455.6605329029894;528.3263838605732;550.4550495009911;560.716837996809;568.4878223924424;3785.9242815143543;3793.734438589272;3797.316483033025;3837.270918525471;3874.9225015500097;53543;72818.2718172822;76115.61942190364;76473.23526764661;87496.6920484334;47551.52448475471;59133.70433147807;63152.05271920925;81565;82568.17431825725;66332;69180.6540967292;71284.64357678179;72891.63554182195;73764.63117684485;8064.838703225785;8310.792230194293;8404.957975210085;8410.495370277802;8506.532140732319;30387.544186836774;40490.39264410977;44478.55521444744;44709;45490.54509454863;19448.319308824124;47920.041599167125;59045.40954590399;60027.69986150041;61891.690541547;11492.85071492844;11549.538018479167;11643.708907277385;11737.706557335794;11973.485568030812;13186.340682966005;13211.273379964194;13367;13374.398152082986;13760.105593136414;12531.498740050296;12743.74512509726;13105.541306054241;13265.403056862271;13425.127366721132;12117.69705757363;12245.754874957966;12250.142490025613;12383.75232495327;12871.099023068295;12013.459394327101;12607.495700172258;12881.613551593467;12905.806412904001;13127.081104322988;10252;10433.739156521147;10566.947165264124;10615.31000484997;11011.724706882393;9890.357126786736;10463.738406539898;10542.15662746963;10542.262041657317;10566.313189642957 10:17:46 INFO - PROCESS | 6164 | __end_tp_report 10:17:46 INFO - PROCESS | 6164 | __start_cc_report 10:17:46 INFO - PROCESS | 6164 | _x_x_mozilla_cycle_collect,979 10:17:46 INFO - PROCESS | 6164 | __end_cc_report 10:17:46 INFO - PROCESS | 6164 | __startTimestamp1469985466153__endTimestamp 10:17:46 INFO - PROCESS | 6164 | 10:17:46 INFO - PROCESS | 6164 | ------- Summary: start ------- 10:17:46 INFO - PROCESS | 6164 | Number of tests: 6 10:17:46 INFO - PROCESS | 6164 | 10:17:46 INFO - PROCESS | 6164 | [#0] dojo.html Cycles:165 Average:4723.58 Median:4842.21 stddev:501.67 (10.4%) stddev-sans-first:476.38 10:17:46 INFO - PROCESS | 6164 | Values: 2660.2 2662.4 2690.3 2690.5 2699.4 4650.6 4713.7 4713.8 4802.1 4834.3 4700.8 4741.0 4761.9 4768.1 4822.0 4326.1 4334.5 4393.8 4445.4 4527.1 4455.4 4479.5 4512.4 4533.3 4539.6 4275.0 4307.9 4400.2 4412.3 4482.4 4354.0 4355.9 4362.4 4410.1 4414.9 4329.6 4386.4 4392.1 4392.5 4430.0 4634.0 4748.4 4797.4 4811.3 4814.6 5025.4 5028.0 5035.3 5044.1 5063.2 5100.3 5105.9 5122.2 5132.0 5135.7 4700.6 4787.8 4827.3 4832.9 4836.6 5300.1 5303.3 5366.3 5368.4 5375.2 5108.7 5113.3 5117.7 5163.8 5164.0 4991.8 5066.1 5183.3 5193.5 5242.8 5049.7 5057.7 5065.8 5112.9 5117.8 5037.4 5053.5 5054.3 5059.0 5105.0 4142.5 4170.6 4247.5 4251.4 4303.1 3677.9 3692.8 3705.3 3728.7 3788.0 4404.9 4407.5 4410.4 4446.8 4455.4 4968.8 5106.6 5106.8 5111.1 5148.9 4402.5 4406.8 4413.7 4451.7 4453.8 4556.2 4584.4 4588.8 4589.5 4633.2 4788.0 4827.0 4837.8 4841.3 4881.9 4952.4 5058.6 5115.6 5115.9 5152.9 4835.9 4842.2 4846.2 4846.2 4883.1 5061.0 5065.9 5066.3 5067.6 5103.4 4991.7 5019.6 5053.1 5066.0 5138.4 4993.6 5003.0 5003.2 5006.6 5054.5 4990.2 5004.4 5006.1 5007.7 5056.2 4716.2 4816.5 4870.1 4874.5 4915.8 4996.1 5011.4 5015.1 5018.6 5058.9 4899.5 4922.2 4922.3 4924.3 4971.1 10:17:46 INFO - PROCESS | 6164 | 10:17:46 INFO - PROCESS | 6164 | [#1] ext.html Cycles:180 Average:48188.91 Median:3366.78 stddev:85738.53 (2546.6%) stddev-sans-first:85904.45 10:17:46 INFO - PROCESS | 6164 | Values: 554.5 568.1 568.8 570.4 572.2 27197.6 39291.7 40669.0 40833.0 44879.3 42144.6 42584.6 42648.4 42661.4 42697.0 7330.7 7792.4 7939.9 7944.4 7950.7 9839.3 10073.7 10076.5 10499.6 10513.9 10218.6 10280.2 10291.8 10324.1 10356.9 10110.0 10122.8 10151.1 10158.2 10169.1 10034.4 10110.8 10115.7 10116.1 10123.8 39320.6 39611.2 39631.4 39685.2 39703.4 2941.3 3123.3 3177.8 3434.7 3547.8 29716.4 29809.7 30281.8 30357.0 30451.5 3316.4 3361.8 3371.7 3400.9 3403.9 264747.0 265529.0 266712.0 267145.6 267477.0 53397.5 53586.5 53603.5 53672.0 53764.7 57190.0 57215.7 57278.4 57331.4 57347.4 13814.2 13969.3 13982.6 13993.4 14000.6 9916.7 10760.4 11096.3 11133.4 11192.7 15909.3 16078.2 16081.8 16210.9 16343.0 6295.2 6305.5 6359.9 6389.9 6397.1 775.9 823.2 930.8 981.8 1034.6 28207.7 28489.0 28619.7 28954.9 29003.9 939.1 942.2 954.3 956.6 1005.6 14933.5 15156.2 15244.5 15548.7 15580.5 389487.0 396964.0 397852.0 398123.0 399151.0 50800.0 50864.7 50961.0 51181.7 51233.7 1073.2 1137.3 1147.8 1179.1 1199.0 27703.6 29113.9 29158.0 29550.4 29929.0 42843.6 43330.0 43341.6 43363.1 43364.0 300344.0 301787.0 301839.0 302431.0 303207.0 24620.5 25182.5 25293.0 26463.6 26693.2 42537.0 42849.1 42963.6 43600.0 43790.3 35361.8 35424.5 35652.8 36059.8 36220.8 35594.3 35672.8 35890.5 36112.1 36498.0 36051.0 36432.0 36868.4 37182.4 37294.3 30885.5 32660.3 33077.3 33316.7 33445.5 24830.6 25221.6 25446.6 25453.1 25654.7 10:17:46 INFO - PROCESS | 6164 | 10:17:46 INFO - PROCESS | 6164 | [#2] jquery.html Cycles:180 Average:26050.93 Median:4967.48 stddev:71449.72 (1438.3%) stddev-sans-first:71624.08 10:17:46 INFO - PROCESS | 6164 | Values: 340.2 357.3 367.6 368.1 388.4 12468.3 15993.4 16409.0 16467.8 17667.9 16093.0 16615.8 17033.7 17124.2 17189.3 4946.1 4988.9 5114.5 5147.2 5153.9 3653.4 5013.8 5101.9 5102.9 5659.9 5890.8 5944.1 5974.4 5978.7 6008.7 5742.9 5828.2 5860.1 5862.1 5990.0 5189.4 5191.9 5192.7 5197.3 5205.9 19230.0 19493.8 20819.7 20955.9 21031.7 1789.7 1874.5 1894.0 1901.1 2371.8 9305.0 9490.5 9601.1 9703.7 11080.5 1707.6 1713.6 1728.7 1741.8 1742.6 72163.6 72914.3 73052.9 74457.0 75898.0 9933.0 10032.2 10103.4 10206.6 10362.8 14116.9 14136.8 14145.8 14153.6 14158.0 6554.5 6728.8 6809.0 6813.3 6819.6 6101.1 6111.2 6275.7 6280.2 6285.1 4269.4 4314.7 4325.2 4468.7 4472.4 1738.7 1843.4 1871.8 1875.3 1879.8 781.6 821.0 859.0 866.2 902.0 16133.4 16593.8 17089.0 17119.7 17289.7 817.5 823.9 837.3 841.2 867.6 6907.6 9678.9 9737.0 9739.0 9871.4 395731.0 398683.0 449779.0 452513.0 458141.0 85241.0 85864.0 87161.0 89096.6 89390.6 884.4 901.5 931.3 932.7 937.1 15792.7 15920.5 16315.8 16587.9 16920.3 39368.0 39681.6 40214.2 40797.4 41439.4 53843.2 54993.0 55837.4 56001.0 56775.0 7606.1 7626.2 7770.9 7825.7 7854.6 8920.9 11904.7 12199.8 12347.9 12713.9 9811.8 10134.4 10221.7 10649.1 10859.1 10279.1 10304.7 10432.1 10504.1 10601.4 9685.1 10007.7 10339.6 10562.1 10582.6 7776.0 7885.8 7961.0 8169.3 8361.4 7681.0 9360.0 9848.3 10224.0 10230.4 10:17:46 INFO - PROCESS | 6164 | 10:17:46 INFO - PROCESS | 6164 | [#3] mootools.html Cycles:180 Average:4930.04 Median:5017.61 stddev:2691.31 (53.6%) stddev-sans-first:2683.92 10:17:46 INFO - PROCESS | 6164 | Values: 1157.4 1291.6 1353.1 1361.7 1636.2 6349.7 7077.2 7314.6 7376.6 7624.7 7429.2 7481.4 7484.7 7485.9 7495.4 2187.0 2209.3 2212.4 2213.7 2215.0 2162.3 2190.3 2192.5 2195.5 2196.3 2143.6 2161.9 2162.9 2163.0 2185.0 2110.4 2123.1 2123.8 2125.9 2126.5 2093.9 2136.1 2136.6 2136.9 2140.5 7206.9 7463.5 7467.6 7549.8 7552.9 4499.2 4625.2 4640.2 4643.5 4651.2 2791.8 2949.0 2983.0 2983.7 3000.0 887.3 893.6 900.8 906.5 908.0 10051.7 10120.5 10148.5 10157.2 10167.5 3777.2 3942.4 4029.8 4082.7 4090.5 8073.9 8092.9 8103.7 8107.2 8109.0 4493.4 4503.1 4505.0 4511.3 4515.5 3558.9 3839.0 4074.1 4139.4 4142.4 3551.2 3675.5 3751.3 3767.0 3814.9 1055.8 1187.0 1189.5 1191.5 1193.3 739.2 849.7 852.7 856.9 894.3 5017.5 5017.7 5025.1 5144.2 5228.6 422.9 426.8 429.9 431.6 432.6 3475.6 3573.6 3594.3 3600.4 3692.2 8648.7 8852.7 8932.2 8944.3 8952.7 8913.6 8914.6 8926.6 8927.5 8933.5 6681.2 6880.6 6883.2 6951.3 6969.3 5090.6 5232.0 5303.7 5318.7 5333.4 8268.6 8274.7 8637.4 8727.9 8731.6 8465.0 8502.7 8768.9 8812.5 8817.3 5727.3 6323.3 6334.9 6467.7 6469.7 6967.1 7249.0 7274.5 7278.5 7302.2 6315.5 6365.0 6391.5 6415.3 6529.5 6431.8 6525.1 6550.4 6565.0 6565.5 6226.8 6346.0 6355.9 6362.3 6363.0 4614.9 4726.8 4756.5 4758.5 4783.1 4630.8 4641.4 4683.6 4709.1 4914.8 10:17:46 INFO - PROCESS | 6164 | 10:17:46 INFO - PROCESS | 6164 | [#4] prototype.html Cycles:180 Average:4170.79 Median:4701.40 stddev:1224.68 (26.0%) stddev-sans-first:1192.83 10:17:46 INFO - PROCESS | 6164 | Values: 282.6 287.3 293.9 297.4 297.8 4875.6 4881.5 4907.2 4933.6 4935.4 4549.0 4704.1 4704.9 4710.7 4822.5 3636.8 3689.9 3691.2 3806.5 3809.9 3788.8 3795.7 3826.3 3834.6 3839.8 3668.0 3772.8 3776.5 3806.9 3815.8 3606.1 3676.4 3691.2 3692.1 3752.5 3260.0 3271.8 3352.9 3359.0 3365.5 4687.8 4690.1 4692.4 4698.5 4698.7 3981.5 4331.4 4333.6 4335.1 4335.9 4905.3 4944.2 4949.3 5004.0 5032.3 3506.3 3507.4 3514.8 3525.6 3526.4 5374.8 5401.4 5415.2 5416.9 5420.5 3509.9 3680.1 3681.5 3692.1 3695.5 3736.7 3745.6 3758.9 3763.7 3768.4 4313.5 4315.5 4316.4 4318.6 4329.8 5055.4 5079.0 5137.4 5189.0 5192.7 1285.9 1302.4 1303.3 1305.9 1307.1 793.8 803.7 827.2 832.2 833.5 4000.2 4002.4 4037.3 4065.3 4066.8 4579.6 4615.0 4623.4 4629.9 4689.7 4090.7 4093.7 4093.8 4097.5 4113.0 2513.6 2639.0 2765.8 2789.7 2791.8 4934.7 4957.9 4958.8 4963.6 4980.5 5228.4 5344.7 5373.0 5385.4 5388.1 4899.4 4912.1 4956.5 4980.9 4983.7 5220.3 5232.3 5236.7 5254.3 5259.6 4878.6 5105.9 5127.9 5154.4 5160.3 4930.7 4939.4 4992.7 4994.6 5002.5 3731.6 3744.7 3775.7 3776.7 3780.3 5040.4 5225.2 5247.9 5248.8 5252.2 5062.9 5068.0 5068.2 5069.1 5074.7 5055.7 5069.3 5089.7 5118.7 5123.8 4730.2 4937.5 4946.7 4992.0 4996.2 4903.4 4983.8 5092.4 5119.8 5129.5 5010.2 5011.6 5013.2 5015.3 5025.6 10:17:46 INFO - PROCESS | 6164 | 10:17:46 INFO - PROCESS | 6164 | [#5] yui.html Cycles:180 Average:16021.09 Median:4099.97 stddev:21124.28 (515.2%) stddev-sans-first:21151.93 10:17:46 INFO - PROCESS | 6164 | Values: 630.5 666.7 674.2 713.3 714.9 12139.3 12981.8 13051.1 13098.0 13098.5 12831.4 12906.7 12931.9 12965.9 12967.8 612.8 739.1 741.3 759.1 766.4 756.1 766.8 767.2 767.8 767.8 805.7 811.9 812.1 812.5 812.6 647.6 774.2 794.7 807.4 808.3 586.1 586.9 587.1 587.2 587.3 12159.1 12214.5 12243.9 12297.4 12298.8 12375.4 12456.2 12474.8 12713.5 13014.6 11330.9 11357.0 11644.9 11846.1 12250.4 3926.7 3977.0 4001.6 4099.6 4100.3 51392.5 53739.7 53756.7 59912.1 60634.7 10033.5 10275.3 10415.8 10421.6 10440.6 18747.3 18756.7 18775.2 18785.3 18792.9 6897.2 6905.9 7076.6 7126.3 7154.2 3589.0 3600.9 3619.4 3625.5 3693.1 2980.5 3045.8 3059.3 3063.4 3068.1 497.6 498.7 500.3 506.6 511.2 501.6 549.2 593.3 597.3 598.0 7754.6 7803.6 7910.8 8056.1 8245.4 455.7 528.3 550.5 560.7 568.5 3785.9 3793.7 3797.3 3837.3 3874.9 53543.0 72818.3 76115.6 76473.2 87496.7 47551.5 59133.7 63152.1 81565.0 82568.2 66332.0 69180.7 71284.6 72891.6 73764.6 8064.8 8310.8 8405.0 8410.5 8506.5 30387.5 40490.4 44478.6 44709.0 45490.5 19448.3 47920.0 59045.4 60027.7 61891.7 11492.9 11549.5 11643.7 11737.7 11973.5 13186.3 13211.3 13367.0 13374.4 13760.1 12531.5 12743.7 13105.5 13265.4 13425.1 12117.7 12245.8 12250.1 12383.8 12871.1 12013.5 12607.5 12881.6 12905.8 13127.1 10252.0 10433.7 10566.9 10615.3 11011.7 9890.4 10463.7 10542.2 10542.3 10566.3 10:17:46 INFO - PROCESS | 6164 | -------- Summary: end -------- 10:17:46 INFO - PROCESS | 6164 | 10:17:46 INFO - TEST-INFO | 6164: exit 0 10:17:46 INFO - TEST-OK | dromaeo_css | took 1119321ms 10:17:46 INFO - TEST-START | kraken 10:17:46 INFO - operating with platform_type : linux_ 10:17:46 INFO - Initialising browser for kraken test... 10:17:46 INFO - TEST-INFO | started process 6352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDD44_J/profile http://localhost:44096/getInfo.html) 10:17:50 INFO - PROCESS | 6352 | __metrics Screen width/height:1600/1200 10:17:50 INFO - PROCESS | 6352 | colorDepth:24 10:17:50 INFO - PROCESS | 6352 | Browser inner width/height: 1024/697 10:17:50 INFO - PROCESS | 6352 | __metrics 10:17:51 INFO - PROCESS | 6352 | 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" 10:17:51 INFO - PROCESS | 6352 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:52 INFO - TEST-INFO | 6352: exit 0 10:17:52 INFO - Browser initialized. 10:17:52 INFO - Running cycle 1/1 for kraken test... 10:17:52 INFO - TEST-INFO | started process 6431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDD44_J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:04 INFO - PROCESS | 6431 | RSS: Main: 157270016 10:18:04 INFO - PROCESS | 6431 | 10:18:07 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44096/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:08 INFO - PROCESS | 6431 | RSS: Main: 213196800 10:18:08 INFO - PROCESS | 6431 | 10:18:11 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44096/tests/kraken/driver.html?testName=audio-dft) 10:18:11 INFO - PROCESS | 6431 | RSS: Main: 191066112 10:18:11 INFO - PROCESS | 6431 | 10:18:14 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44096/tests/kraken/driver.html?testName=audio-fft) 10:18:15 INFO - PROCESS | 6431 | RSS: Main: 269574144 10:18:15 INFO - PROCESS | 6431 | 10:18:17 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44096/tests/kraken/driver.html?testName=audio-oscillator) 10:18:18 INFO - PROCESS | 6431 | RSS: Main: 180338688 10:18:18 INFO - PROCESS | 6431 | 10:18:20 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:21 INFO - PROCESS | 6431 | RSS: Main: 184434688 10:18:21 INFO - PROCESS | 6431 | 10:18:24 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44096/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:24 INFO - PROCESS | 6431 | RSS: Main: 221102080 10:18:24 INFO - PROCESS | 6431 | 10:18:28 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44096/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:28 INFO - PROCESS | 6431 | RSS: Main: 215175168 10:18:28 INFO - PROCESS | 6431 | 10:18:31 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44096/tests/kraken/driver.html?testName=json-parse-financial) 10:18:32 INFO - PROCESS | 6431 | RSS: Main: 218460160 10:18:32 INFO - PROCESS | 6431 | 10:18:34 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:34 INFO - PROCESS | 6431 | RSS: Main: 184254464 10:18:34 INFO - PROCESS | 6431 | 10:18:36 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:37 INFO - PROCESS | 6431 | RSS: Main: 189153280 10:18:37 INFO - PROCESS | 6431 | 10:18:39 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:40 INFO - PROCESS | 6431 | RSS: Main: 193515520 10:18:40 INFO - PROCESS | 6431 | 10:18:42 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:43 INFO - PROCESS | 6431 | RSS: Main: 188510208 10:18:43 INFO - PROCESS | 6431 | 10:18:46 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:46 INFO - PROCESS | 6431 | RSS: Main: 192335872 10:18:46 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44096/tests/kraken/driver.html?testName=ai-astar) 10:18:48 INFO - PROCESS | 6431 | RSS: Main: 243130368 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | __start_tp_report 10:18:48 INFO - PROCESS | 6431 | _x_x_mozilla_page_load 10:18:48 INFO - PROCESS | 6431 | _x_x_mozilla_page_load_details 10:18:48 INFO - PROCESS | 6431 | |i|pagename|runs| 10:18:48 INFO - PROCESS | 6431 | |0;ai-astar;105;114;113;113;114;115;116;113;113;114 10:18:48 INFO - PROCESS | 6431 | |1;audio-beat-detection;147;123;124;201;126;125;145;124;181;121 10:18:48 INFO - PROCESS | 6431 | |2;audio-dft;161;159;162;160;160;160;161;162;161;166 10:18:48 INFO - PROCESS | 6431 | |3;audio-fft;75;75;76;122;76;78;76;75;105;75 10:18:48 INFO - PROCESS | 6431 | |4;audio-oscillator;84;85;127;85;85;87;118;84;84;126 10:18:48 INFO - PROCESS | 6431 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;116;117 10:18:48 INFO - PROCESS | 6431 | |6;imaging-darkroom;146;146;148;146;146;146;147;147;146;146 10:18:48 INFO - PROCESS | 6431 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 10:18:48 INFO - PROCESS | 6431 | |8;json-parse-financial;64;63;62;63;62;62;63;62;61;63 10:18:48 INFO - PROCESS | 6431 | |9;json-stringify-tinderbox;66;65;66;65;67;65;65;66;65;65 10:18:48 INFO - PROCESS | 6431 | |10;stanford-crypto-aes;89;79;79;78;78;79;79;89;88;82 10:18:48 INFO - PROCESS | 6431 | |11;stanford-crypto-ccm;133;131;130;154;134;129;126;150;169;133 10:18:48 INFO - PROCESS | 6431 | |12;stanford-crypto-pbkdf2;163;165;164;164;163;169;163;164;164;163 10:18:48 INFO - PROCESS | 6431 | |13;stanford-crypto-sha256-iterative;72;67;68;65;67;69;67;68;65;67 10:18:48 INFO - PROCESS | 6431 | __end_tp_report 10:18:48 INFO - PROCESS | 6431 | __start_cc_report 10:18:48 INFO - PROCESS | 6431 | _x_x_mozilla_cycle_collect,1958 10:18:48 INFO - PROCESS | 6431 | __end_cc_report 10:18:48 INFO - PROCESS | 6431 | __startTimestamp1469985528950__endTimestamp 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | ------- Summary: start ------- 10:18:48 INFO - PROCESS | 6431 | Number of tests: 14 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.98 (2.6%) stddev-sans-first:1.05 10:18:48 INFO - PROCESS | 6431 | Values: 105.0 114.0 113.0 113.0 114.0 115.0 116.0 113.0 113.0 114.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:135.50 stddev:27.95 (20.6%) stddev-sans-first:29.58 10:18:48 INFO - PROCESS | 6431 | Values: 147.0 123.0 124.0 201.0 126.0 125.0 145.0 124.0 181.0 121.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.93 (1.2%) stddev-sans-first:2.05 10:18:48 INFO - PROCESS | 6431 | Values: 161.0 159.0 162.0 160.0 160.0 160.0 161.0 162.0 161.0 166.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.50 stddev:16.44 (21.8%) stddev-sans-first:17.16 10:18:48 INFO - PROCESS | 6431 | Values: 75.0 75.0 76.0 122.0 76.0 78.0 76.0 75.0 105.0 75.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:84.50 stddev:18.91 (22.4%) stddev-sans-first:19.51 10:18:48 INFO - PROCESS | 6431 | Values: 84.0 85.0 127.0 85.0 85.0 87.0 118.0 84.0 84.0 126.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:18:48 INFO - PROCESS | 6431 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:18:48 INFO - PROCESS | 6431 | Values: 146.0 146.0 148.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:18:48 INFO - PROCESS | 6431 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 10:18:48 INFO - PROCESS | 6431 | Values: 64.0 63.0 62.0 63.0 62.0 62.0 63.0 62.0 61.0 63.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 10:18:48 INFO - PROCESS | 6431 | Values: 66.0 65.0 66.0 65.0 67.0 65.0 65.0 66.0 65.0 65.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:80.50 stddev:4.74 (5.9%) stddev-sans-first:4.29 10:18:48 INFO - PROCESS | 6431 | Values: 89.0 79.0 79.0 78.0 78.0 79.0 79.0 89.0 88.0 82.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:133.50 stddev:13.97 (10.5%) stddev-sans-first:14.66 10:18:48 INFO - PROCESS | 6431 | Values: 133.0 131.0 130.0 154.0 134.0 129.0 126.0 150.0 169.0 133.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.00 stddev:1.81 (1.1%) stddev-sans-first:1.87 10:18:48 INFO - PROCESS | 6431 | Values: 163.0 165.0 164.0 164.0 163.0 169.0 163.0 164.0 164.0 163.0 10:18:48 INFO - PROCESS | 6431 | 10:18:48 INFO - PROCESS | 6431 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:2.01 (3.0%) stddev-sans-first:1.32 10:18:48 INFO - PROCESS | 6431 | Values: 72.0 67.0 68.0 65.0 67.0 69.0 67.0 68.0 65.0 67.0 10:18:48 INFO - PROCESS | 6431 | -------- Summary: end -------- 10:18:48 INFO - PROCESS | 6431 | 10:18:50 INFO - TEST-INFO | 6431: exit 0 10:18:50 INFO - TEST-OK | kraken | took 63117ms 10:18:50 INFO - SUITE-END | took 1182s 10:18:50 INFO - Completed test suite (00:19:42) 10:18:50 INFO - javascript benchmark 10:18:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.2152365052307, 2662.4275780707144, 2690.3274181454635, 2690.5291573974564, 2699.4331190450016, 4650.627949764019, 4713.693609915353, 4713.8114475421025, 4802.087603355364, 4834.347363105984, 4700.835470758524, 4740.976295118519, 4761.90476190476, 4768.141734487791, 4822.0, 4326.113146804905, 4334.501532323776, 4393.758343291118, 4445.444319460067, 4527.071950250191, 4455.353973673816, 4479.484859241196, 4512.368268442421, 4533.274676051832, 4539.6368290536675, 4274.995376086617, 4307.935380969288, 4400.185965596343, 4412.338149277602, 4482.439695038121, 4354.042110735633, 4355.934660980088, 4362.367456718758, 4410.140022695576, 4414.933775993362, 4329.610335069859, 4386.407834942306, 4392.143532011259, 4392.538783427726, 4430.0, 4633.976830115827, 4748.406449193851, 4797.376341075673, 4811.326414302001, 4814.5907597853875, 5025.447200807908, 5028.044671512437, 5035.3454050973505, 5044.117279476113, 5063.215201643751, 5100.311457953166, 5105.872353191163, 5122.231665250242, 5131.974340128313, 5135.6918584885025, 4700.600448961876, 4787.784549695272, 4827.25177597473, 4832.8791780205775, 4836.637252206028, 5300.12547929595, 5303.28405665238, 5366.302380690485, 5368.355797304271, 5375.220593013991, 5108.693478391308, 5113.284140220372, 5117.744112794346, 5163.8192663256605, 5164.0, 4991.800327986913, 5066.138756411419, 5183.300254465675, 5193.480651934852, 5242.7640756166065, 5049.747512624354, 5057.671251368649, 5065.797368105234, 5112.872178195575, 5117.795288188431, 5037.420696619935, 5053.545180933734, 5054.267131265946, 5059.038782631362, 5105.0, 4142.482189726285, 4170.645495132948, 4247.532771395144, 4251.404803327537, 4303.096349766522, 3677.9080522987138, 3692.7599706019023, 3705.2959937611768, 3728.7389882708494, 3788.0340513169517, 4404.867853964386, 4407.515173330931, 4410.360497727812, 4446.755428451402, 4455.443069616298, 4968.826091086795, 5106.591472682177, 5106.795728170831, 5111.054454925777, 5148.9485105149215, 4402.471703395613, 4406.779661016936, 4413.7351758894565, 4451.666125040635, 4453.844115455943, 4556.248219043887, 4584.426946631671, 4588.770561471913, 4589.472210695746, 4633.189191891405, 4788.0, 4826.975865120652, 4837.782299796448, 4841.346418233635, 4881.877953051202, 4952.356193694796, 5058.620603454682, 5115.590752739847, 5115.9232611510115, 5152.948470515397, 4835.879103022453, 4842.206215846357, 4846.151923413459, 4846.200376937766, 4883.121038213014, 5061.038402703622, 5065.949340506548, 5066.341375621146, 5067.645264831426, 5103.387593488805, 4991.700497970133, 5019.598432125348, 5053.065182941167, 5065.974670126626, 5138.434772175133, 4993.600511958962, 5003.024410239968, 5003.199488081889, 5006.6495345325475, 5054.545090941833, 4990.201567749143, 5004.4495105537635, 5006.098902197494, 5007.674501157413, 5056.241563765465, 4716.174669432904, 4816.518348165156, 4870.050340183772, 4874.512548745097, 4915.778789954389, 4996.100701873697, 5011.4487406386, 5015.122353588181, 5018.648694591489, 5058.9494105058475, 4899.534544218293, 4922.187839006524, 4922.335484709519, 4924.335214745964, 4971.055499455092], "value": 4691.268409511999, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.52865064695, 568.0598609301604, 568.7838621323897, 570.4067769519698, 572.2360648534207, 27197.592036119448, 39291.695621091145, 40669.0, 40832.97917552059, 44879.326810097795, 42144.57855421445, 42584.57415425845, 42648.36027459591, 42661.36007959883, 42697.0, 7330.706771729125, 7792.376609871225, 7939.920600794005, 7944.443888927777, 7950.681972721113, 9839.311248212627, 10073.69778906634, 10076.496175191247, 10499.632512862052, 10513.894861051369, 10218.642347517838, 10280.22898282628, 10291.845622315672, 10324.122449591794, 10356.948215258913, 10110.039546243095, 10122.848157277647, 10151.086402223762, 10158.238132140044, 10169.135623472013, 10034.448105354202, 10110.797784044278, 10115.696529104138, 10116.14012808912, 10123.79752404955, 39320.60679393227, 39611.20777584432, 39631.40552891709, 39685.20629587421, 39703.40444893329, 2941.2940894185454, 3123.2660324823646, 3177.8252196129206, 3434.7423943204108, 3547.840347184383, 29716.40567188644, 29809.701902981127, 30281.848590756905, 30357.0, 30451.543226851616, 3316.3698897209692, 3361.8151001694896, 3371.7471189660873, 3400.931981360359, 3403.8523834442153, 264747.0, 265529.0, 266712.0, 267145.6211659889, 267476.9999999981, 53397.46602533925, 53586.464135358925, 53603.46396536063, 53672.0, 53764.73117634465, 57190.0, 57215.71392143096, 57278.427215728145, 57331.42668573261, 57347.42652573421, 13814.171149731048, 13969.301534923214, 13982.58052258434, 13993.440262389391, 14000.579982600539, 9916.702498925044, 10760.3543787373, 11096.33421994683, 11133.387663678575, 11192.720181995352, 15909.284082216096, 16078.196090195677, 16081.758773618405, 16210.918945405198, 16343.0, 6295.244570651551, 6305.495560355161, 6359.872802544016, 6389.872202555923, 6397.072424498421, 775.9107702614272, 823.1685997142929, 930.8371035068836, 981.7923953537047, 1034.6482196053378, 28207.71792282092, 28489.0, 28619.713802862123, 28954.855225723735, 29003.854980724962, 939.0703203828161, 942.2414955960518, 954.2509130332655, 956.5791051937125, 1005.6027868991707, 14933.477328293458, 15156.24218789056, 15244.46644367464, 15548.689026219412, 15580.454684086002, 389487.0, 396964.0, 397852.0, 398123.0, 399151.0, 50800.0, 50864.74567627212, 50961.0, 51181.7440912793, 51233.743831280604, 1073.173656284672, 1137.3005601554985, 1147.8106112491346, 1179.0685358566636, 1199.040767386105, 27703.58444623292, 29113.85443072771, 29158.0, 29550.40899181961, 29929.0, 42843.57156428396, 43330.0, 43341.566584333756, 43363.132737344444, 43364.0, 300344.0, 301787.0, 301839.0, 302431.0, 303207.0, 24620.507589847744, 25182.496350073263, 25293.0, 26463.60304595471, 26693.19920402391, 42537.0, 42849.14301714011, 42963.570364295956, 43600.0, 43790.34314485222, 35361.82319088388, 35424.46863297001, 35652.82173589219, 36059.81970090133, 36220.81889590535, 35594.28811423705, 35672.821635891654, 35890.46164307485, 36112.094013046895, 36498.0, 36051.0, 36432.0, 36868.446973294886, 37182.44226336553, 37294.25411491809, 30885.536716949715, 32660.34679306353, 33077.33845323032, 33316.66683333136, 33445.498317525744, 24830.627540586545, 25221.621675675247, 25446.618300725873, 25453.109141179968, 25654.74345256598], "value": 18098.01765817608, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.23956457317905, 357.2889949001488, 367.64154948924795, 368.123865200822, 388.35533015194767, 12468.251904885701, 15993.440229591966, 16409.0, 16467.752983705253, 17667.91166044171, 16093.034417934932, 16615.750763738553, 17033.659326813457, 17124.22940967656, 17189.312427502886, 4946.084974279761, 4988.87527811804, 5114.488551144893, 5147.2021836615195, 5153.922691159635, 3653.4337177737493, 5013.799448022075, 5101.923471147936, 5102.872428189288, 5659.886802263953, 5890.823275301726, 5944.138099975501, 5974.372690867462, 5978.671173085479, 6008.669523176223, 5742.942570574303, 5828.242328497311, 5860.091685788667, 5862.14998825168, 5989.999999999978, 5189.42916279209, 5191.870203244911, 5192.688438693691, 5197.272381866542, 5205.9219111713355, 19230.0, 19493.805061949482, 20819.687704684442, 20955.8952205238, 21031.68452473214, 1789.6868048091662, 1874.46577725349, 1894.043508028437, 1901.1254822781536, 2371.822113341489, 9305.0, 9490.525473726355, 9601.087896649808, 9703.66037188695, 11080.501377438035, 1707.5731067233191, 1713.5801728576455, 1728.680194164071, 1741.7909850817982, 1742.581780372714, 72163.63918180375, 72914.27085729128, 73052.90420643748, 74457.0, 75898.0, 9932.950335248423, 10032.247581431422, 10103.444310562989, 10206.64276750325, 10362.792744145076, 14116.85883141176, 14136.787948180785, 14145.787813182811, 14153.646158846112, 14158.0, 6554.475641948633, 6728.798136055926, 6808.9659551701925, 6813.284605116491, 6819.556728812611, 6101.145839582462, 6111.236095488064, 6275.654838983808, 6280.183576135165, 6285.120083188357, 4269.4449721536, 4314.71954322968, 4325.243082460557, 4468.664850136252, 4472.351509031172, 1738.7304967730022, 1843.3824668735856, 1871.775386953547, 1875.2967637136073, 1879.8402135818608, 781.6248200863618, 820.971266005687, 858.965641374338, 866.2204016385177, 901.977450563728, 16133.354665813471, 16593.83406165947, 17089.0, 17119.65760684779, 17289.740653890203, 817.4808996287401, 823.9093699693029, 837.250660658707, 841.2386789955101, 867.5922316511229, 6907.551009184387, 9678.854817177747, 9736.95131524352, 9738.951305243429, 9871.358361706467, 395731.0, 398683.0, 449779.0, 452513.0, 458141.0, 85241.0, 85864.0, 87161.0, 89096.55451722699, 89390.55304723565, 884.4207044385937, 901.4996676844414, 931.3340961212765, 932.7388331267256, 937.1097457415483, 15792.684146317239, 15920.52238432849, 16315.755263671292, 16587.91706041462, 16920.32318707238, 39368.0, 39681.60318396779, 40214.19571608493, 40797.38803918003, 41439.37840932449, 53843.19235211553, 54993.0, 55837.44162558485, 56001.0, 56775.0, 7606.125295590857, 7626.237376262329, 7770.9120723097685, 7825.686972521263, 7854.625440547996, 8920.910790892009, 11904.702382440508, 12199.817002744789, 12347.938260308641, 12713.93643031779, 9811.754706132404, 10134.391936483835, 10221.693349199535, 10649.094826939798, 10859.07697845692, 10279.149753044523, 10304.690859273935, 10432.061114499731, 10504.10715089226, 10601.363918164934, 9685.079917407835, 10007.699769006942, 10339.638112666322, 10562.102221311274, 10582.576696932036, 7776.0, 7885.763427097197, 7961.0, 8169.2647661710735, 8361.372897032625, 7680.961595191989, 9359.953200233955, 9848.261380396356, 10224.0, 10230.437325947145], "value": 8276.686431315447, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1157.3981529604612, 1291.5608693044367, 1353.0596235616247, 1361.6868120332324, 1636.1982628512033, 6349.746010159593, 7077.186123595788, 7314.634268286578, 7376.55740655561, 7624.69501219952, 7429.182789893108, 7481.40148788097, 7484.700611975514, 7485.925140748591, 7495.362894154004, 2186.999999999996, 2209.2709405896017, 2212.4468882779306, 2213.712217411742, 2214.9811086900045, 2162.264829957814, 2190.2772085211923, 2192.451887028243, 2195.5499122679894, 2196.3410976707005, 2143.6355819510723, 2161.945951351213, 2162.9242976495825, 2162.9567408651897, 2185.0, 2110.3668899330214, 2123.055240418015, 2123.84071194661, 2125.946851328714, 2126.5002724359765, 2093.9371818845457, 2136.113512892148, 2136.5513242219154, 2136.9252076177413, 2140.5076832328496, 7206.927930720678, 7463.477556571042, 7467.55194688315, 7549.811254718621, 7552.8867066994035, 4499.167653984024, 4625.213713668684, 4640.164770341337, 4643.535646435329, 4651.186042442559, 2791.7627001704877, 2949.0, 2982.9850850745606, 2983.701629837021, 3000.0399872040957, 887.3256325192835, 893.5978809535735, 900.8243392538458, 906.5014242166782, 908.0238743350858, 10051.748706282327, 10120.544575494121, 10148.543315550818, 10157.187425005981, 10167.542460589291, 3777.150141218259, 3942.42834788954, 4029.7582145071387, 4082.693797965105, 4090.4682391288943, 8073.878891816627, 8092.947916770782, 8103.716369927024, 8107.229813167857, 8108.9594552026865, 4493.415855938772, 4503.076869241798, 4504.954950450519, 4511.255642818898, 4515.525869783691, 3558.9110272242883, 3839.0, 4074.1240633263396, 4139.441175441337, 4142.420061191436, 3551.1654761131113, 3675.5405574303213, 3751.324761542894, 3766.981165094212, 3814.923701525954, 1055.7571758495435, 1186.9881301186876, 1189.5241903238773, 1191.4876603060768, 1193.3198077096145, 739.2275072549199, 849.7323343146888, 852.6504133305315, 856.905740368559, 894.3247847874812, 5017.498250175026, 5017.724025178651, 5025.120603894304, 5144.210395114047, 5228.63399562027, 422.8921624985609, 426.81646891836186, 429.9398084268205, 431.5964573124139, 432.5998451432412, 3475.600305964796, 3573.6069032406413, 3594.263176048904, 3600.4419315006216, 3692.1692619161013, 8648.654053837901, 8852.734417967471, 8932.19610235069, 8944.329175311877, 8952.731418057469, 8913.643454261886, 8914.55427228636, 8926.642934282685, 8927.464352138892, 8933.46399216049, 6681.198256209286, 6880.58716477003, 6883.208431030395, 6951.339622735832, 6969.30306969299, 5090.592752579859, 5232.0, 5303.734813259399, 5318.734063296897, 5333.386660534088, 8268.586570671563, 8274.710385136492, 8637.438566493158, 8727.91272087271, 8731.56342182901, 8465.0, 8502.74491765248, 8768.912310877065, 8812.515311657664, 8817.294616430541, 5727.341355744143, 6323.336049714714, 6334.9366506334345, 6467.708953097216, 6469.708863101266, 6967.1291088613925, 7249.0, 7274.4907856449545, 7278.454115941431, 7302.160251571137, 6315.463185629273, 6364.977178960848, 6391.488680905423, 6415.262244841716, 6529.477641788741, 6431.774887879089, 6525.086487891794, 6550.443212327005, 6565.048068030204, 6565.507586931095, 6226.844328891632, 6346.048092786119, 6355.872882542416, 6362.3319551448285, 6362.968185159045, 4614.930776038429, 4726.834560790356, 4756.524347565354, 4758.524147585353, 4783.115123702126, 4630.76846157684, 4641.443026836801, 4683.578477937002, 4709.081729062937, 4914.754262286943], "value": 3946.4297824945997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.5704928508668, 287.2706308025685, 293.8868535613788, 297.41706255738745, 297.79005800910363, 4875.634327425444, 4881.511848815126, 4907.190313598257, 4933.555979961803, 4935.383077115361, 4548.976480291933, 4704.106219818232, 4704.882377940553, 4710.717356958585, 4822.541858523444, 3636.8363423646, 3689.889303320898, 3691.187938653492, 3806.5241844769403, 3809.923801523968, 3788.8484460621544, 3795.6773674237725, 3826.2730081284467, 3834.6357096075967, 3839.8464061437508, 3667.9816600916956, 3772.8113594320175, 3776.546029778541, 3806.9340584636348, 3815.8473661053526, 3606.1165014571466, 3676.4301533262387, 3691.2248427830186, 3692.1138926657677, 3752.5496940367193, 3259.96740032599, 3271.8200498972546, 3352.8826491072696, 3358.9664103358896, 3365.478350855621, 4687.835925742583, 4690.132325519789, 4692.366530518405, 4698.506656801055, 4698.694584852008, 3981.482407287034, 4331.436913201295, 4333.566643335673, 4335.1329734053, 4335.934960975588, 4905.3132561441425, 4944.208926571731, 4949.331840201563, 5004.049230646166, 5032.2703208035, 3506.264399122451, 3507.421275489541, 3514.771539849927, 3525.6298088700573, 3526.3828829954914, 5374.785008599691, 5401.351837779453, 5415.187721841716, 5416.945830541684, 5420.485053919911, 3509.9298014039578, 3680.116771974707, 3681.4537894084547, 3692.095436618046, 3695.4848512109907, 3736.7197460190596, 3745.569259535134, 3758.8684396046006, 3763.7365384423374, 3768.436099018931, 4313.460817397825, 4315.4605674290715, 4316.374125751749, 4318.589733975267, 4329.783510824446, 5055.443901170868, 5079.0, 5137.383513978347, 5189.0, 5192.662476938987, 1285.8555885262124, 1302.4204229117952, 1303.3352989974992, 1305.9281739504418, 1307.1307580458888, 793.8293266947519, 803.7140575079826, 827.1769589258726, 832.1803024021334, 833.4540875726409, 4000.179963107556, 4002.3596224604507, 4037.273290807624, 4065.288574499451, 4066.7763273019677, 4579.5878370946775, 4614.976925115353, 4623.42207224097, 4629.888826681572, 4689.695169813951, 4090.6727461802984, 4093.672506199497, 4093.7543747375253, 4097.549269580344, 4112.979435102805, 2513.6229565564945, 2638.9736102639113, 2765.834049957009, 2789.693133755326, 2791.776657867366, 4934.67924584908, 4957.851264462, 4958.768554150574, 4963.6277279204205, 4980.530743430624, 5228.398734145622, 5344.706041167773, 5373.0, 5385.384384684658, 5388.084025715638, 4899.363082799213, 4912.1158191525865, 4956.4547899731, 4980.900381992267, 4983.700977941335, 5220.269162317354, 5232.267482552522, 5236.711980841091, 5254.3169387979315, 5259.63182577216, 4878.585100375195, 5105.8723531912, 5127.948720512896, 5154.355705536808, 5160.277561141368, 4930.654854160174, 4939.357883475125, 4992.72540010303, 4994.600431965507, 5002.474740152232, 3731.6268373162466, 3744.681702055356, 3775.7356985010783, 3776.6789822864266, 3780.3195424822698, 5040.420351659606, 5225.16397376418, 5247.868803279948, 5248.8425347239645, 5252.1596544552685, 5062.949370506248, 5068.0, 5068.189089745771, 5069.062223488666, 5074.67014644047, 5055.6713813602, 5069.2902993581665, 5089.6691715038405, 5118.744062796771, 5123.820666276812, 4730.172219861442, 4937.506249375034, 4946.653734238569, 4992.001599680151, 4996.200607902863, 4903.387076615423, 4983.750812459435, 5092.388913330424, 5119.795208191631, 5129.461406552258, 5010.198368261061, 5011.599072074152, 5013.24801279811, 5015.3480047593575, 5025.6482046256415], "value": 3778.9822594204425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.4830039367719, 666.7099811581962, 674.1707699529576, 713.2546488919081, 714.8641758065967, 12139.332336721487, 12981.805272920901, 13051.086423950328, 13098.0, 13098.476060957573, 12831.42258598363, 12906.677333066678, 12931.935340323309, 12965.935170324135, 12967.805482917764, 612.7916508387148, 739.1499775258442, 741.2624438683517, 759.1270039454616, 766.3830616353833, 756.0549313358302, 766.7814672818248, 767.17528656694, 767.7850201943464, 767.8003719033036, 805.6535689653476, 811.9472234304751, 812.1431889356726, 812.5165526511746, 812.5774597209447, 647.5661306924372, 774.156169774948, 794.7417089445895, 807.4267270238167, 808.3290868579095, 586.0974099886171, 586.9207656966298, 587.1398401342012, 587.1984740828781, 587.2571197435248, 12159.148859579833, 12214.511419543207, 12243.938780306042, 12297.385130743427, 12298.75402491954, 12375.443105060203, 12456.190347627375, 12474.750504989941, 12713.491460341667, 13014.609561713163, 11330.886691133066, 11357.015435507104, 11644.88355116455, 11846.111541634413, 12250.44872980709, 3926.666233370167, 3976.960230397688, 4001.619036673175, 4099.590040995907, 4100.34394496882, 51392.486075139146, 53739.731301343636, 53756.73121634406, 59912.101318480694, 60634.69682651559, 10033.498325083716, 10275.332103413255, 10415.791684166274, 10421.5831366746, 10440.582376704999, 18747.34384296543, 18756.71864922027, 18775.248990040247, 18785.34251301198, 18792.90603547001, 6897.206821215524, 6905.896411553831, 7076.575405475688, 7126.251743566954, 7154.213036565973, 3589.0, 3600.9279814403567, 3619.420892657215, 3625.510556074896, 3693.076730817296, 2980.508216144312, 3045.771567132474, 3059.2963618367453, 3063.3720087382035, 3068.1102480280915, 497.63672519060566, 498.7132398870664, 500.30457663847284, 506.6478797235959, 511.16679811907096, 501.623044742185, 549.2365611799602, 593.3147214966721, 597.3071237364636, 597.9671118088547, 7754.573498457639, 7803.648835802403, 7910.762677119696, 8056.133056132971, 8245.381596380295, 455.6605329029894, 528.3263838605732, 550.4550495009911, 560.716837996809, 568.4878223924424, 3785.9242815143543, 3793.734438589272, 3797.316483033025, 3837.270918525471, 3874.9225015500097, 53543.0, 72818.2718172822, 76115.61942190364, 76473.23526764661, 87496.6920484334, 47551.52448475471, 59133.70433147807, 63152.05271920925, 81565.0, 82568.17431825725, 66332.0, 69180.6540967292, 71284.64357678179, 72891.63554182195, 73764.63117684485, 8064.838703225785, 8310.792230194293, 8404.957975210085, 8410.495370277802, 8506.532140732319, 30387.544186836774, 40490.39264410977, 44478.55521444744, 44709.0, 45490.54509454863, 19448.319308824124, 47920.041599167125, 59045.40954590399, 60027.69986150041, 61891.690541547, 11492.85071492844, 11549.538018479167, 11643.708907277385, 11737.706557335794, 11973.485568030812, 13186.340682966005, 13211.273379964194, 13367.0, 13374.398152082986, 13760.105593136414, 12531.498740050296, 12743.74512509726, 13105.541306054241, 13265.403056862271, 13425.127366721132, 12117.69705757363, 12245.754874957966, 12250.142490025613, 12383.75232495327, 12871.099023068295, 12013.459394327101, 12607.495700172258, 12881.613551593467, 12905.806412904001, 13127.081104322988, 10252.0, 10433.739156521147, 10566.947165264124, 10615.31000484997, 11011.724706882393, 9890.357126786736, 10463.738406539898, 10542.15662746963, 10542.262041657317, 10566.313189642957], "value": 6443.978413790275, "unit": "score"}], "name": "dromaeo_css", "value": 6381.567413736686, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 113.0, 114.0, 115.0, 116.0, 113.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 124.0, 201.0, 126.0, 125.0, 145.0, 124.0, 181.0, 121.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 162.0, 160.0, 160.0, 160.0, 161.0, 162.0, 161.0, 166.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 122.0, 76.0, 78.0, 76.0, 75.0, 105.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 127.0, 85.0, 85.0, 87.0, 118.0, 84.0, 84.0, 126.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 61.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 79.0, 79.0, 78.0, 78.0, 79.0, 79.0, 89.0, 88.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 130.0, 154.0, 134.0, 129.0, 126.0, 150.0, 169.0, 133.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 164.0, 163.0, 169.0, 163.0, 164.0, 164.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 68.0, 65.0, 67.0, 69.0, 67.0, 68.0, 65.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1534.3000000000002, "alertThreshold": 2.0}]} 10:18:50 INFO - Return code: 0 10:18:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:50 INFO - # TBPL SUCCESS # 10:18:50 INFO - Running post-action listener: _resource_record_post_action 10:18:50 INFO - [mozharness: 2016-07-31 17:18:50.266036Z] Finished run-tests step (success) 10:18:50 INFO - Running post-run listener: _resource_record_post_run 10:18:50 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 421888; Write bytes: 283250688; Read time: 32; Write time: 229996 10:18:50 INFO - TinderboxPrint: CPU usage
13.0% 10:18:50 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 32 10:18:50 INFO - TinderboxPrint: I/O write bytes / time
283,250,688 / 229,996 10:18:50 INFO - TinderboxPrint: CPU idle
8,327.7 (87.0%) 10:18:50 INFO - TinderboxPrint: CPU user
1,199.3 (12.5%) 10:18:50 INFO - TinderboxPrint: Swap in / out
0 / 0 10:18:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1196032; Read time: 0; Write time: 52 10:18:50 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 417792; Write bytes: 282054656; Read time: 24; Write time: 229944 10:18:50 INFO - Running post-run listener: _upload_blobber_files 10:18:50 INFO - Blob upload gear active. 10:18:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:50 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 10:18:50 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:18:50 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:18:51 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:54 INFO - (blobuploader) - INFO - Done attempting. 10:18:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:55 INFO - (blobuploader) - INFO - Done attempting. 10:18:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:18:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:18:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:56 INFO - (blobuploader) - INFO - Done attempting. 10:18:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:56 INFO - Return code: 0 10:18:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70bd5f84f6950d8c08e1d1643f5288cb2f90e562b94babd70b7f576332ef5f8703b214289fb0be5aac4e5cc52725596b70ce180dbd9fec825f5571ba68a9eba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd09a0d8bc54f0cecc165e25bc579672f099c368568f3248cd86e61199b1f8be663affafcb9c44110db7dd9415b0213941846bc45a2905ae932f147b4b083704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c157125ad67dc217f33281dcaa0bb4573147710ab5d81728ddb3954e883aaddfce1f0fd2f43b880e5be8c7e59b0489dcd336d193dbd6f6e4679d2039da4592f2"} 10:18:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:56 INFO - Contents: 10:18:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70bd5f84f6950d8c08e1d1643f5288cb2f90e562b94babd70b7f576332ef5f8703b214289fb0be5aac4e5cc52725596b70ce180dbd9fec825f5571ba68a9eba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd09a0d8bc54f0cecc165e25bc579672f099c368568f3248cd86e61199b1f8be663affafcb9c44110db7dd9415b0213941846bc45a2905ae932f147b4b083704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c157125ad67dc217f33281dcaa0bb4573147710ab5d81728ddb3954e883aaddfce1f0fd2f43b880e5be8c7e59b0489dcd336d193dbd6f6e4679d2039da4592f2"} 10:18:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:56 INFO - Copying logs to upload dir... 10:18:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.854655 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-31 10:18:56.457400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 10:18:56.460713) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70bd5f84f6950d8c08e1d1643f5288cb2f90e562b94babd70b7f576332ef5f8703b214289fb0be5aac4e5cc52725596b70ce180dbd9fec825f5571ba68a9eba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd09a0d8bc54f0cecc165e25bc579672f099c368568f3248cd86e61199b1f8be663affafcb9c44110db7dd9415b0213941846bc45a2905ae932f147b4b083704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c157125ad67dc217f33281dcaa0bb4573147710ab5d81728ddb3954e883aaddfce1f0fd2f43b880e5be8c7e59b0489dcd336d193dbd6f6e4679d2039da4592f2"} build_url:https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/ThH9h94UT0uiMg8j_fJGfw/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/Firefox-Non-PGO/sha512/70bd5f84f6950d8c08e1d1643f5288cb2f90e562b94babd70b7f576332ef5f8703b214289fb0be5aac4e5cc52725596b70ce180dbd9fec825f5571ba68a9eba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd09a0d8bc54f0cecc165e25bc579672f099c368568f3248cd86e61199b1f8be663affafcb9c44110db7dd9415b0213941846bc45a2905ae932f147b4b083704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c157125ad67dc217f33281dcaa0bb4573147710ab5d81728ddb3954e883aaddfce1f0fd2f43b880e5be8c7e59b0489dcd336d193dbd6f6e4679d2039da4592f2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 10:18:56.485845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:18:56.486130) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1469983675.998374-15818583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:18:56.571758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 10:18:56.572034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 10:18:56.572288) ========= ========= Total master_lag: 0.16 =========