builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1462885835.32 results: success (0) buildid: 20160510033408 builduid: 37ba95556cc94133bfc14909e6f549a4 revision: f07d961162adaf999dcaffc8c06bebfe8c5b8067 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:35.320821) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:35.321374) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:35.321739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:35.339775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:35.340082) ========= 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=00204705a9daa57ed339a427000001b9-1462885635.904423-690559836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 06:10:35-- 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% 219M=0s 2016-05-10 06:10:35 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090568 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:35.447613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:35.448175) ========= 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=00204705a9daa57ed339a427000001b9-1462885635.904423-690559836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020919 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:35.501909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:35.502367) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f07d961162adaf999dcaffc8c06bebfe8c5b8067 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f07d961162adaf999dcaffc8c06bebfe8c5b8067 --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=00204705a9daa57ed339a427000001b9-1462885635.904423-690559836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 06:10:35,581 truncating revision to first 12 chars 2016-05-10 06:10:35,581 Setting DEBUG logging. 2016-05-10 06:10:35,581 attempt 1/10 2016-05-10 06:10:35,581 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f07d961162ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 06:10:35,987 unpacking tar archive at: mozilla-beta-f07d961162ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702780 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:36.217996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:36.218305) ========= script_repo_revision: f07d961162adaf999dcaffc8c06bebfe8c5b8067 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:36.218824) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:36.219137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 06:10:36.226996) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-10 06:10:36.227325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=00204705a9daa57ed339a427000001b9-1462885635.904423-690559836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:10:36 INFO - MultiFileLogger online at 20160510 06:10:36 in /builds/slave/test 06:10:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:10:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:10:36 INFO - {'append_to_log': False, 06:10:36 INFO - 'base_work_dir': '/builds/slave/test', 06:10:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:10:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:10:36 INFO - 'branch': 'Mozilla-Beta', 06:10:36 INFO - 'buildbot_json_path': 'buildprops.json', 06:10:36 INFO - 'config_files': ('talos/linux_config.py',), 06:10:36 INFO - 'default_actions': ('clobber', 06:10:36 INFO - 'read-buildbot-config', 06:10:36 INFO - 'download-and-extract', 06:10:36 INFO - 'populate-webroot', 06:10:36 INFO - 'create-virtualenv', 06:10:36 INFO - 'install', 06:10:36 INFO - 'run-tests'), 06:10:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:10:36 INFO - 'download_minidump_stackwalk': True, 06:10:36 INFO - 'download_symbols': 'ondemand', 06:10:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:10:36 INFO - 'tooltool.py': '/tools/tooltool.py', 06:10:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:10:36 INFO - '/tools/misc-python/virtualenv.py')}, 06:10:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:10:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:10:36 INFO - 'installer_path': 'installer.exe', 06:10:36 INFO - 'log_level': 'info', 06:10:36 INFO - 'log_name': 'talos', 06:10:36 INFO - 'log_to_console': True, 06:10:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:10:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:10:36 INFO - 'opt_config_files': (), 06:10:36 INFO - 'pip_index': False, 06:10:36 INFO - 'sps_profile': False, 06:10:36 INFO - 'sps_profile_interval': 0, 06:10:36 INFO - 'suite': 'dromaeojs', 06:10:36 INFO - 'system_bits': '32', 06:10:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:10:36 INFO - 'title': 'talos-linux64-ix-016', 06:10:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:10:36 INFO - 'use_talos_json': True, 06:10:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:10:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:10:36 INFO - 'work_dir': 'build'} 06:10:36 INFO - ##### 06:10:36 INFO - ##### Running clobber step. 06:10:36 INFO - ##### 06:10:36 INFO - Running pre-action listener: _resource_record_pre_action 06:10:36 INFO - Running main action method: clobber 06:10:36 INFO - rmtree: /builds/slave/test/build 06:10:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:10:36 INFO - Running post-action listener: _resource_record_post_action 06:10:36 INFO - ##### 06:10:36 INFO - ##### Running read-buildbot-config step. 06:10:36 INFO - ##### 06:10:36 INFO - Running pre-action listener: _resource_record_pre_action 06:10:36 INFO - Running main action method: read_buildbot_config 06:10:36 INFO - Using buildbot properties: 06:10:36 INFO - { 06:10:36 INFO - "project": "", 06:10:36 INFO - "product": "firefox", 06:10:36 INFO - "script_repo_revision": "production", 06:10:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:10:36 INFO - "repository": "", 06:10:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:10:36 INFO - "buildid": "20160510033408", 06:10:36 INFO - "pgo_build": "True", 06:10:36 INFO - "basedir": "/builds/slave/test", 06:10:36 INFO - "buildnumber": 83, 06:10:36 INFO - "slavename": "talos-linux64-ix-016", 06:10:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:10:36 INFO - "platform": "ubuntu64_hw", 06:10:36 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:10:36 INFO - "branch": "mozilla-beta", 06:10:36 INFO - "repo_path": "releases/mozilla-beta", 06:10:36 INFO - "revision": "f07d961162adaf999dcaffc8c06bebfe8c5b8067", 06:10:36 INFO - "stage_platform": "linux64-pgo", 06:10:36 INFO - "builduid": "37ba95556cc94133bfc14909e6f549a4", 06:10:36 INFO - "slavebuilddir": "test" 06:10:36 INFO - } 06:10:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 06:10:36 INFO - Running post-action listener: _resource_record_post_action 06:10:36 INFO - ##### 06:10:36 INFO - ##### Running download-and-extract step. 06:10:36 INFO - ##### 06:10:36 INFO - Running pre-action listener: _resource_record_pre_action 06:10:36 INFO - Running main action method: download_and_extract 06:10:36 INFO - mkdir: /builds/slave/test/build/tests 06:10: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')]} 06:10:36 INFO - https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:10:38 INFO - Downloaded 1412 bytes. 06:10:38 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:10:38 INFO - Using the following test package requirements: 06:10:38 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:10:38 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:10:38 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:10:38 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:10:38 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 06:10:38 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:10:38 INFO - u'jsshell-linux-x86_64.zip'], 06:10:38 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:10:38 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:10:38 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:10:38 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:10:38 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 06:10:38 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:10:38 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 06:10:38 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:10:38 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:10:38 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:10:38 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:10:38 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:10:38 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:38 INFO - https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:10:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:10:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:10:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:10:39 INFO - Downloaded 23364798 bytes. 06:10:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:10:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:10:40 INFO - Return code: 0 06:10:40 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:10: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')]} 06:10:40 INFO - https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:10:45 INFO - Downloaded 23364798 bytes. 06:10:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:10:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:10:46 INFO - Return code: 0 06:10: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')]} 06:10:46 INFO - https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:10:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:10:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:10:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:10:48 INFO - Downloaded 10845194 bytes. 06:10:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:10:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:10:48 INFO - Return code: 0 06:10:48 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')]} 06:10:48 INFO - https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:10:52 INFO - Downloaded 53792356 bytes. 06:10:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:10:52 INFO - mkdir: /builds/slave/test/properties 06:10:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:10:52 INFO - Writing to file /builds/slave/test/properties/build_url 06:10:52 INFO - Contents: 06:10:52 INFO - build_url:https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:10:52 INFO - Running post-action listener: _resource_record_post_action 06:10:52 INFO - Running post-action listener: set_extra_try_arguments 06:10:52 INFO - ##### 06:10:52 INFO - ##### Running populate-webroot step. 06:10:52 INFO - ##### 06:10:52 INFO - Running pre-action listener: _resource_record_pre_action 06:10:52 INFO - Running main action method: populate_webroot 06:10:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:10:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:10:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:10:52 INFO - '--tppagecycles', 06:10:52 INFO - '7'], 06:10:52 INFO - 'tests': ['tsvgm']}}, 06:10:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:10:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:10:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:10:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:10:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:10:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:10:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:52 INFO - 'talos_options': ['--e10s'], 06:10:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:52 INFO - 'tests': ['damp', 'tps']}, 06:10:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:52 INFO - 'talos_options': ['--e10s'], 06:10:52 INFO - 'tests': ['damp', 'tps']}, 06:10:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:10:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:10:52 INFO - 'other': {'tests': ['a11yr', 06:10:52 INFO - 'ts_paint', 06:10:52 INFO - 'tpaint', 06:10:52 INFO - 'sessionrestore', 06:10:52 INFO - 'sessionrestore_no_auto_restore', 06:10:52 INFO - 'tabpaint']}, 06:10:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:10:52 INFO - 'tests': ['a11yr', 06:10:52 INFO - 'ts_paint', 06:10:52 INFO - 'tpaint', 06:10:52 INFO - 'sessionrestore', 06:10:52 INFO - 'sessionrestore_no_auto_restore', 06:10:52 INFO - 'tabpaint']}, 06:10:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:10:52 INFO - 'tests': ['a11yr', 06:10:52 INFO - 'ts_paint', 06:10:52 INFO - 'tpaint', 06:10:52 INFO - 'sessionrestore', 06:10:52 INFO - 'sessionrestore_no_auto_restore', 06:10:52 INFO - 'tabpaint']}, 06:10:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:10:52 INFO - 'tests': ['a11yr', 06:10:52 INFO - 'ts_paint', 06:10:52 INFO - 'tpaint', 06:10:52 INFO - 'sessionrestore', 06:10:52 INFO - 'sessionrestore_no_auto_restore', 06:10:52 INFO - 'tabpaint']}, 06:10:52 INFO - 'other_l64': {'tests': ['a11yr', 06:10:52 INFO - 'ts_paint', 06:10:52 INFO - 'tpaint', 06:10:52 INFO - 'sessionrestore', 06:10:52 INFO - 'sessionrestore_no_auto_restore', 06:10:52 INFO - 'tabpaint']}, 06:10:52 INFO - 'other_nol64': {'tests': ['a11yr', 06:10:52 INFO - 'ts_paint', 06:10:52 INFO - 'tpaint', 06:10:52 INFO - 'sessionrestore', 06:10:52 INFO - 'sessionrestore_no_auto_restore', 06:10:52 INFO - 'tabpaint']}, 06:10:52 INFO - 'svgr': {'tests': ['tsvgx', 06:10:52 INFO - 'tsvgr_opacity', 06:10:52 INFO - 'tart', 06:10:52 INFO - 'tscrollx', 06:10:52 INFO - 'cart']}, 06:10:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:10:52 INFO - 'tests': ['tsvgx', 06:10:52 INFO - 'tsvgr_opacity', 06:10:52 INFO - 'tart', 06:10:52 INFO - 'tscrollx', 06:10:52 INFO - 'cart']}, 06:10:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:52 INFO - 'tests': ['tp5o']}, 06:10:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:52 INFO - 'talos_options': ['--e10s'], 06:10:52 INFO - 'tests': ['tp5o']}, 06:10:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:52 INFO - 'talos_options': ['--xperf_path', 06:10:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:52 INFO - 'tests': ['tp5n']}, 06:10:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:52 INFO - 'talos_options': ['--e10s', 06:10:52 INFO - '--xperf_path', 06:10:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:52 INFO - 'tests': ['tp5n']}}, 06:10:52 INFO - 'talos.zip': {'path': '', 06:10:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:10:52 INFO - Running post-action listener: _resource_record_post_action 06:10:52 INFO - ##### 06:10:52 INFO - ##### Running create-virtualenv step. 06:10:52 INFO - ##### 06:10:52 INFO - Running pre-action listener: _resource_record_pre_action 06:10:52 INFO - Running main action method: create_virtualenv 06:10:52 INFO - Creating virtualenv /builds/slave/test/build/venv 06:10:52 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 06:10:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:10:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:10:53 INFO - Using real prefix '/usr' 06:10:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:10:53 INFO - Installing distribute.............................................................................................................................................................................................done. 06:10:55 INFO - Installing pip.................done. 06:10:55 INFO - Return code: 0 06:10:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:10:55 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')]} 06:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:55 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')]} 06:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:55 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 0x7ff162979f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, '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': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', '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 06:10:55 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 06:10:55 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 06:10:55 INFO - Using env: {'DISPLAY': ':0', 06:10:55 INFO - 'HOME': '/home/cltbld', 06:10:55 INFO - 'LANG': 'en_US.UTF-8', 06:10:55 INFO - 'LANGUAGE': 'en_US:en', 06:10:55 INFO - 'LOGNAME': 'cltbld', 06:10:55 INFO - 'MAIL': '/var/mail/cltbld', 06:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:55 INFO - 'MOZ_NO_REMOTE': '1', 06:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:55 INFO - 'NO_EM_RESTART': '1', 06:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:55 INFO - 'PWD': '/builds/slave/test', 06:10:55 INFO - 'SHELL': '/bin/bash', 06:10:55 INFO - 'SHLVL': '1', 06:10:55 INFO - 'TERM': 'linux', 06:10:55 INFO - 'TMOUT': '86400', 06:10:55 INFO - 'USER': 'cltbld', 06:10:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:55 INFO - '_': '/tools/buildbot/bin/python'} 06:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:55 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 06:10:55 INFO - Cleaning up... 06:10:55 INFO - Return code: 0 06:10:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:10:55 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')]} 06:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:55 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')]} 06:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:55 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff162979f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, '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': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', '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 06:10:55 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>=0.7.1'] in /builds/slave/test/build 06:10:55 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>=0.7.1 06:10:55 INFO - Using env: {'DISPLAY': ':0', 06:10:55 INFO - 'HOME': '/home/cltbld', 06:10:55 INFO - 'LANG': 'en_US.UTF-8', 06:10:55 INFO - 'LANGUAGE': 'en_US:en', 06:10:55 INFO - 'LOGNAME': 'cltbld', 06:10:55 INFO - 'MAIL': '/var/mail/cltbld', 06:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:55 INFO - 'MOZ_NO_REMOTE': '1', 06:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:55 INFO - 'NO_EM_RESTART': '1', 06:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:55 INFO - 'PWD': '/builds/slave/test', 06:10:55 INFO - 'SHELL': '/bin/bash', 06:10:55 INFO - 'SHLVL': '1', 06:10:55 INFO - 'TERM': 'linux', 06:10:55 INFO - 'TMOUT': '86400', 06:10:55 INFO - 'USER': 'cltbld', 06:10:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:55 INFO - '_': '/tools/buildbot/bin/python'} 06:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:55 INFO - Downloading/unpacking psutil>=0.7.1 06:10:55 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 06:10:55 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 06:10:55 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 06:10:55 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 06:10:55 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 06:10:55 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 06:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:10:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:58 INFO - Installing collected packages: psutil 06:10:58 INFO - Running setup.py install for psutil 06:10:58 INFO - building 'psutil._psutil_linux' extension 06:10:58 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 06:10:58 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 06:10:58 INFO - building 'psutil._psutil_posix' extension 06:10:58 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 06:10:58 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 06:10:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:58 INFO - Successfully installed psutil 06:10:58 INFO - Cleaning up... 06:10:58 INFO - Return code: 0 06:10:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:10:58 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')]} 06:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:58 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')]} 06:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:58 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff162979f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, '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': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', '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 06:10:58 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.0.0'] in /builds/slave/test/build 06:10:58 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.0.0 06:10:58 INFO - Using env: {'DISPLAY': ':0', 06:10:58 INFO - 'HOME': '/home/cltbld', 06:10:58 INFO - 'LANG': 'en_US.UTF-8', 06:10:58 INFO - 'LANGUAGE': 'en_US:en', 06:10:58 INFO - 'LOGNAME': 'cltbld', 06:10:58 INFO - 'MAIL': '/var/mail/cltbld', 06:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:58 INFO - 'MOZ_NO_REMOTE': '1', 06:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:58 INFO - 'NO_EM_RESTART': '1', 06:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:58 INFO - 'PWD': '/builds/slave/test', 06:10:58 INFO - 'SHELL': '/bin/bash', 06:10:58 INFO - 'SHLVL': '1', 06:10:58 INFO - 'TERM': 'linux', 06:10:58 INFO - 'TMOUT': '86400', 06:10:58 INFO - 'USER': 'cltbld', 06:10:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:58 INFO - '_': '/tools/buildbot/bin/python'} 06:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:10:58 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 06:10:58 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 06:10:58 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 06:10:58 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 06:10:58 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 06:10:58 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 06:11:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:11:00 INFO - Installing collected packages: mozsystemmonitor 06:11:00 INFO - Running setup.py install for mozsystemmonitor 06:11:00 INFO - Successfully installed mozsystemmonitor 06:11:00 INFO - Cleaning up... 06:11:00 INFO - Return code: 0 06:11:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:00 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 0x7ff162979f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, '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': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', '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 06:11:00 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 06:11:00 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 06:11:00 INFO - Using env: {'DISPLAY': ':0', 06:11:00 INFO - 'HOME': '/home/cltbld', 06:11:00 INFO - 'LANG': 'en_US.UTF-8', 06:11:00 INFO - 'LANGUAGE': 'en_US:en', 06:11:00 INFO - 'LOGNAME': 'cltbld', 06:11:00 INFO - 'MAIL': '/var/mail/cltbld', 06:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:00 INFO - 'MOZ_NO_REMOTE': '1', 06:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:00 INFO - 'NO_EM_RESTART': '1', 06:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:00 INFO - 'PWD': '/builds/slave/test', 06:11:00 INFO - 'SHELL': '/bin/bash', 06:11:00 INFO - 'SHLVL': '1', 06:11:00 INFO - 'TERM': 'linux', 06:11:00 INFO - 'TMOUT': '86400', 06:11:00 INFO - 'USER': 'cltbld', 06:11:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:00 INFO - '_': '/tools/buildbot/bin/python'} 06:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:01 INFO - Downloading/unpacking blobuploader==1.2.4 06:11:01 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 06:11:01 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 06:11:01 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 06:11:01 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 06:11:01 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 06:11:01 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 06:11:02 INFO - Downloading blobuploader-1.2.4.tar.gz 06:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:11:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:11:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 INFO - Downloading docopt-0.6.1.tar.gz 06:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:11:03 INFO - Installing collected packages: blobuploader, requests, docopt 06:11:03 INFO - Running setup.py install for blobuploader 06:11:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:11:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:11:03 INFO - Running setup.py install for requests 06:11:04 INFO - Running setup.py install for docopt 06:11:04 INFO - Successfully installed blobuploader requests docopt 06:11:04 INFO - Cleaning up... 06:11:04 INFO - Return code: 0 06:11:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:04 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')]} 06:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:04 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')]} 06:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:04 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 0x7ff162979f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, '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': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', '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 06:11:04 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 06:11:04 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 06:11:04 INFO - Using env: {'DISPLAY': ':0', 06:11:04 INFO - 'HOME': '/home/cltbld', 06:11:04 INFO - 'LANG': 'en_US.UTF-8', 06:11:04 INFO - 'LANGUAGE': 'en_US:en', 06:11:04 INFO - 'LOGNAME': 'cltbld', 06:11:04 INFO - 'MAIL': '/var/mail/cltbld', 06:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:04 INFO - 'MOZ_NO_REMOTE': '1', 06:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:04 INFO - 'NO_EM_RESTART': '1', 06:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:04 INFO - 'PWD': '/builds/slave/test', 06:11:04 INFO - 'SHELL': '/bin/bash', 06:11:04 INFO - 'SHLVL': '1', 06:11:04 INFO - 'TERM': 'linux', 06:11:04 INFO - 'TMOUT': '86400', 06:11:04 INFO - 'USER': 'cltbld', 06:11:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:04 INFO - '_': '/tools/buildbot/bin/python'} 06:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:04 INFO - Running setup.py (path:/tmp/pip-V4t0ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:04 INFO - Running setup.py (path:/tmp/pip-TF_wTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:04 INFO - Running setup.py (path:/tmp/pip-t9V35p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:04 INFO - Running setup.py (path:/tmp/pip-_KvtBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:04 INFO - Running setup.py (path:/tmp/pip-sUoHpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:04 INFO - Running setup.py (path:/tmp/pip-QiAVlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:11:04 INFO - Running setup.py (path:/tmp/pip-olNabC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:11:05 INFO - Running setup.py (path:/tmp/pip-08qQHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:11:05 INFO - Running setup.py (path:/tmp/pip-L3J1B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:11:05 INFO - Running setup.py (path:/tmp/pip-SphS8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:11:05 INFO - Running setup.py (path:/tmp/pip-J5thUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:11:05 INFO - Running setup.py (path:/tmp/pip-oxCRBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:11:05 INFO - Running setup.py (path:/tmp/pip-YnPIuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:11:05 INFO - Running setup.py (path:/tmp/pip-AJHbE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:05 INFO - Running setup.py (path:/tmp/pip-XsJ4JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:11:05 INFO - Running setup.py (path:/tmp/pip-DxsMnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:11:05 INFO - Running setup.py (path:/tmp/pip-WvfwV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:11:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:11:05 INFO - Running setup.py install for manifestparser 06:11:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:11:05 INFO - Running setup.py install for mozcrash 06:11:05 INFO - Running setup.py install for mozdebug 06:11:06 INFO - Running setup.py install for mozdevice 06:11:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Running setup.py install for mozfile 06:11:06 INFO - Running setup.py install for mozhttpd 06:11:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Running setup.py install for mozinfo 06:11:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Running setup.py install for mozInstall 06:11:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Running setup.py install for mozleak 06:11:06 INFO - Running setup.py install for mozlog 06:11:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Running setup.py install for moznetwork 06:11:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:11:06 INFO - Running setup.py install for mozprocess 06:11:06 INFO - Running setup.py install for mozprofile 06:11:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:11:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:11:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:11:07 INFO - Running setup.py install for mozrunner 06:11:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:11:07 INFO - Running setup.py install for mozscreenshot 06:11:07 INFO - Running setup.py install for moztest 06:11:07 INFO - Running setup.py install for mozversion 06:11:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:11:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:11:07 INFO - Cleaning up... 06:11:07 INFO - Return code: 0 06:11:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11: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')]} 06:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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')]} 06:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:07 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 0x7ff162979f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, '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': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', '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 06:11:07 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 06:11:07 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 06:11:07 INFO - Using env: {'DISPLAY': ':0', 06:11:07 INFO - 'HOME': '/home/cltbld', 06:11:07 INFO - 'LANG': 'en_US.UTF-8', 06:11:07 INFO - 'LANGUAGE': 'en_US:en', 06:11:07 INFO - 'LOGNAME': 'cltbld', 06:11:07 INFO - 'MAIL': '/var/mail/cltbld', 06:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:07 INFO - 'MOZ_NO_REMOTE': '1', 06:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:07 INFO - 'NO_EM_RESTART': '1', 06:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:07 INFO - 'PWD': '/builds/slave/test', 06:11:07 INFO - 'SHELL': '/bin/bash', 06:11:07 INFO - 'SHLVL': '1', 06:11:07 INFO - 'TERM': 'linux', 06:11:07 INFO - 'TMOUT': '86400', 06:11:07 INFO - 'USER': 'cltbld', 06:11:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:07 INFO - '_': '/tools/buildbot/bin/python'} 06:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:07 INFO - Running setup.py (path:/tmp/pip-WD6m6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:07 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)) 06:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:07 INFO - Running setup.py (path:/tmp/pip-zf4OEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:07 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)) 06:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:07 INFO - Running setup.py (path:/tmp/pip-w_O4t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:07 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)) 06:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:07 INFO - Running setup.py (path:/tmp/pip-2BzKSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:08 INFO - Running setup.py (path:/tmp/pip-ryJMtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:08 INFO - Running setup.py (path:/tmp/pip-4vGnbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:11:08 INFO - Running setup.py (path:/tmp/pip-tpKUHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:11:08 INFO - Running setup.py (path:/tmp/pip-jB9CVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:11:08 INFO - Running setup.py (path:/tmp/pip-rr_3PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:11:08 INFO - Running setup.py (path:/tmp/pip-MO6QO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:11:08 INFO - Running setup.py (path:/tmp/pip-_Yd6MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:11:08 INFO - Running setup.py (path:/tmp/pip-E2nQLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:11:08 INFO - Running setup.py (path:/tmp/pip-FMlx8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:11:08 INFO - Running setup.py (path:/tmp/pip-_7SNY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:08 INFO - Running setup.py (path:/tmp/pip-M5NcMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:11:08 INFO - Running setup.py (path:/tmp/pip-DuaGuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:11:08 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)) 06:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:11:08 INFO - Running setup.py (path:/tmp/pip-DOHkn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:11:08 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)) 06:11:08 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)) 06:11:08 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)) 06:11:08 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)) 06:11:08 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)) 06:11:08 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)) 06:11:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:11:09 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 06:11:09 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 06:11:09 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 06:11:09 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 06:11:09 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 06:11:09 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 06:11:10 INFO - Downloading blessings-1.6.tar.gz 06:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:11:10 INFO - Installing collected packages: blessings 06:11:10 INFO - Running setup.py install for blessings 06:11:11 INFO - Successfully installed blessings 06:11:11 INFO - Cleaning up... 06:11:11 INFO - Return code: 0 06:11:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:11:11 INFO - Reading from file tmpfile_stdout 06:11:11 INFO - Current package versions: 06:11:11 INFO - argparse == 1.2.1 06:11:11 INFO - blessings == 1.6 06:11:11 INFO - blobuploader == 1.2.4 06:11:11 INFO - docopt == 0.6.1 06:11:11 INFO - manifestparser == 1.1 06:11:11 INFO - mozInstall == 1.12 06:11:11 INFO - mozcrash == 0.17 06:11:11 INFO - mozdebug == 0.1 06:11:11 INFO - mozdevice == 0.48 06:11:11 INFO - mozfile == 1.2 06:11:11 INFO - mozhttpd == 0.7 06:11:11 INFO - mozinfo == 0.9 06:11:11 INFO - mozleak == 0.1 06:11:11 INFO - mozlog == 3.1 06:11:11 INFO - moznetwork == 0.27 06:11:11 INFO - mozprocess == 0.22 06:11:11 INFO - mozprofile == 0.28 06:11:11 INFO - mozrunner == 6.11 06:11:11 INFO - mozscreenshot == 0.1 06:11:11 INFO - mozsystemmonitor == 0.0 06:11:11 INFO - moztest == 0.7 06:11:11 INFO - mozversion == 1.4 06:11:11 INFO - psutil == 3.1.1 06:11:11 INFO - requests == 1.2.3 06:11:11 INFO - wsgiref == 0.1.2 06:11:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:11 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 0x7ff162979f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, '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': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', '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 06:11:11 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 06:11:11 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 06:11:11 INFO - Using env: {'DISPLAY': ':0', 06:11:11 INFO - 'HOME': '/home/cltbld', 06:11:11 INFO - 'LANG': 'en_US.UTF-8', 06:11:11 INFO - 'LANGUAGE': 'en_US:en', 06:11:11 INFO - 'LOGNAME': 'cltbld', 06:11:11 INFO - 'MAIL': '/var/mail/cltbld', 06:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:11 INFO - 'MOZ_NO_REMOTE': '1', 06:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:11 INFO - 'NO_EM_RESTART': '1', 06:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:11 INFO - 'PWD': '/builds/slave/test', 06:11:11 INFO - 'SHELL': '/bin/bash', 06:11:11 INFO - 'SHLVL': '1', 06:11:11 INFO - 'TERM': 'linux', 06:11:11 INFO - 'TMOUT': '86400', 06:11:11 INFO - 'USER': 'cltbld', 06:11:11 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:11 INFO - '_': '/tools/buildbot/bin/python'} 06:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:11 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)) 06:11:11 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)) 06:11:11 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)) 06:11:11 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)) 06:11:11 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)) 06:11:11 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)) 06:11:11 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)) 06:11:11 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)) 06:11:11 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)) 06:11:11 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)) 06:11:11 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)) 06:11:11 INFO - Cleaning up... 06:11:11 INFO - Return code: 0 06:11:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:11 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 0x7ff162979f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, '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': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', '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 06:11:11 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 06:11:11 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 06:11:11 INFO - Using env: {'DISPLAY': ':0', 06:11:11 INFO - 'HOME': '/home/cltbld', 06:11:11 INFO - 'LANG': 'en_US.UTF-8', 06:11:11 INFO - 'LANGUAGE': 'en_US:en', 06:11:11 INFO - 'LOGNAME': 'cltbld', 06:11:11 INFO - 'MAIL': '/var/mail/cltbld', 06:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:11 INFO - 'MOZ_NO_REMOTE': '1', 06:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:11 INFO - 'NO_EM_RESTART': '1', 06:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:11 INFO - 'PWD': '/builds/slave/test', 06:11:11 INFO - 'SHELL': '/bin/bash', 06:11:11 INFO - 'SHLVL': '1', 06:11:11 INFO - 'TERM': 'linux', 06:11:11 INFO - 'TMOUT': '86400', 06:11:11 INFO - 'USER': 'cltbld', 06:11:11 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:11 INFO - '_': '/tools/buildbot/bin/python'} 06:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:11 INFO - Downloading/unpacking jsonschema 06:11:11 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 06:11:11 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 06:11:11 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 06:11:11 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 06:11:11 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 06:11:11 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 06:11:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:11:13 INFO - Downloading/unpacking functools32 (from jsonschema) 06:11:13 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 06:11:13 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 06:11:13 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 06:11:13 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 06:11:13 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 06:11:13 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 06:11:14 INFO - Downloading functools32-3.2.3-2.tar.gz 06:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:11:14 INFO - warning: no files found matching '*.txt' 06:11:14 INFO - no previously-included directories found matching 'build' 06:11:14 INFO - no previously-included directories found matching 'dist' 06:11:14 INFO - no previously-included directories found matching '.git*' 06:11:14 INFO - Installing collected packages: jsonschema, functools32 06:11:14 INFO - Running setup.py install for functools32 06:11:14 INFO - warning: no files found matching '*.txt' 06:11:14 INFO - no previously-included directories found matching 'build' 06:11:14 INFO - no previously-included directories found matching 'dist' 06:11:14 INFO - no previously-included directories found matching '.git*' 06:11:14 INFO - Successfully installed jsonschema functools32 06:11:14 INFO - Cleaning up... 06:11:14 INFO - Return code: 0 06:11:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:14 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff162979f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, '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': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', '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 06:11:14 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', 'flake8'] in /builds/slave/test/build 06:11:14 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 flake8 06:11:14 INFO - Using env: {'DISPLAY': ':0', 06:11:14 INFO - 'HOME': '/home/cltbld', 06:11:14 INFO - 'LANG': 'en_US.UTF-8', 06:11:14 INFO - 'LANGUAGE': 'en_US:en', 06:11:14 INFO - 'LOGNAME': 'cltbld', 06:11:14 INFO - 'MAIL': '/var/mail/cltbld', 06:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:14 INFO - 'MOZ_NO_REMOTE': '1', 06:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:14 INFO - 'NO_EM_RESTART': '1', 06:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:14 INFO - 'PWD': '/builds/slave/test', 06:11:14 INFO - 'SHELL': '/bin/bash', 06:11:14 INFO - 'SHLVL': '1', 06:11:14 INFO - 'TERM': 'linux', 06:11:14 INFO - 'TMOUT': '86400', 06:11:14 INFO - 'USER': 'cltbld', 06:11:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:14 INFO - '_': '/tools/buildbot/bin/python'} 06:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:14 INFO - Downloading/unpacking flake8 06:11:14 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 06:11:14 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 06:11:14 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 06:11:14 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 06:11:14 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 06:11:14 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 06:11:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:11:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:11:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 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 06:11:16 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 06:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:11:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:11:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:11:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:11:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:11:17 INFO - no previously-included directories found matching 'docs/_build' 06:11:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:11:17 INFO - Running setup.py install for pep8 06:11:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:11:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:11:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:11:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:11:17 INFO - no previously-included directories found matching 'docs/_build' 06:11:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:11:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:11:17 INFO - Cleaning up... 06:11:17 INFO - Return code: 0 06:11:17 INFO - Running post-action listener: _resource_record_post_action 06:11:17 INFO - Running post-action listener: _start_resource_monitoring 06:11:17 INFO - Starting resource monitoring. 06:11:17 INFO - ##### 06:11:17 INFO - ##### Running install step. 06:11:17 INFO - ##### 06:11:17 INFO - Running pre-action listener: _resource_record_pre_action 06:11:17 INFO - Running main action method: install 06:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:11:17 INFO - Reading from file tmpfile_stdout 06:11:17 INFO - Detecting whether we're running mozinstall >=1.0... 06:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:11:17 INFO - Reading from file tmpfile_stdout 06:11:17 INFO - Output received: 06:11:17 INFO - Usage: mozinstall [options] installer 06:11:17 INFO - Options: 06:11:17 INFO - -h, --help show this help message and exit 06:11:17 INFO - -d DEST, --destination=DEST 06:11:17 INFO - Directory to install application into. [default: 06:11:17 INFO - "/builds/slave/test"] 06:11:17 INFO - --app=APP Application being installed. [default: firefox] 06:11:17 INFO - mkdir: /builds/slave/test/build/application 06:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:11:30 INFO - Reading from file tmpfile_stdout 06:11:30 INFO - Output received: 06:11:30 INFO - /builds/slave/test/build/application/firefox/firefox 06:11:30 INFO - Running post-action listener: _resource_record_post_action 06:11:30 INFO - ##### 06:11:30 INFO - ##### Running run-tests step. 06:11:30 INFO - ##### 06:11:30 INFO - Running pre-action listener: _resource_record_pre_action 06:11:30 INFO - Running main action method: run_tests 06:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:11:30 INFO - Python 2.7.3 06:11:30 INFO - Return code: 0 06:11:30 INFO - grabbing minidump binary from tooltool 06:11: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')]} 06:11:30 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee160>, '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 0x28ef060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ef4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:11:30 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 06:11:30 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 06:11:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:11:30 INFO - Return code: 0 06:11:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:11:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:11:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:11:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:11:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:11:31 INFO - Return code: 0 06:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 06:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 06:11:31 INFO - Using env: {'DISPLAY': ':0', 06:11:31 INFO - 'HOME': '/home/cltbld', 06:11:31 INFO - 'LANG': 'en_US.UTF-8', 06:11:31 INFO - 'LANGUAGE': 'en_US:en', 06:11:31 INFO - 'LOGNAME': 'cltbld', 06:11:31 INFO - 'MAIL': '/var/mail/cltbld', 06:11:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:11:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:31 INFO - 'MOZ_NO_REMOTE': '1', 06:11:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:31 INFO - 'NO_EM_RESTART': '1', 06:11:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:31 INFO - 'PWD': '/builds/slave/test', 06:11:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:11:31 INFO - 'SHELL': '/bin/bash', 06:11:31 INFO - 'SHLVL': '1', 06:11:31 INFO - 'TERM': 'linux', 06:11:31 INFO - 'TMOUT': '86400', 06:11:31 INFO - 'USER': 'cltbld', 06:11:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462885635.904423-690559836', 06:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:31 INFO - '_': '/tools/buildbot/bin/python'} 06:11:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 06:11:31 INFO - mozversion application_buildid: 20160510033408 06:11:31 INFO - mozversion application_changeset: f07d961162adaf999dcaffc8c06bebfe8c5b8067 06:11:31 INFO - mozversion application_display_name: Firefox 06:11:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:11:31 INFO - mozversion application_name: Firefox 06:11:31 INFO - mozversion application_remotingname: firefox 06:11:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:11:31 INFO - mozversion application_vendor: Mozilla 06:11:31 INFO - mozversion application_version: 47.0 06:11:31 INFO - mozversion platform_buildid: 20160510033408 06:11:31 INFO - mozversion platform_changeset: f07d961162adaf999dcaffc8c06bebfe8c5b8067 06:11:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:11:31 INFO - mozversion platform_version: 47.0 06:11:31 INFO - using testdate: 1462885891 06:11:31 INFO - actual date: 1462885891 06:11:31 INFO - starting webserver on 'localhost:58145' 06:11:31 INFO - SUITE-START | Running 2 tests 06:11:31 INFO - TEST-START | dromaeo_css 06:11:31 INFO - operating with platform_type : linux_ 06:11:31 INFO - Initialising browser for dromaeo_css test... 06:11:31 INFO - TEST-INFO | started process 10237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0RSOHD/profile http://localhost:58145/getInfo.html) 06:11:35 INFO - PROCESS | 10237 | __metrics Screen width/height:1600/1200 06:11:35 INFO - PROCESS | 10237 | colorDepth:24 06:11:35 INFO - PROCESS | 10237 | Browser inner width/height: 1024/697 06:11:35 INFO - PROCESS | 10237 | __metrics 06:11:37 INFO - PROCESS | 10237 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:37 INFO - TEST-INFO | 10237: exit 0 06:11:37 INFO - Browser initialized. 06:11:37 INFO - Running cycle 1/1 for dromaeo_css test... 06:11:37 INFO - TEST-INFO | started process 10331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0RSOHD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:49 INFO - PROCESS | 10331 | RSS: Main: 139763712 06:11:49 INFO - PROCESS | 10331 | 06:12:40 INFO - PROCESS | 10331 | 1462885960391 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] 06:14:48 INFO - PROCESS | 10331 | Cycle 1(1): loaded http://localhost:58145/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58145/tests/dromaeo/cssquery-ext.html) 06:14:49 INFO - PROCESS | 10331 | RSS: Main: 247312384 06:14:49 INFO - PROCESS | 10331 | 06:17:51 INFO - PROCESS | 10331 | Cycle 1(1): loaded http://localhost:58145/tests/dromaeo/cssquery-ext.html (next: http://localhost:58145/tests/dromaeo/cssquery-jquery.html) 06:17:51 INFO - PROCESS | 10331 | RSS: Main: 221036544 06:17:51 INFO - PROCESS | 10331 | 06:20:53 INFO - PROCESS | 10331 | Cycle 1(1): loaded http://localhost:58145/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58145/tests/dromaeo/cssquery-mootools.html) 06:20:54 INFO - PROCESS | 10331 | RSS: Main: 211742720 06:20:54 INFO - PROCESS | 10331 | 06:23:55 INFO - PROCESS | 10331 | Cycle 1(1): loaded http://localhost:58145/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58145/tests/dromaeo/cssquery-prototype.html) 06:23:56 INFO - PROCESS | 10331 | RSS: Main: 204484608 06:23:56 INFO - PROCESS | 10331 | 06:26:58 INFO - PROCESS | 10331 | Cycle 1(1): loaded http://localhost:58145/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58145/tests/dromaeo/cssquery-yui.html) 06:26:59 INFO - PROCESS | 10331 | RSS: Main: 207757312 06:26:59 INFO - PROCESS | 10331 | 06:30:01 INFO - PROCESS | 10331 | Cycle 1(1): loaded http://localhost:58145/tests/dromaeo/cssquery-yui.html (next: http://localhost:58145/tests/dromaeo/cssquery-dojo.html) 06:30:01 INFO - PROCESS | 10331 | RSS: Main: 252915712 06:30:01 INFO - PROCESS | 10331 | 06:30:01 INFO - PROCESS | 10331 | __start_tp_report 06:30:01 INFO - PROCESS | 10331 | _x_x_mozilla_page_load 06:30:01 INFO - PROCESS | 10331 | _x_x_mozilla_page_load_details 06:30:01 INFO - PROCESS | 10331 | |i|pagename|runs| 06:30:01 INFO - PROCESS | 10331 | |0;dojo.html;3245.7078862902335;3320.9833950830243;3335.5330253764478;3343.9164020899475;3374.0383990562696;5320.973395133024;5334.359876814783;5353.197020446935;5362.142057270833;5388.084025715628;5312.256284120226;5355.6786592804365;5362.973185134078;5365.517103460687;5371.113766228567;4739.834105806298;4862.854114376574;4881.4874438184015;4897.02059588082;4947.554720075193;4851.830185943492;4899.363082799231;4926.261060840885;4930.654854160211;4962.702237865721;4880.487548807378;4913.9262911056185;4941.975290123562;4942.752862356868;4944.554990050895;4890.070886531547;4933.901321973541;4943.777530011158;4946.802127914897;4956.256561515784;4796.136695394827;4818.879528011793;4888.584470320027;4895;4921.114199444099;5110.540051395392;5111.361079865017;5112.386513618352;5113.207452844815;5120.692758434506;5658.292713410824;5661.264035675335;5664.915026274609;5673.120666296731;5698.601097923147;5621.437856214387;5800.593958422912;5829.417058294179;5854.356020837705;5901.114832775075;5411.594130440233;5434;5460.071787796044;5462.0987537056335;5464.371597266365;5778.27771528559;5948.881022379528;5975.19334889793;5980.671063091571;5983.222181116427;5624.859378515488;5695.715214239354;5707.429257074343;5725.398833122462;5731.684757338387;5728.1407788831175;5739.540836733051;5754.942450575524;5755.165501002331;5762.1068734346245;5608;5727.942720572824;5728.054870946247;5736.483716465455;5737.827865164052;5729.684867332337;5732.541396688255;5735.340435849931;5760.423957604206;5769.509591684754;4347.9565204347555;4378.036831896978;4378.124375124988;4378.277584198571;4407.58127977848;3882.242962622318;3931.5871833457645;3975.0857302820514;3993.7803420812133;3998.4801975742967;5475.534579560782;5489.149181876815;5505.284313039359;5508;5517.227588137664;5800.39095894925;5803.970980145073;5811.912821307684;5819.127130930395;5822;5303.68177909319;5401.972990135024;5470.206820011076;5487.1494918286935;5491.341039075257;4879.243717223836;4920.950790492049;4925.38432695913;4925.581325587294;4943.505649435099;5944.821655350346;5988.790392336335;5999.760009599567;6006.309274433496;6009.369016253318;5671.291088613923;5747.942520574741;5803.593748437569;5805.129230615442;5819.592628515963;5904.143899134516;5912.881742365043;5916.526677865846;5924.200232968667;5926.4666180044005;5610.971945140248;5669.234653321749;5679.801206957736;5681.659100453986;5688.971555142198;5800.854978625399;5867.031939729897;5885.087811389241;5889.852753681021;5901.5868889177345;5627.071533196977;5633.436656334334;5639.351474580476;5652.830415087554;5655.830325090254;5493.835184944458;5572.192032155396;5640.830775076754;5643.88712225745;5646.9152962704775;5544.805931792368;5577.721113944205;5578.219049333015;5583.2462617547735;5615.0173719599725;5641.407652196624;5664.716764161693;5665.461781130786;5672.631278966854;5680.9147862781265;5510.090835012178;5577.995960726946;5604.579656525859;5616.634918730269;5683.3748287687495 06:30:01 INFO - PROCESS | 10331 | |1;ext.html;512.6513970500063;520.8697825543614;539.9066889548664;548.5967813656964;556.2907293201168;30580.082597522083;40263.194736105295;40652.39021414678;40799.184016319654;40845;42804.35793463101;42984.14031719364;42998.140037199315;43533.56466435335;43559.564404355944;8859.999999999984;8990.415622984485;9069.455832650028;9071.773205669879;9075.27397808177;8792.120787921222;8930.776730581754;8967.327450441211;8967.372283940127;9141.817163656722;9166.487529557615;9274.02622724611;9291.303152263607;9312.487813170274;9315.627374905029;9129.406588571755;9202.401843880127;9204.953975230148;9210.49342286174;9219.492927888963;9100.908990910073;9287.210587100037;9305.255579553686;9308.208802251816;9310.627574896997;43129.56870431287;43618.34572481384;43669;43685;43699.34450983238;3697.593264740903;3835.9424608630893;3902.102516421239;4175.997760537449;4377.299632058887;32836.83581582101;32888.6711132888;33068.51191696379;33259.501107483404;34157;4251.149770046003;4285.507166675841;4293.506246781629;4296.3770253313405;4355.477342718862;296541;303942;304917.9999999978;305101;305639;46043.539564603925;66598.66700666466;67286.32713672899;67350;67472;44996.775016125364;45045.774771125936;45089.77455112703;45243.773781131546;45264.77367613207;15156.848431515544;15385.230738463031;15403.691926161415;15411;15453.690926181413;12215.206011609216;12224.26654400721;12249.510019599116;12251.081168912368;12256.571020014257;15216.695666086616;15354.078755274719;15746.527604171893;15792.605184870241;15816.446424375092;5664.54683625309;5793.8551536211935;5915.349311575723;5962.433568811043;5983.850403739854;932.4265576670434;959.3236768078488;1092.5902786455079;1190.3869507203797;1192.785298646252;29699.40601187964;30270.243243918638;30439;30605;30728.38543229123;1106.7675788084593;1111.766529028897;1117.022605220432;1137.6018393562354;1154.988450115505;15743.527694169194;15931.601709957113;15973.299908479485;16032.038077715375;16109.516714498584;310831;314580;314786;315338;315790;56722.71638641781;57920.13119803206;57963.71018144882;58015.70992145012;58021.41978580245;1310.1614966421498;1368.7194125204508;1463.1075044223016;1466.3914475492552;1467.1563850785628;27347.72652273452;28563.714362856106;29626;29771.22501286561;30226;46062.30906536338;46608.067838643714;46632;46639.76680116577;46641.53358466508;192561;193918;194080;204462;210685;29976.850115749283;34511.82744086264;34619;35042.24788760603;35342.23288835496;41109.383359250234;41151.794241028605;41345.79327103345;41538.792306038275;41970.58029419789;34846;35222.29555408826;35501.644983549835;35573.64426355807;37961.240775184895;37335.43996840104;37524.061898452754;37640.247195056494;37899.81050094732;37901.620983789806;37512.812435937645;37838.43242351312;37973.620263797005;38434;38536.229275414895;31742.682573173974;33613;33662.15844603806;34029.31941361109;34261.314773704886;26438.735612643628;26563.867180663972;26635.20094397171;26800.32999175036;26933.326666833487 06:30:01 INFO - PROCESS | 10331 | |2;jquery.html;361;368.08897977505666;369.53254133521096;370.24839575661383;370.53312825839436;18177.72733408998;18735.62528749424;19732.408027759153;19737;19800.1089950952;18069.1868865901;18444.815551844476;18565.164567594456;18625.62748745024;18649.347272845454;5596.804111856076;5862.120681897728;5880.852978675546;5882.264716910387;5883.764649414018;4238.7032907696475;5737.856553586173;6053;6293.4650554702675;6308.93691063088;6227.813165605039;6235.376462353751;6255.311915689271;6256.061590761399;6263.404976527223;6029.668368239745;6321.6523091229965;6326.84182895429;6333.461655759266;6335.11308416822;3800.1639639279315;5326.6537675050995;5508.586855985777;5512.145617429305;5534.280543529316;20891.37325880226;21301.254456094117;21504.247351342627;21570.56858862814;21809.890950545305;2342.5197834443898;2683.932901677454;2734.808563400563;2742.424090940905;2883.68279489256;13366.799498007538;14007.439702411892;14087.084339518002;14269.643258918506;14369.425222991067;1932.1015727686552;1984.9404517864486;1990.2536548794203;2002.5093852006205;2020.3332900142918;61304.38695613076;62694.68652656753;62884.37115628831;63115.68442157806;64176.67911660459;9200.769980750534;9471.763205919908;9839.360441571418;10070.44612546317;10090.69727908164;13145.73708525824;13229.669258268428;13239.470421183238;13287.003474739433;13340.866591334157;7660.961695191489;7784.299413052852;7805.141434442206;7850.6859725611475;7883.645235964395;7674.53952762836;7683.731069412544;7695.461317707706;7721.884171737428;7750.108737495148;5973.850653733692;6026.487748541423;6045.244344456943;6065.727042283108;6187.412195841388;1646.853582554517;1684.5030715938829;1697.6180359419031;1747.2224859937205;1797.4068557376036;451.32977528370344;455.4193403410612;456.8419057688743;466.7409587678871;911.6854685133618;10305.948470257601;10983.780324393627;11068.335899846035;11354;11356.205065645325;456.6597884576012;460.4842576314482;463.4577544273208;464.15060439395825;464.1876715747442;6189;6225.221847269091;6228.532860035515;6270.498360131179;6310.085037669604;407505;407664;414304;426469;443836;81632;81754;81834;83695.581522092;83942.58028709817;472.94324681037807;473.3349643750536;477.27215995606286;478.4497827498405;479.9304100905349;10280.331778434378;10285.485725713834;10327.896721032994;10450.954904509792;10456.68629941103;32240.67759322377;32488;33156.50265246072;34000.576179926924;34452.82773586116;47391.763041184575;47860.28209576929;48489.27266091082;48632;51325.74337128291;8169.2647661710735;8186.076272076177;8344.707935222481;8535.445196062235;8581.699640512552;7021.665231608573;10255.538500767334;12807.487700491876;13189.40647670838;13209.339533023503;11164.720881978015;11200.551977920792;11500.194986350874;11562.364069976233;11607.36159511235;6890.896636550556;11365.772684546428;11392.601258955896;11444.771104578029;11799.82300265514;10680.092192163753;10894.128469722562;11011.174161938046;11144.275622084539;11220.1023918088;8147.507751013538;8180.181981801772;8472.957635212031;8502.277306429023;8701.738947831574;10502.94748526283;11322.150838686966;11326.150538709466;11351.886481135083;11517.596884109016 06:30:01 INFO - PROCESS | 10331 | |3;mootools.html;1418.3121186224685;1532.134344095586;1533.946311879084;1768.2661695396412;1890.8581856360777;8156.510609363435;8365.665373385065;8372.83254334913;8387;8390.370722195838;7908.80227994299;8033.558154301511;8037.316828069621;8044;8056.234657707509;2398.1846172301457;2419.41933935855;2422.321749910028;2424.1030818597055;2424.1757802347197;2252.988735056331;2380.4048987753063;2458.557459657261;2467.099508679337;2470.2465747946867;2382.03527571333;2392.1866565367773;2403.0147639467823;2415.698037745282;2427.3446169534304;2321.58211521926;2328.033865945639;2330.9650355244685;2331.7318508371413;2393.6170212765874;2365.8580485170773;2400.1239547565187;2406.1578447543393;2410.2648692148887;2413.083028449178;8117.9594102029705;8125.715599953974;8136.796580085486;8150.633221504987;8153.8776918346275;4961.305417241553;5023.34696489454;5067.417247016567;5079.085764562377;5080.695158290514;3182.2839861031316;3188.872445102193;3243.383757086146;3315.2374953760527;3330.833458327074;1075.67192006438;1975.664137096697;1979.7228388025687;2014.385612388221;2023.3828682251908;11329.660110196708;11343.943280283629;11347.943260283646;11364.204505684524;11412.029977451926;4313.741175529415;4466.5086840448175;4495.100979804052;4522.163399770987;4531.750753708512;9213.677521286856;9237;9247.676331328372;9256.676016339396;9258.768530786785;5074.264231686385;5097.8215762448135;5108.693478391308;5114.820981265638;5120.462351453119;4127.7936103194725;4194.203101410722;4652.185867473247;4705.929411058768;4782.234842425195;3551.6093229744706;3596.3346780845627;3637.9818100909856;3645.9453108203397;3659.597444281127;1066.5360568152878;1068.3963560588243;1075.1936047964027;1076.9138468922467;1087.4182312462954;1396.6787638843123;1409.1545072956144;1421.3959067396315;1455.0905683947533;1476.6308422894276;8084.717034903868;8132.105468398471;8143.307818835466;8148.348132149414;8150.266476017068;546.3089192171906;546.7430307755349;549.8432946610197;556.5380733990778;556.6520924422236;6341.460975817107;6395.616263024141;6400.135981642512;6416.358364163546;6464.418202361716;10072.748181295527;10462.947685261677;10488.63289784869;10523.84214236787;10559.736006599744;10006.49967501622;10208.132308753691;10224.897751022543;10266.948665256627;10327.225458090674;7962.08436029864;8072.757817265491;8077.636506357228;8124.187581241828;8155.673773049011;7868.645910934136;7873.330766884879;7917.208279172037;8047.557384343917;8076.071251806117;9132.360734748503;9194.632214711337;9201.76995575116;9216.539173041187;9383.718488445358;9394;9418.293627977791;9631.759206019906;9735.902640973783;9754.463504507321;5917.260342457193;6467.353264673495;6569.605823650596;6826.829329266609;6960.512764106464;7919.485233459806;7920.603969801372;7935;7946.562939038408;7999.520028798291;7010.26392228829;7035.577865328097;7053.294670532906;7058.964705176441;7278.563286202845;7277.672504737406;7336.156342020736;7338.816529586803;7405.518641288299;7450.813729656802;7365.8526829462035;7480.2145774695055;7490.550566965781;7493.70025198986;7494.063242094739;6800.183977922483;6886.070380498569;6890.10428644273;6890.758823441155;6908.792736217922;6968.0941477607585;7077.009218709488;7079.539829911039;7089.220185779457;7101.502894797314 06:30:01 INFO - PROCESS | 10331 | |4;prototype.html;343.30823390867397;347.0629300887604;347.2499401293207;350.0867757704147;354.7215435882832;6000.369961154076;6013.458788709016;6020.849478763033;6024.246969128859;6032.969835150818;6001.729922153502;6001.969990150054;6011.188489553909;6023.759049638009;6024.09638554216;4380.3210502372185;4539.5006549279715;4633.212353899837;4641.883952901171;4683.8360657377;4658.440987081555;4676.906461870761;4685.2972054191805;4686.390769199999;4692.0381321828945;4627.722336659811;4634.30485427187;4635.976820115895;4636.884077898063;4648.9767551162195;4410.845620403286;4510.0979804039325;4571.565701258375;4577.267637178069;4586.036932244233;4046.9595304046875;4047.7166598338126;4048.1296521248073;4056.634902858757;4056.7971601420104;5615.848751006034;5752.252207213078;5767.884642307173;5770.826875193751;5779.3642699303045;5339.786408543654;5360.410354860962;5397.62216644835;5403.405625381205;5415.918761218585;6340.619562826199;6343.302236753953;6344.555881088326;6344.936550634481;6349.1428657131155;4295.055087880662;4442.888927776799;4448.799804008828;4454.0646464242545;4532.478764942008;6606.207255129367;6653.800385988428;6665.500087493458;6679.56582822115;6688.3646053624825;4527.569880861313;4536.79584418702;4546.29532422475;4550.089982003613;4550.408446901948;4607.055553611502;4607.792649330788;4607.884802879955;4610.700304480198;4612.930806037912;5319.601029922771;5325.600579956519;5326.17444296127;5329.600279979017;5337.092694241911;6289.465395441347;6342.968285158637;6415.1981002374705;6423.710933008026;6425.646589437626;1589.4834178891906;1594.0993338763562;1596.888217824741;1603.0381770937577;1604.7352186889266;1010.434156872154;1053.6048981631889;1056.9524371403306;1070.812607793633;1074.9623763168252;6024.457798798129;6041.577089603774;6055.303640081359;6088.8782224356155;6095.359987201368;6565.803025909135;6566.080748695186;6572.769953051716;6580;6583.111279977237;6062.636241825505;6065.6663883486835;6069.332373438918;6074.301455332605;6134.202553668084;3511.438169892805;3539.663731945461;3544.4683297505067;3544.787312761191;3544.946825797615;6631.966840165865;6740.325967403319;6925.411340036153;6935.167779866348;6939.826504337331;6824.522283440211;6842.828929276808;6846.9729540569315;6859.451243900476;6861.073755043005;6868.210155832143;6896.137982752156;6898;6904.171499420001;6911;6692.364225398579;6694.263631000684;6696.698648560729;6701;6702.285574342399;6439.291677915332;6530.967345163243;6564.6389448580785;6568.146141001639;6570.178727659043;6850.554713943578;6882.242953275036;6884.965575172092;6885.724571017103;6896.689648965708;4503.121891231179;4542.386777784956;4548.249538826057;4549.727016379028;4551.613112885442;6635.502337324623;6654.90017649726;6666.033425153422;6666.166729158856;6666.466682665278;6310.305866354789;6433.067205255305;6436.034594810816;6447.580907241015;6481.902771458526;6453.128827608213;6473.546851720523;6477.287498375081;6478.902816457663;6480.351964803482;6287.182666253358;6344.460720838781;6346.904796427965;6347.428731414195;6349.4920406366455;6469.417752402306;6478.578892371981;6479.708413121515;6486.0919471275;6486.513511486752;6071.939280607137;6190.226221722285;6217.191765070512;6358.046293056079;6358.268799088164 06:30:01 INFO - PROCESS | 10331 | |5;yui.html;901.68441045634;905.8822353094097;906.9863952040721;914.2685851318943;917.1287277086767;14564.927175364122;14865.405383784635;14889.329980150893;14909.478168264113;14917.925410372947;13835;14336.283185840719;14351.210683412408;14370.281485925689;14377.928110359433;763.0347610273009;913.9360244782868;917.4220241248021;928.1368327455464;932.7434955387255;926.5459924636913;940.887093548775;941.5104145844157;942.0626476655738;943.0616536546146;963.7349728824594;967.5984466446416;968.1770495079197;968.3657204531044;969.1326262994615;800.3277247112425;952.5713428956963;959.4579062829514;971.6793458158861;973.4013581647307;707.7699747582056;712.9857402851914;713.2724620886719;713.5718568858695;713.8929160625896;15047.548573542812;15050.548483545512;15089.39642414302;15111.244437778067;15135.621609459742;13967.79048314276;14003.369848356848;14272.785908211385;14301.928490357586;14499.275036248251;11646.534138634444;11684.298942063504;11725.296482211095;11758;11761.235519691192;4010.1779135277197;4026.335654616985;4035.455213546163;4057.2696914555368;4064.7764372959477;53873;53907.73046134783;53974.19038714462;54279.728601357136;54470.45529544733;10890.074343680875;11022.559097636165;11185.364423664694;11211.71970700739;11218.046466050313;20469.18123275082;20505;20507.4873128173;20564.794352056586;20592.176312947613;8328.042275138316;8427.367947403969;8435.409521333448;8520.062793092755;8773.07882672323;4470.642348612103;4575.702579332333;4601.746903920316;4641.466231383367;4795.95204047962;3377.6960073593496;3378.3243351329834;3406.744494162948;3426;3427.657234276602;540.5675459632279;594.4531031451075;602.8553147244629;603.499095750526;606.4875180472494;618.329112912495;681.4207923265185;724.478375569589;725.8330583965718;766.8657984852629;8939.955300223457;9077.319201059947;9170.90829091714;9198.264138868875;9220.953895230481;577.4629594477177;680.3808534233823;713.5148099292531;714.3249629100554;729.6169511006764;4240.893977650521;4291.29193683045;4339.305711086211;4394.692371534026;4407.848144195192;62331;62472.37527624756;62717.11848644548;63163.36836631667;63536;54967.725161373935;55851.441485585434;57000.42999570034;57471;57491.712541437024;49375.50624493781;49490.50509494931;50395.74802126039;50666.493335066174;51039.7448012765;8487.108853570286;8566.957165214135;8593.31253499731;8686.218240358397;8745.825083498166;37521.81239093896;37776;38439.61560384472;38554.6144538551;38591.6140838588;44021.77989110034;44582;48101.75949120372;49103.26345104755;49269.26096108633;11582.247153934968;11691.415429228335;11791.587294444653;12007.939960300142;12176.939115304367;12255.938720306342;12292.938535307267;12497.375131243583;12505.624831255076;12662.683432914251;11193.440327983406;11304.378259195822;11438;11502.079833613458;11889.227200231957;11441;11753.412329383667;11921.52313907434;11927;12198.451069702061;11093.722656933642;11167.162462815159;11651.30092194471;11855.525778968744;11978.161528693256;10845.078168355463;11084.224104312621;11154.832677510007;11407.885921140682;11551.306921584732;10256.897431025594;10324.277300588887;10505;10966.06788422993;11108.50011749457 06:30:01 INFO - PROCESS | 10331 | __end_tp_report 06:30:01 INFO - PROCESS | 10331 | __start_cc_report 06:30:01 INFO - PROCESS | 10331 | _x_x_mozilla_cycle_collect,859 06:30:01 INFO - PROCESS | 10331 | __end_cc_report 06:30:01 INFO - PROCESS | 10331 | __startTimestamp1462887001884__endTimestamp 06:30:01 INFO - PROCESS | 10331 | 06:30:01 INFO - PROCESS | 10331 | ------- Summary: start ------- 06:30:01 INFO - PROCESS | 10331 | Number of tests: 6 06:30:01 INFO - PROCESS | 10331 | 06:30:01 INFO - PROCESS | 10331 | [#0] dojo.html Cycles:165 Average:5354.14 Median:5583.25 stddev:589.54 (10.6%) stddev-sans-first:567.67 06:30:01 INFO - PROCESS | 10331 | Values: 3245.7 3321.0 3335.5 3343.9 3374.0 5321.0 5334.4 5353.2 5362.1 5388.1 5312.3 5355.7 5363.0 5365.5 5371.1 4739.8 4862.9 4881.5 4897.0 4947.6 4851.8 4899.4 4926.3 4930.7 4962.7 4880.5 4913.9 4942.0 4942.8 4944.6 4890.1 4933.9 4943.8 4946.8 4956.3 4796.1 4818.9 4888.6 4895.0 4921.1 5110.5 5111.4 5112.4 5113.2 5120.7 5658.3 5661.3 5664.9 5673.1 5698.6 5621.4 5800.6 5829.4 5854.4 5901.1 5411.6 5434.0 5460.1 5462.1 5464.4 5778.3 5948.9 5975.2 5980.7 5983.2 5624.9 5695.7 5707.4 5725.4 5731.7 5728.1 5739.5 5754.9 5755.2 5762.1 5608.0 5727.9 5728.1 5736.5 5737.8 5729.7 5732.5 5735.3 5760.4 5769.5 4348.0 4378.0 4378.1 4378.3 4407.6 3882.2 3931.6 3975.1 3993.8 3998.5 5475.5 5489.1 5505.3 5508.0 5517.2 5800.4 5804.0 5811.9 5819.1 5822.0 5303.7 5402.0 5470.2 5487.1 5491.3 4879.2 4921.0 4925.4 4925.6 4943.5 5944.8 5988.8 5999.8 6006.3 6009.4 5671.3 5747.9 5803.6 5805.1 5819.6 5904.1 5912.9 5916.5 5924.2 5926.5 5611.0 5669.2 5679.8 5681.7 5689.0 5800.9 5867.0 5885.1 5889.9 5901.6 5627.1 5633.4 5639.4 5652.8 5655.8 5493.8 5572.2 5640.8 5643.9 5646.9 5544.8 5577.7 5578.2 5583.2 5615.0 5641.4 5664.7 5665.5 5672.6 5680.9 5510.1 5578.0 5604.6 5616.6 5683.4 06:30:01 INFO - PROCESS | 10331 | 06:30:01 INFO - PROCESS | 10331 | [#1] ext.html Cycles:180 Average:44921.43 Median:37931.43 stddev:72413.93 (190.9%) stddev-sans-first:72540.31 06:30:01 INFO - PROCESS | 10331 | Values: 512.7 520.9 539.9 548.6 556.3 30580.1 40263.2 40652.4 40799.2 40845.0 42804.4 42984.1 42998.1 43533.6 43559.6 8860.0 8990.4 9069.5 9071.8 9075.3 8792.1 8930.8 8967.3 8967.4 9141.8 9166.5 9274.0 9291.3 9312.5 9315.6 9129.4 9202.4 9205.0 9210.5 9219.5 9100.9 9287.2 9305.3 9308.2 9310.6 43129.6 43618.3 43669.0 43685.0 43699.3 3697.6 3835.9 3902.1 4176.0 4377.3 32836.8 32888.7 33068.5 33259.5 34157.0 4251.1 4285.5 4293.5 4296.4 4355.5 296541.0 303942.0 304918.0 305101.0 305639.0 46043.5 66598.7 67286.3 67350.0 67472.0 44996.8 45045.8 45089.8 45243.8 45264.8 15156.8 15385.2 15403.7 15411.0 15453.7 12215.2 12224.3 12249.5 12251.1 12256.6 15216.7 15354.1 15746.5 15792.6 15816.4 5664.5 5793.9 5915.3 5962.4 5983.9 932.4 959.3 1092.6 1190.4 1192.8 29699.4 30270.2 30439.0 30605.0 30728.4 1106.8 1111.8 1117.0 1137.6 1155.0 15743.5 15931.6 15973.3 16032.0 16109.5 310831.0 314580.0 314786.0 315338.0 315790.0 56722.7 57920.1 57963.7 58015.7 58021.4 1310.2 1368.7 1463.1 1466.4 1467.2 27347.7 28563.7 29626.0 29771.2 30226.0 46062.3 46608.1 46632.0 46639.8 46641.5 192561.0 193918.0 194080.0 204462.0 210685.0 29976.9 34511.8 34619.0 35042.2 35342.2 41109.4 41151.8 41345.8 41538.8 41970.6 34846.0 35222.3 35501.6 35573.6 37961.2 37335.4 37524.1 37640.2 37899.8 37901.6 37512.8 37838.4 37973.6 38434.0 38536.2 31742.7 33613.0 33662.2 34029.3 34261.3 26438.7 26563.9 26635.2 26800.3 26933.3 06:30:01 INFO - PROCESS | 10331 | 06:30:01 INFO - PROCESS | 10331 | [#2] jquery.html Cycles:180 Average:25065.30 Median:435152.50 stddev:69153.68 (15.9%) stddev-sans-first:69322.80 06:30:01 INFO - PROCESS | 10331 | Values: 361.0 368.1 369.5 370.2 370.5 18177.7 18735.6 19732.4 19737.0 19800.1 18069.2 18444.8 18565.2 18625.6 18649.3 5596.8 5862.1 5880.9 5882.3 5883.8 4238.7 5737.9 6053.0 6293.5 6308.9 6227.8 6235.4 6255.3 6256.1 6263.4 6029.7 6321.7 6326.8 6333.5 6335.1 3800.2 5326.7 5508.6 5512.1 5534.3 20891.4 21301.3 21504.2 21570.6 21809.9 2342.5 2683.9 2734.8 2742.4 2883.7 13366.8 14007.4 14087.1 14269.6 14369.4 1932.1 1984.9 1990.3 2002.5 2020.3 61304.4 62694.7 62884.4 63115.7 64176.7 9200.8 9471.8 9839.4 10070.4 10090.7 13145.7 13229.7 13239.5 13287.0 13340.9 7661.0 7784.3 7805.1 7850.7 7883.6 7674.5 7683.7 7695.5 7721.9 7750.1 5973.9 6026.5 6045.2 6065.7 6187.4 1646.9 1684.5 1697.6 1747.2 1797.4 451.3 455.4 456.8 466.7 911.7 10305.9 10983.8 11068.3 11354.0 11356.2 456.7 460.5 463.5 464.2 464.2 6189.0 6225.2 6228.5 6270.5 6310.1 407505.0 407664.0 414304.0 426469.0 443836.0 81632.0 81754.0 81834.0 83695.6 83942.6 472.9 473.3 477.3 478.4 479.9 10280.3 10285.5 10327.9 10451.0 10456.7 32240.7 32488.0 33156.5 34000.6 34452.8 47391.8 47860.3 48489.3 48632.0 51325.7 8169.3 8186.1 8344.7 8535.4 8581.7 7021.7 10255.5 12807.5 13189.4 13209.3 11164.7 11200.6 11500.2 11562.4 11607.4 6890.9 11365.8 11392.6 11444.8 11799.8 10680.1 10894.1 11011.2 11144.3 11220.1 8147.5 8180.2 8473.0 8502.3 8701.7 10502.9 11322.2 11326.2 11351.9 11517.6 06:30:01 INFO - PROCESS | 10331 | 06:30:01 INFO - PROCESS | 10331 | [#3] mootools.html Cycles:180 Average:5830.24 Median:546.53 stddev:3051.64 (558.4%) stddev-sans-first:3042.18 06:30:01 INFO - PROCESS | 10331 | Values: 1418.3 1532.1 1533.9 1768.3 1890.9 8156.5 8365.7 8372.8 8387.0 8390.4 7908.8 8033.6 8037.3 8044.0 8056.2 2398.2 2419.4 2422.3 2424.1 2424.2 2253.0 2380.4 2458.6 2467.1 2470.2 2382.0 2392.2 2403.0 2415.7 2427.3 2321.6 2328.0 2331.0 2331.7 2393.6 2365.9 2400.1 2406.2 2410.3 2413.1 8118.0 8125.7 8136.8 8150.6 8153.9 4961.3 5023.3 5067.4 5079.1 5080.7 3182.3 3188.9 3243.4 3315.2 3330.8 1075.7 1975.7 1979.7 2014.4 2023.4 11329.7 11343.9 11347.9 11364.2 11412.0 4313.7 4466.5 4495.1 4522.2 4531.8 9213.7 9237.0 9247.7 9256.7 9258.8 5074.3 5097.8 5108.7 5114.8 5120.5 4127.8 4194.2 4652.2 4705.9 4782.2 3551.6 3596.3 3638.0 3645.9 3659.6 1066.5 1068.4 1075.2 1076.9 1087.4 1396.7 1409.2 1421.4 1455.1 1476.6 8084.7 8132.1 8143.3 8148.3 8150.3 546.3 546.7 549.8 556.5 556.7 6341.5 6395.6 6400.1 6416.4 6464.4 10072.7 10462.9 10488.6 10523.8 10559.7 10006.5 10208.1 10224.9 10266.9 10327.2 7962.1 8072.8 8077.6 8124.2 8155.7 7868.6 7873.3 7917.2 8047.6 8076.1 9132.4 9194.6 9201.8 9216.5 9383.7 9394.0 9418.3 9631.8 9735.9 9754.5 5917.3 6467.4 6569.6 6826.8 6960.5 7919.5 7920.6 7935.0 7946.6 7999.5 7010.3 7035.6 7053.3 7059.0 7278.6 7277.7 7336.2 7338.8 7405.5 7450.8 7365.9 7480.2 7490.6 7493.7 7494.1 6800.2 6886.1 6890.1 6890.8 6908.8 6968.1 7077.0 7079.5 7089.2 7101.5 06:30:01 INFO - PROCESS | 10331 | 06:30:01 INFO - PROCESS | 10331 | [#4] prototype.html Cycles:180 Average:5361.38 Median:6037.27 stddev:1623.89 (26.9%) stddev-sans-first:1584.16 06:30:01 INFO - PROCESS | 10331 | Values: 343.3 347.1 347.2 350.1 354.7 6000.4 6013.5 6020.8 6024.2 6033.0 6001.7 6002.0 6011.2 6023.8 6024.1 4380.3 4539.5 4633.2 4641.9 4683.8 4658.4 4676.9 4685.3 4686.4 4692.0 4627.7 4634.3 4636.0 4636.9 4649.0 4410.8 4510.1 4571.6 4577.3 4586.0 4047.0 4047.7 4048.1 4056.6 4056.8 5615.8 5752.3 5767.9 5770.8 5779.4 5339.8 5360.4 5397.6 5403.4 5415.9 6340.6 6343.3 6344.6 6344.9 6349.1 4295.1 4442.9 4448.8 4454.1 4532.5 6606.2 6653.8 6665.5 6679.6 6688.4 4527.6 4536.8 4546.3 4550.1 4550.4 4607.1 4607.8 4607.9 4610.7 4612.9 5319.6 5325.6 5326.2 5329.6 5337.1 6289.5 6343.0 6415.2 6423.7 6425.6 1589.5 1594.1 1596.9 1603.0 1604.7 1010.4 1053.6 1057.0 1070.8 1075.0 6024.5 6041.6 6055.3 6088.9 6095.4 6565.8 6566.1 6572.8 6580.0 6583.1 6062.6 6065.7 6069.3 6074.3 6134.2 3511.4 3539.7 3544.5 3544.8 3544.9 6632.0 6740.3 6925.4 6935.2 6939.8 6824.5 6842.8 6847.0 6859.5 6861.1 6868.2 6896.1 6898.0 6904.2 6911.0 6692.4 6694.3 6696.7 6701.0 6702.3 6439.3 6531.0 6564.6 6568.1 6570.2 6850.6 6882.2 6885.0 6885.7 6896.7 4503.1 4542.4 4548.2 4549.7 4551.6 6635.5 6654.9 6666.0 6666.2 6666.5 6310.3 6433.1 6436.0 6447.6 6481.9 6453.1 6473.5 6477.3 6478.9 6480.4 6287.2 6344.5 6346.9 6347.4 6349.5 6469.4 6478.6 6479.7 6486.1 6486.5 6071.9 6190.2 6217.2 6358.0 6358.3 06:30:01 INFO - PROCESS | 10331 | 06:30:01 INFO - PROCESS | 10331 | [#5] yui.html Cycles:180 Average:15043.51 Median:24494.92 stddev:17449.30 (71.2%) stddev-sans-first:17465.93 06:30:01 INFO - PROCESS | 10331 | Values: 901.7 905.9 907.0 914.3 917.1 14564.9 14865.4 14889.3 14909.5 14917.9 13835.0 14336.3 14351.2 14370.3 14377.9 763.0 913.9 917.4 928.1 932.7 926.5 940.9 941.5 942.1 943.1 963.7 967.6 968.2 968.4 969.1 800.3 952.6 959.5 971.7 973.4 707.8 713.0 713.3 713.6 713.9 15047.5 15050.5 15089.4 15111.2 15135.6 13967.8 14003.4 14272.8 14301.9 14499.3 11646.5 11684.3 11725.3 11758.0 11761.2 4010.2 4026.3 4035.5 4057.3 4064.8 53873.0 53907.7 53974.2 54279.7 54470.5 10890.1 11022.6 11185.4 11211.7 11218.0 20469.2 20505.0 20507.5 20564.8 20592.2 8328.0 8427.4 8435.4 8520.1 8773.1 4470.6 4575.7 4601.7 4641.5 4796.0 3377.7 3378.3 3406.7 3426.0 3427.7 540.6 594.5 602.9 603.5 606.5 618.3 681.4 724.5 725.8 766.9 8940.0 9077.3 9170.9 9198.3 9221.0 577.5 680.4 713.5 714.3 729.6 4240.9 4291.3 4339.3 4394.7 4407.8 62331.0 62472.4 62717.1 63163.4 63536.0 54967.7 55851.4 57000.4 57471.0 57491.7 49375.5 49490.5 50395.7 50666.5 51039.7 8487.1 8567.0 8593.3 8686.2 8745.8 37521.8 37776.0 38439.6 38554.6 38591.6 44021.8 44582.0 48101.8 49103.3 49269.3 11582.2 11691.4 11791.6 12007.9 12176.9 12255.9 12292.9 12497.4 12505.6 12662.7 11193.4 11304.4 11438.0 11502.1 11889.2 11441.0 11753.4 11921.5 11927.0 12198.5 11093.7 11167.2 11651.3 11855.5 11978.2 10845.1 11084.2 11154.8 11407.9 11551.3 10256.9 10324.3 10505.0 10966.1 11108.5 06:30:01 INFO - PROCESS | 10331 | -------- Summary: end -------- 06:30:01 INFO - PROCESS | 10331 | 06:30:02 INFO - TEST-INFO | 10331: exit 0 06:30:02 INFO - TEST-OK | dromaeo_css | took 1110714ms 06:30:02 INFO - TEST-START | kraken 06:30:02 INFO - operating with platform_type : linux_ 06:30:02 INFO - Initialising browser for kraken test... 06:30:02 INFO - TEST-INFO | started process 10531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxq0iuv/profile http://localhost:58145/getInfo.html) 06:30:06 INFO - PROCESS | 10531 | __metrics Screen width/height:1600/1200 06:30:06 INFO - PROCESS | 10531 | colorDepth:24 06:30:06 INFO - PROCESS | 10531 | Browser inner width/height: 1024/697 06:30:06 INFO - PROCESS | 10531 | __metrics 06:30:07 INFO - PROCESS | 10531 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:30:08 INFO - TEST-INFO | 10531: exit 0 06:30:08 INFO - Browser initialized. 06:30:08 INFO - Running cycle 1/1 for kraken test... 06:30:08 INFO - TEST-INFO | started process 10623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxq0iuv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:20 INFO - PROCESS | 10623 | RSS: Main: 139472896 06:30:20 INFO - PROCESS | 10623 | 06:30:22 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58145/tests/kraken/driver.html?testName=audio-beat-detection) 06:30:23 INFO - PROCESS | 10623 | RSS: Main: 172982272 06:30:23 INFO - PROCESS | 10623 | 06:30:26 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58145/tests/kraken/driver.html?testName=audio-dft) 06:30:26 INFO - PROCESS | 10623 | RSS: Main: 171724800 06:30:26 INFO - PROCESS | 10623 | 06:30:29 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58145/tests/kraken/driver.html?testName=audio-fft) 06:30:30 INFO - PROCESS | 10623 | RSS: Main: 168415232 06:30:30 INFO - PROCESS | 10623 | 06:30:32 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58145/tests/kraken/driver.html?testName=audio-oscillator) 06:30:32 INFO - PROCESS | 10623 | RSS: Main: 169287680 06:30:32 INFO - PROCESS | 10623 | 06:30:34 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58145/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:30:35 INFO - PROCESS | 10623 | RSS: Main: 167116800 06:30:35 INFO - PROCESS | 10623 | 06:30:38 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58145/tests/kraken/driver.html?testName=imaging-darkroom) 06:30:38 INFO - PROCESS | 10623 | RSS: Main: 167522304 06:30:38 INFO - PROCESS | 10623 | 06:30:42 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58145/tests/kraken/driver.html?testName=imaging-desaturate) 06:30:42 INFO - PROCESS | 10623 | RSS: Main: 167632896 06:30:42 INFO - PROCESS | 10623 | 06:30:45 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58145/tests/kraken/driver.html?testName=json-parse-financial) 06:30:46 INFO - PROCESS | 10623 | RSS: Main: 167587840 06:30:46 INFO - PROCESS | 10623 | 06:30:47 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58145/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:30:48 INFO - PROCESS | 10623 | RSS: Main: 174202880 06:30:48 INFO - PROCESS | 10623 | 06:30:50 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58145/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:30:50 INFO - PROCESS | 10623 | RSS: Main: 172216320 06:30:50 INFO - PROCESS | 10623 | 06:30:52 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58145/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:30:53 INFO - PROCESS | 10623 | RSS: Main: 178442240 06:30:53 INFO - PROCESS | 10623 | 06:30:55 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:30:56 INFO - PROCESS | 10623 | RSS: Main: 183775232 06:30:56 INFO - PROCESS | 10623 | 06:30:58 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:30:59 INFO - PROCESS | 10623 | RSS: Main: 182861824 06:30:59 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | Cycle 1(1): loaded http://localhost:58145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58145/tests/kraken/driver.html?testName=ai-astar) 06:31:01 INFO - PROCESS | 10623 | RSS: Main: 244981760 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | __start_tp_report 06:31:01 INFO - PROCESS | 10623 | _x_x_mozilla_page_load 06:31:01 INFO - PROCESS | 10623 | _x_x_mozilla_page_load_details 06:31:01 INFO - PROCESS | 10623 | |i|pagename|runs| 06:31:01 INFO - PROCESS | 10623 | |0;ai-astar;111;114;107;111;112;112;101;111;111;110 06:31:01 INFO - PROCESS | 10623 | |1;audio-beat-detection;153;126;158;175;128;157;151;130;186;128 06:31:01 INFO - PROCESS | 10623 | |2;audio-dft;162;161;161;161;159;162;160;167;161;160 06:31:01 INFO - PROCESS | 10623 | |3;audio-fft;73;76;74;161;76;76;76;77;165;78 06:31:01 INFO - PROCESS | 10623 | |4;audio-oscillator;92;93;148;92;92;93;138;93;94;134 06:31:01 INFO - PROCESS | 10623 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;116;117;116 06:31:01 INFO - PROCESS | 10623 | |6;imaging-darkroom;147;146;146;145;146;145;146;145;146;145 06:31:01 INFO - PROCESS | 10623 | |7;imaging-desaturate;96;96;95;95;95;96;96;95;95;95 06:31:01 INFO - PROCESS | 10623 | |8;json-parse-financial;57;57;56;55;56;55;55;56;55;54 06:31:01 INFO - PROCESS | 10623 | |9;json-stringify-tinderbox;64;65;66;65;65;65;65;65;65;65 06:31:01 INFO - PROCESS | 10623 | |10;stanford-crypto-aes;79;80;81;79;81;79;81;94;80;92 06:31:01 INFO - PROCESS | 10623 | |11;stanford-crypto-ccm;115;115;117;113;112;130;113;118;112;113 06:31:01 INFO - PROCESS | 10623 | |12;stanford-crypto-pbkdf2;149;139;148;146;146;136;146;146;147;146 06:31:01 INFO - PROCESS | 10623 | |13;stanford-crypto-sha256-iterative;67;69;72;69;70;68;67;69;66;68 06:31:01 INFO - PROCESS | 10623 | __end_tp_report 06:31:01 INFO - PROCESS | 10623 | __start_cc_report 06:31:01 INFO - PROCESS | 10623 | _x_x_mozilla_cycle_collect,1067 06:31:01 INFO - PROCESS | 10623 | __end_cc_report 06:31:01 INFO - PROCESS | 10623 | __startTimestamp1462887061349__endTimestamp 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | ------- Summary: start ------- 06:31:01 INFO - PROCESS | 10623 | Number of tests: 14 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.62 (3.3%) stddev-sans-first:3.82 06:31:01 INFO - PROCESS | 10623 | Values: 111.0 114.0 107.0 111.0 112.0 112.0 101.0 111.0 111.0 110.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:155.00 stddev:21.03 (13.6%) stddev-sans-first:22.26 06:31:01 INFO - PROCESS | 10623 | Values: 153.0 126.0 158.0 175.0 128.0 157.0 151.0 130.0 186.0 128.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:2.17 (1.3%) stddev-sans-first:2.29 06:31:01 INFO - PROCESS | 10623 | Values: 162.0 161.0 161.0 161.0 159.0 162.0 160.0 167.0 161.0 160.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.00 stddev:36.83 (48.5%) stddev-sans-first:38.33 06:31:01 INFO - PROCESS | 10623 | Values: 73.0 76.0 74.0 161.0 76.0 76.0 76.0 77.0 165.0 78.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:92.50 stddev:23.10 (25.0%) stddev-sans-first:23.86 06:31:01 INFO - PROCESS | 10623 | Values: 92.0 93.0 148.0 92.0 92.0 93.0 138.0 93.0 94.0 134.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:31:01 INFO - PROCESS | 10623 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 06:31:01 INFO - PROCESS | 10623 | Values: 147.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:31:01 INFO - PROCESS | 10623 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:0.88 06:31:01 INFO - PROCESS | 10623 | Values: 57.0 57.0 56.0 55.0 56.0 55.0 55.0 56.0 55.0 54.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 06:31:01 INFO - PROCESS | 10623 | Values: 64.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:81.00 stddev:5.56 (6.9%) stddev-sans-first:5.74 06:31:01 INFO - PROCESS | 10623 | Values: 79.0 80.0 81.0 79.0 81.0 79.0 81.0 94.0 80.0 92.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:115.00 stddev:5.39 (4.7%) stddev-sans-first:5.71 06:31:01 INFO - PROCESS | 10623 | Values: 115.0 115.0 117.0 113.0 112.0 130.0 113.0 118.0 112.0 113.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:146.00 stddev:4.09 (2.8%) stddev-sans-first:4.07 06:31:01 INFO - PROCESS | 10623 | Values: 149.0 139.0 148.0 146.0 146.0 136.0 146.0 146.0 147.0 146.0 06:31:01 INFO - PROCESS | 10623 | 06:31:01 INFO - PROCESS | 10623 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.72 (2.5%) stddev-sans-first:1.73 06:31:01 INFO - PROCESS | 10623 | Values: 67.0 69.0 72.0 69.0 70.0 68.0 67.0 69.0 66.0 68.0 06:31:01 INFO - PROCESS | 10623 | -------- Summary: end -------- 06:31:01 INFO - PROCESS | 10623 | 06:31:02 INFO - TEST-INFO | 10623: exit 0 06:31:02 INFO - TEST-OK | kraken | took 59890ms 06:31:02 INFO - SUITE-END | took 1170s 06:31:02 INFO - Completed test suite (00:19:30) 06:31:02 INFO - javascript benchmark 06:31:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3245.7078862902335, 3320.9833950830243, 3335.5330253764478, 3343.9164020899475, 3374.0383990562696, 5320.973395133024, 5334.359876814783, 5353.197020446935, 5362.142057270833, 5388.084025715628, 5312.256284120226, 5355.6786592804365, 5362.973185134078, 5365.517103460687, 5371.113766228567, 4739.834105806298, 4862.854114376574, 4881.4874438184015, 4897.02059588082, 4947.554720075193, 4851.830185943492, 4899.363082799231, 4926.261060840885, 4930.654854160211, 4962.702237865721, 4880.487548807378, 4913.9262911056185, 4941.975290123562, 4942.752862356868, 4944.554990050895, 4890.070886531547, 4933.901321973541, 4943.777530011158, 4946.802127914897, 4956.256561515784, 4796.136695394827, 4818.879528011793, 4888.584470320027, 4895.0, 4921.114199444099, 5110.540051395392, 5111.361079865017, 5112.386513618352, 5113.207452844815, 5120.692758434506, 5658.292713410824, 5661.264035675335, 5664.915026274609, 5673.120666296731, 5698.601097923147, 5621.437856214387, 5800.593958422912, 5829.417058294179, 5854.356020837705, 5901.114832775075, 5411.594130440233, 5434.0, 5460.071787796044, 5462.0987537056335, 5464.371597266365, 5778.27771528559, 5948.881022379528, 5975.19334889793, 5980.671063091571, 5983.222181116427, 5624.859378515488, 5695.715214239354, 5707.429257074343, 5725.398833122462, 5731.684757338387, 5728.1407788831175, 5739.540836733051, 5754.942450575524, 5755.165501002331, 5762.1068734346245, 5608.0, 5727.942720572824, 5728.054870946247, 5736.483716465455, 5737.827865164052, 5729.684867332337, 5732.541396688255, 5735.340435849931, 5760.423957604206, 5769.509591684754, 4347.9565204347555, 4378.036831896978, 4378.124375124988, 4378.277584198571, 4407.58127977848, 3882.242962622318, 3931.5871833457645, 3975.0857302820514, 3993.7803420812133, 3998.4801975742967, 5475.534579560782, 5489.149181876815, 5505.284313039359, 5508.0, 5517.227588137664, 5800.39095894925, 5803.970980145073, 5811.912821307684, 5819.127130930395, 5822.0, 5303.68177909319, 5401.972990135024, 5470.206820011076, 5487.1494918286935, 5491.341039075257, 4879.243717223836, 4920.950790492049, 4925.38432695913, 4925.581325587294, 4943.505649435099, 5944.821655350346, 5988.790392336335, 5999.760009599567, 6006.309274433496, 6009.369016253318, 5671.291088613923, 5747.942520574741, 5803.593748437569, 5805.129230615442, 5819.592628515963, 5904.143899134516, 5912.881742365043, 5916.526677865846, 5924.200232968667, 5926.4666180044005, 5610.971945140248, 5669.234653321749, 5679.801206957736, 5681.659100453986, 5688.971555142198, 5800.854978625399, 5867.031939729897, 5885.087811389241, 5889.852753681021, 5901.5868889177345, 5627.071533196977, 5633.436656334334, 5639.351474580476, 5652.830415087554, 5655.830325090254, 5493.835184944458, 5572.192032155396, 5640.830775076754, 5643.88712225745, 5646.9152962704775, 5544.805931792368, 5577.721113944205, 5578.219049333015, 5583.2462617547735, 5615.0173719599725, 5641.407652196624, 5664.716764161693, 5665.461781130786, 5672.631278966854, 5680.9147862781265, 5510.090835012178, 5577.995960726946, 5604.579656525859, 5616.634918730269, 5683.3748287687495], "unit": "score", "name": "dojo.html", "value": 5316.67065277281}, {"lowerIsBetter": false, "replicates": [512.6513970500063, 520.8697825543614, 539.9066889548664, 548.5967813656964, 556.2907293201168, 30580.082597522083, 40263.194736105295, 40652.39021414678, 40799.184016319654, 40845.0, 42804.35793463101, 42984.14031719364, 42998.140037199315, 43533.56466435335, 43559.564404355944, 8859.999999999984, 8990.415622984485, 9069.455832650028, 9071.773205669879, 9075.27397808177, 8792.120787921222, 8930.776730581754, 8967.327450441211, 8967.372283940127, 9141.817163656722, 9166.487529557615, 9274.02622724611, 9291.303152263607, 9312.487813170274, 9315.627374905029, 9129.406588571755, 9202.401843880127, 9204.953975230148, 9210.49342286174, 9219.492927888963, 9100.908990910073, 9287.210587100037, 9305.255579553686, 9308.208802251816, 9310.627574896997, 43129.56870431287, 43618.34572481384, 43669.0, 43685.0, 43699.34450983238, 3697.593264740903, 3835.9424608630893, 3902.102516421239, 4175.997760537449, 4377.299632058887, 32836.83581582101, 32888.6711132888, 33068.51191696379, 33259.501107483404, 34157.0, 4251.149770046003, 4285.507166675841, 4293.506246781629, 4296.3770253313405, 4355.477342718862, 296541.0, 303942.0, 304917.9999999978, 305101.0, 305639.0, 46043.539564603925, 66598.66700666466, 67286.32713672899, 67350.0, 67472.0, 44996.775016125364, 45045.774771125936, 45089.77455112703, 45243.773781131546, 45264.77367613207, 15156.848431515544, 15385.230738463031, 15403.691926161415, 15411.0, 15453.690926181413, 12215.206011609216, 12224.26654400721, 12249.510019599116, 12251.081168912368, 12256.571020014257, 15216.695666086616, 15354.078755274719, 15746.527604171893, 15792.605184870241, 15816.446424375092, 5664.54683625309, 5793.8551536211935, 5915.349311575723, 5962.433568811043, 5983.850403739854, 932.4265576670434, 959.3236768078488, 1092.5902786455079, 1190.3869507203797, 1192.785298646252, 29699.40601187964, 30270.243243918638, 30439.0, 30605.0, 30728.38543229123, 1106.7675788084593, 1111.766529028897, 1117.022605220432, 1137.6018393562354, 1154.988450115505, 15743.527694169194, 15931.601709957113, 15973.299908479485, 16032.038077715375, 16109.516714498584, 310831.0, 314580.0, 314786.0, 315338.0, 315790.0, 56722.71638641781, 57920.13119803206, 57963.71018144882, 58015.70992145012, 58021.41978580245, 1310.1614966421498, 1368.7194125204508, 1463.1075044223016, 1466.3914475492552, 1467.1563850785628, 27347.72652273452, 28563.714362856106, 29626.0, 29771.22501286561, 30226.0, 46062.30906536338, 46608.067838643714, 46632.0, 46639.76680116577, 46641.53358466508, 192561.0, 193918.0, 194080.0, 204462.0, 210685.0, 29976.850115749283, 34511.82744086264, 34619.0, 35042.24788760603, 35342.23288835496, 41109.383359250234, 41151.794241028605, 41345.79327103345, 41538.792306038275, 41970.58029419789, 34846.0, 35222.29555408826, 35501.644983549835, 35573.64426355807, 37961.240775184895, 37335.43996840104, 37524.061898452754, 37640.247195056494, 37899.81050094732, 37901.620983789806, 37512.812435937645, 37838.43242351312, 37973.620263797005, 38434.0, 38536.229275414895, 31742.682573173974, 33613.0, 33662.15844603806, 34029.31941361109, 34261.314773704886, 26438.735612643628, 26563.867180663972, 26635.20094397171, 26800.32999175036, 26933.326666833487], "unit": "score", "name": "ext.html", "value": 18644.277076740098}, {"lowerIsBetter": false, "replicates": [361.0, 368.08897977505666, 369.53254133521096, 370.24839575661383, 370.53312825839436, 18177.72733408998, 18735.62528749424, 19732.408027759153, 19737.0, 19800.1089950952, 18069.1868865901, 18444.815551844476, 18565.164567594456, 18625.62748745024, 18649.347272845454, 5596.804111856076, 5862.120681897728, 5880.852978675546, 5882.264716910387, 5883.764649414018, 4238.7032907696475, 5737.856553586173, 6053.0, 6293.4650554702675, 6308.93691063088, 6227.813165605039, 6235.376462353751, 6255.311915689271, 6256.061590761399, 6263.404976527223, 6029.668368239745, 6321.6523091229965, 6326.84182895429, 6333.461655759266, 6335.11308416822, 3800.1639639279315, 5326.6537675050995, 5508.586855985777, 5512.145617429305, 5534.280543529316, 20891.37325880226, 21301.254456094117, 21504.247351342627, 21570.56858862814, 21809.890950545305, 2342.5197834443898, 2683.932901677454, 2734.808563400563, 2742.424090940905, 2883.68279489256, 13366.799498007538, 14007.439702411892, 14087.084339518002, 14269.643258918506, 14369.425222991067, 1932.1015727686552, 1984.9404517864486, 1990.2536548794203, 2002.5093852006205, 2020.3332900142918, 61304.38695613076, 62694.68652656753, 62884.37115628831, 63115.68442157806, 64176.67911660459, 9200.769980750534, 9471.763205919908, 9839.360441571418, 10070.44612546317, 10090.69727908164, 13145.73708525824, 13229.669258268428, 13239.470421183238, 13287.003474739433, 13340.866591334157, 7660.961695191489, 7784.299413052852, 7805.141434442206, 7850.6859725611475, 7883.645235964395, 7674.53952762836, 7683.731069412544, 7695.461317707706, 7721.884171737428, 7750.108737495148, 5973.850653733692, 6026.487748541423, 6045.244344456943, 6065.727042283108, 6187.412195841388, 1646.853582554517, 1684.5030715938829, 1697.6180359419031, 1747.2224859937205, 1797.4068557376036, 451.32977528370344, 455.4193403410612, 456.8419057688743, 466.7409587678871, 911.6854685133618, 10305.948470257601, 10983.780324393627, 11068.335899846035, 11354.0, 11356.205065645325, 456.6597884576012, 460.4842576314482, 463.4577544273208, 464.15060439395825, 464.1876715747442, 6189.0, 6225.221847269091, 6228.532860035515, 6270.498360131179, 6310.085037669604, 407505.0, 407664.0, 414304.0, 426469.0, 443836.0, 81632.0, 81754.0, 81834.0, 83695.581522092, 83942.58028709817, 472.94324681037807, 473.3349643750536, 477.27215995606286, 478.4497827498405, 479.9304100905349, 10280.331778434378, 10285.485725713834, 10327.896721032994, 10450.954904509792, 10456.68629941103, 32240.67759322377, 32488.0, 33156.50265246072, 34000.576179926924, 34452.82773586116, 47391.763041184575, 47860.28209576929, 48489.27266091082, 48632.0, 51325.74337128291, 8169.2647661710735, 8186.076272076177, 8344.707935222481, 8535.445196062235, 8581.699640512552, 7021.665231608573, 10255.538500767334, 12807.487700491876, 13189.40647670838, 13209.339533023503, 11164.720881978015, 11200.551977920792, 11500.194986350874, 11562.364069976233, 11607.36159511235, 6890.896636550556, 11365.772684546428, 11392.601258955896, 11444.771104578029, 11799.82300265514, 10680.092192163753, 10894.128469722562, 11011.174161938046, 11144.275622084539, 11220.1023918088, 8147.507751013538, 8180.181981801772, 8472.957635212031, 8502.277306429023, 8701.738947831574, 10502.94748526283, 11322.150838686966, 11326.150538709466, 11351.886481135083, 11517.596884109016], "unit": "score", "name": "jquery.html", "value": 8050.52189972528}, {"lowerIsBetter": false, "replicates": [1418.3121186224685, 1532.134344095586, 1533.946311879084, 1768.2661695396412, 1890.8581856360777, 8156.510609363435, 8365.665373385065, 8372.83254334913, 8387.0, 8390.370722195838, 7908.80227994299, 8033.558154301511, 8037.316828069621, 8044.0, 8056.234657707509, 2398.1846172301457, 2419.41933935855, 2422.321749910028, 2424.1030818597055, 2424.1757802347197, 2252.988735056331, 2380.4048987753063, 2458.557459657261, 2467.099508679337, 2470.2465747946867, 2382.03527571333, 2392.1866565367773, 2403.0147639467823, 2415.698037745282, 2427.3446169534304, 2321.58211521926, 2328.033865945639, 2330.9650355244685, 2331.7318508371413, 2393.6170212765874, 2365.8580485170773, 2400.1239547565187, 2406.1578447543393, 2410.2648692148887, 2413.083028449178, 8117.9594102029705, 8125.715599953974, 8136.796580085486, 8150.633221504987, 8153.8776918346275, 4961.305417241553, 5023.34696489454, 5067.417247016567, 5079.085764562377, 5080.695158290514, 3182.2839861031316, 3188.872445102193, 3243.383757086146, 3315.2374953760527, 3330.833458327074, 1075.67192006438, 1975.664137096697, 1979.7228388025687, 2014.385612388221, 2023.3828682251908, 11329.660110196708, 11343.943280283629, 11347.943260283646, 11364.204505684524, 11412.029977451926, 4313.741175529415, 4466.5086840448175, 4495.100979804052, 4522.163399770987, 4531.750753708512, 9213.677521286856, 9237.0, 9247.676331328372, 9256.676016339396, 9258.768530786785, 5074.264231686385, 5097.8215762448135, 5108.693478391308, 5114.820981265638, 5120.462351453119, 4127.7936103194725, 4194.203101410722, 4652.185867473247, 4705.929411058768, 4782.234842425195, 3551.6093229744706, 3596.3346780845627, 3637.9818100909856, 3645.9453108203397, 3659.597444281127, 1066.5360568152878, 1068.3963560588243, 1075.1936047964027, 1076.9138468922467, 1087.4182312462954, 1396.6787638843123, 1409.1545072956144, 1421.3959067396315, 1455.0905683947533, 1476.6308422894276, 8084.717034903868, 8132.105468398471, 8143.307818835466, 8148.348132149414, 8150.266476017068, 546.3089192171906, 546.7430307755349, 549.8432946610197, 556.5380733990778, 556.6520924422236, 6341.460975817107, 6395.616263024141, 6400.135981642512, 6416.358364163546, 6464.418202361716, 10072.748181295527, 10462.947685261677, 10488.63289784869, 10523.84214236787, 10559.736006599744, 10006.49967501622, 10208.132308753691, 10224.897751022543, 10266.948665256627, 10327.225458090674, 7962.08436029864, 8072.757817265491, 8077.636506357228, 8124.187581241828, 8155.673773049011, 7868.645910934136, 7873.330766884879, 7917.208279172037, 8047.557384343917, 8076.071251806117, 9132.360734748503, 9194.632214711337, 9201.76995575116, 9216.539173041187, 9383.718488445358, 9394.0, 9418.293627977791, 9631.759206019906, 9735.902640973783, 9754.463504507321, 5917.260342457193, 6467.353264673495, 6569.605823650596, 6826.829329266609, 6960.512764106464, 7919.485233459806, 7920.603969801372, 7935.0, 7946.562939038408, 7999.520028798291, 7010.26392228829, 7035.577865328097, 7053.294670532906, 7058.964705176441, 7278.563286202845, 7277.672504737406, 7336.156342020736, 7338.816529586803, 7405.518641288299, 7450.813729656802, 7365.8526829462035, 7480.2145774695055, 7490.550566965781, 7493.70025198986, 7494.063242094739, 6800.183977922483, 6886.070380498569, 6890.10428644273, 6890.758823441155, 6908.792736217922, 6968.0941477607585, 7077.009218709488, 7079.539829911039, 7089.220185779457, 7101.502894797314], "unit": "score", "name": "mootools.html", "value": 4739.538247670505}, {"lowerIsBetter": false, "replicates": [343.30823390867397, 347.0629300887604, 347.2499401293207, 350.0867757704147, 354.7215435882832, 6000.369961154076, 6013.458788709016, 6020.849478763033, 6024.246969128859, 6032.969835150818, 6001.729922153502, 6001.969990150054, 6011.188489553909, 6023.759049638009, 6024.09638554216, 4380.3210502372185, 4539.5006549279715, 4633.212353899837, 4641.883952901171, 4683.8360657377, 4658.440987081555, 4676.906461870761, 4685.2972054191805, 4686.390769199999, 4692.0381321828945, 4627.722336659811, 4634.30485427187, 4635.976820115895, 4636.884077898063, 4648.9767551162195, 4410.845620403286, 4510.0979804039325, 4571.565701258375, 4577.267637178069, 4586.036932244233, 4046.9595304046875, 4047.7166598338126, 4048.1296521248073, 4056.634902858757, 4056.7971601420104, 5615.848751006034, 5752.252207213078, 5767.884642307173, 5770.826875193751, 5779.3642699303045, 5339.786408543654, 5360.410354860962, 5397.62216644835, 5403.405625381205, 5415.918761218585, 6340.619562826199, 6343.302236753953, 6344.555881088326, 6344.936550634481, 6349.1428657131155, 4295.055087880662, 4442.888927776799, 4448.799804008828, 4454.0646464242545, 4532.478764942008, 6606.207255129367, 6653.800385988428, 6665.500087493458, 6679.56582822115, 6688.3646053624825, 4527.569880861313, 4536.79584418702, 4546.29532422475, 4550.089982003613, 4550.408446901948, 4607.055553611502, 4607.792649330788, 4607.884802879955, 4610.700304480198, 4612.930806037912, 5319.601029922771, 5325.600579956519, 5326.17444296127, 5329.600279979017, 5337.092694241911, 6289.465395441347, 6342.968285158637, 6415.1981002374705, 6423.710933008026, 6425.646589437626, 1589.4834178891906, 1594.0993338763562, 1596.888217824741, 1603.0381770937577, 1604.7352186889266, 1010.434156872154, 1053.6048981631889, 1056.9524371403306, 1070.812607793633, 1074.9623763168252, 6024.457798798129, 6041.577089603774, 6055.303640081359, 6088.8782224356155, 6095.359987201368, 6565.803025909135, 6566.080748695186, 6572.769953051716, 6580.0, 6583.111279977237, 6062.636241825505, 6065.6663883486835, 6069.332373438918, 6074.301455332605, 6134.202553668084, 3511.438169892805, 3539.663731945461, 3544.4683297505067, 3544.787312761191, 3544.946825797615, 6631.966840165865, 6740.325967403319, 6925.411340036153, 6935.167779866348, 6939.826504337331, 6824.522283440211, 6842.828929276808, 6846.9729540569315, 6859.451243900476, 6861.073755043005, 6868.210155832143, 6896.137982752156, 6898.0, 6904.171499420001, 6911.0, 6692.364225398579, 6694.263631000684, 6696.698648560729, 6701.0, 6702.285574342399, 6439.291677915332, 6530.967345163243, 6564.6389448580785, 6568.146141001639, 6570.178727659043, 6850.554713943578, 6882.242953275036, 6884.965575172092, 6885.724571017103, 6896.689648965708, 4503.121891231179, 4542.386777784956, 4548.249538826057, 4549.727016379028, 4551.613112885442, 6635.502337324623, 6654.90017649726, 6666.033425153422, 6666.166729158856, 6666.466682665278, 6310.305866354789, 6433.067205255305, 6436.034594810816, 6447.580907241015, 6481.902771458526, 6453.128827608213, 6473.546851720523, 6477.287498375081, 6478.902816457663, 6480.351964803482, 6287.182666253358, 6344.460720838781, 6346.904796427965, 6347.428731414195, 6349.4920406366455, 6469.417752402306, 6478.578892371981, 6479.708413121515, 6486.0919471275, 6486.513511486752, 6071.939280607137, 6190.226221722285, 6217.191765070512, 6358.046293056079, 6358.268799088164], "unit": "score", "name": "prototype.html", "value": 4832.854748855808}, {"lowerIsBetter": false, "replicates": [901.68441045634, 905.8822353094097, 906.9863952040721, 914.2685851318943, 917.1287277086767, 14564.927175364122, 14865.405383784635, 14889.329980150893, 14909.478168264113, 14917.925410372947, 13835.0, 14336.283185840719, 14351.210683412408, 14370.281485925689, 14377.928110359433, 763.0347610273009, 913.9360244782868, 917.4220241248021, 928.1368327455464, 932.7434955387255, 926.5459924636913, 940.887093548775, 941.5104145844157, 942.0626476655738, 943.0616536546146, 963.7349728824594, 967.5984466446416, 968.1770495079197, 968.3657204531044, 969.1326262994615, 800.3277247112425, 952.5713428956963, 959.4579062829514, 971.6793458158861, 973.4013581647307, 707.7699747582056, 712.9857402851914, 713.2724620886719, 713.5718568858695, 713.8929160625896, 15047.548573542812, 15050.548483545512, 15089.39642414302, 15111.244437778067, 15135.621609459742, 13967.79048314276, 14003.369848356848, 14272.785908211385, 14301.928490357586, 14499.275036248251, 11646.534138634444, 11684.298942063504, 11725.296482211095, 11758.0, 11761.235519691192, 4010.1779135277197, 4026.335654616985, 4035.455213546163, 4057.2696914555368, 4064.7764372959477, 53873.0, 53907.73046134783, 53974.19038714462, 54279.728601357136, 54470.45529544733, 10890.074343680875, 11022.559097636165, 11185.364423664694, 11211.71970700739, 11218.046466050313, 20469.18123275082, 20505.0, 20507.4873128173, 20564.794352056586, 20592.176312947613, 8328.042275138316, 8427.367947403969, 8435.409521333448, 8520.062793092755, 8773.07882672323, 4470.642348612103, 4575.702579332333, 4601.746903920316, 4641.466231383367, 4795.95204047962, 3377.6960073593496, 3378.3243351329834, 3406.744494162948, 3426.0, 3427.657234276602, 540.5675459632279, 594.4531031451075, 602.8553147244629, 603.499095750526, 606.4875180472494, 618.329112912495, 681.4207923265185, 724.478375569589, 725.8330583965718, 766.8657984852629, 8939.955300223457, 9077.319201059947, 9170.90829091714, 9198.264138868875, 9220.953895230481, 577.4629594477177, 680.3808534233823, 713.5148099292531, 714.3249629100554, 729.6169511006764, 4240.893977650521, 4291.29193683045, 4339.305711086211, 4394.692371534026, 4407.848144195192, 62331.0, 62472.37527624756, 62717.11848644548, 63163.36836631667, 63536.0, 54967.725161373935, 55851.441485585434, 57000.42999570034, 57471.0, 57491.712541437024, 49375.50624493781, 49490.50509494931, 50395.74802126039, 50666.493335066174, 51039.7448012765, 8487.108853570286, 8566.957165214135, 8593.31253499731, 8686.218240358397, 8745.825083498166, 37521.81239093896, 37776.0, 38439.61560384472, 38554.6144538551, 38591.6140838588, 44021.77989110034, 44582.0, 48101.75949120372, 49103.26345104755, 49269.26096108633, 11582.247153934968, 11691.415429228335, 11791.587294444653, 12007.939960300142, 12176.939115304367, 12255.938720306342, 12292.938535307267, 12497.375131243583, 12505.624831255076, 12662.683432914251, 11193.440327983406, 11304.378259195822, 11438.0, 11502.079833613458, 11889.227200231957, 11441.0, 11753.412329383667, 11921.52313907434, 11927.0, 12198.451069702061, 11093.722656933642, 11167.162462815159, 11651.30092194471, 11855.525778968744, 11978.161528693256, 10845.078168355463, 11084.224104312621, 11154.832677510007, 11407.885921140682, 11551.306921584732, 10256.897431025594, 10324.277300588887, 10505.0, 10966.06788422993, 11108.50011749457], "unit": "score", "name": "yui.html", "value": 6887.655685023503}], "name": "dromaeo_css", "value": 7079.609838703837}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 107.0, 111.0, 112.0, 112.0, 101.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [153.0, 126.0, 158.0, 175.0, 128.0, 157.0, 151.0, 130.0, 186.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 159.0, 162.0, 160.0, 167.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 74.0, 161.0, 76.0, 76.0, 76.0, 77.0, 165.0, 78.0], "unit": "score", "name": "audio-fft", "value": 93.2}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 148.0, 92.0, 92.0, 93.0, 138.0, 93.0, 94.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 81.0, 79.0, 81.0, 79.0, 81.0, 94.0, 80.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 117.0, 113.0, 112.0, 130.0, 113.0, 118.0, 112.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.8}, {"lowerIsBetter": true, "replicates": [149.0, 139.0, 148.0, 146.0, 146.0, 136.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 72.0, 69.0, 70.0, 68.0, 67.0, 69.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1510.8}]} 06:31:02 INFO - Return code: 0 06:31:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:31:02 INFO - # TBPL SUCCESS # 06:31:02 INFO - Running post-action listener: _resource_record_post_action 06:31:02 INFO - Running post-run listener: _resource_record_post_run 06:31:03 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 16384; Write bytes: 441151488; Read time: 36; Write time: 298576 06:31:03 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 219443200; Read time: 0; Write time: 187476 06:31:03 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 221708288; Read time: 36; Write time: 111100 06:31:03 INFO - Running post-run listener: _upload_blobber_files 06:31:03 INFO - Blob upload gear active. 06:31:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:31:03 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 06:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:31:04 INFO - (blobuploader) - INFO - Open directory for files ... 06:31:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:31:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:05 INFO - (blobuploader) - INFO - Done attempting. 06:31:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:31:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:05 INFO - (blobuploader) - INFO - Done attempting. 06:31:05 INFO - (blobuploader) - INFO - Iteration through files over. 06:31:05 INFO - Return code: 0 06:31:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:31:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:31:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58e516b059619e590a0e84382c9307e006a3e0d4477ad8588c17bada97fc93e7793d4259ca5a7204ef63783032aaeab18193426c2ea84fb0ad941140efe48695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dac9c9a4bd8a4dc2a3abf33f35c2a202d917c465134e5efb85f33d7d0d7b534635634226e826dd260aa5ab24a7b478f6587828dc1cd4bf640bca18ec3a41667f"} 06:31:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:31:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:31:05 INFO - Contents: 06:31:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58e516b059619e590a0e84382c9307e006a3e0d4477ad8588c17bada97fc93e7793d4259ca5a7204ef63783032aaeab18193426c2ea84fb0ad941140efe48695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dac9c9a4bd8a4dc2a3abf33f35c2a202d917c465134e5efb85f33d7d0d7b534635634226e826dd260aa5ab24a7b478f6587828dc1cd4bf640bca18ec3a41667f"} 06:31:05 INFO - Running post-run listener: copy_logs_to_upload_dir 06:31:05 INFO - Copying logs to upload dir... 06:31:05 INFO - mkdir: /builds/slave/test/build/upload/logs 06:31:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.471864 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-10 06:31:05.724338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 06:31:05.727922) ========= 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=00204705a9daa57ed339a427000001b9-1462885635.904423-690559836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58e516b059619e590a0e84382c9307e006a3e0d4477ad8588c17bada97fc93e7793d4259ca5a7204ef63783032aaeab18193426c2ea84fb0ad941140efe48695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dac9c9a4bd8a4dc2a3abf33f35c2a202d917c465134e5efb85f33d7d0d7b534635634226e826dd260aa5ab24a7b478f6587828dc1cd4bf640bca18ec3a41667f"} build_url:https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/bR7pJtUeTtycWQDpQjwFqA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58e516b059619e590a0e84382c9307e006a3e0d4477ad8588c17bada97fc93e7793d4259ca5a7204ef63783032aaeab18193426c2ea84fb0ad941140efe48695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dac9c9a4bd8a4dc2a3abf33f35c2a202d917c465134e5efb85f33d7d0d7b534635634226e826dd260aa5ab24a7b478f6587828dc1cd4bf640bca18ec3a41667f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 06:31:05.752741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:31:05.753120) ========= 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=00204705a9daa57ed339a427000001b9-1462885635.904423-690559836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:31:05.841133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 06:31:05.841864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 06:31:05.842502) ========= ========= Total master_lag: 0.18 =========