builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1470381797.33 results: success (0) buildid: 20160804212522 builduid: 12fabcd8e57144588b832717041f2d82 revision: b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:17.327935) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:17.328485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-08-05 00:23:17.328821) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-08-05 00:23:20.838399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:20.839029) ========= 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=0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 00:23:21-- 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% 46.5M=0s 2016-08-05 00:23:21 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111022 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:20.993519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:20.993896) ========= 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=0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015679 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:21.099352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 00:23:21.099838) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb --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 b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb --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=0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 00:23:21,315 truncating revision to first 12 chars 2016-08-05 00:23:21,315 Setting DEBUG logging. 2016-08-05 00:23:21,315 attempt 1/10 2016-08-05 00:23:21,315 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b4ead0ffd25a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 00:23:22,068 unpacking tar archive at: mozilla-beta-b4ead0ffd25a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.081167 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 00:23:22.229154) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:22.233480) ========= script_repo_revision: b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:22.233881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:22.234150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:22.250849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-05 00:23:22.251191) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:23:22 INFO - MultiFileLogger online at 20160805 00:23:22 in /builds/slave/test 00:23:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 00:23:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:23:22 INFO - {'append_to_log': False, 00:23:22 INFO - 'base_work_dir': '/builds/slave/test', 00:23:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 00:23:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:23:22 INFO - 'branch': 'Mozilla-Beta', 00:23:22 INFO - 'buildbot_json_path': 'buildprops.json', 00:23:22 INFO - 'config_files': ('talos/linux_config.py',), 00:23:22 INFO - 'default_actions': ('clobber', 00:23:22 INFO - 'read-buildbot-config', 00:23:22 INFO - 'download-and-extract', 00:23:22 INFO - 'populate-webroot', 00:23:22 INFO - 'create-virtualenv', 00:23:22 INFO - 'install', 00:23:22 INFO - 'run-tests'), 00:23:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:23:22 INFO - 'download_minidump_stackwalk': True, 00:23:22 INFO - 'download_symbols': 'ondemand', 00:23:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:23:22 INFO - 'tooltool.py': '/tools/tooltool.py', 00:23:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:23:22 INFO - '/tools/misc-python/virtualenv.py')}, 00:23:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:23:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:23:22 INFO - 'installer_path': 'installer.exe', 00:23:22 INFO - 'log_level': 'info', 00:23:22 INFO - 'log_name': 'talos', 00:23:22 INFO - 'log_to_console': True, 00:23:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:23:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:23:22 INFO - 'opt_config_files': (), 00:23:22 INFO - 'pip_index': False, 00:23:22 INFO - 'sps_profile': False, 00:23:22 INFO - 'sps_profile_interval': 0, 00:23:22 INFO - 'suite': 'dromaeojs-e10s', 00:23:22 INFO - 'system_bits': '32', 00:23:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:23:22 INFO - 'title': 'talos-linux64-ix-017', 00:23:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:23:22 INFO - 'use_talos_json': True, 00:23:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:23:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:23:22 INFO - 'work_dir': 'build'} 00:23:22 INFO - ##### 00:23:22 INFO - ##### Running clobber step. 00:23:22 INFO - ##### 00:23:22 INFO - Running pre-action listener: _resource_record_pre_action 00:23:22 INFO - Running main action method: clobber 00:23:22 INFO - rmtree: /builds/slave/test/build 00:23:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:23:22 INFO - Running post-action listener: _resource_record_post_action 00:23:22 INFO - ##### 00:23:22 INFO - ##### Finished clobber step (success) 00:23:22 INFO - ##### 00:23:22 INFO - ##### 00:23:22 INFO - ##### Running read-buildbot-config step. 00:23:22 INFO - ##### 00:23:22 INFO - Running pre-action listener: _resource_record_pre_action 00:23:22 INFO - Running main action method: read_buildbot_config 00:23:22 INFO - Using buildbot properties: 00:23:22 INFO - { 00:23:22 INFO - "project": "", 00:23:22 INFO - "product": "firefox", 00:23:22 INFO - "script_repo_revision": "production", 00:23:22 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 00:23:22 INFO - "repository": "", 00:23:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 00:23:22 INFO - "buildid": "20160804212522", 00:23:22 INFO - "pgo_build": "True", 00:23:22 INFO - "basedir": "/builds/slave/test", 00:23:22 INFO - "buildnumber": 199, 00:23:22 INFO - "slavename": "talos-linux64-ix-017", 00:23:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:23:22 INFO - "platform": "ubuntu64_hw", 00:23:22 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 00:23:22 INFO - "branch": "mozilla-beta", 00:23:22 INFO - "repo_path": "releases/mozilla-beta", 00:23:22 INFO - "revision": "b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb", 00:23:22 INFO - "stage_platform": "linux64-pgo", 00:23:22 INFO - "builduid": "12fabcd8e57144588b832717041f2d82", 00:23:22 INFO - "slavebuilddir": "test" 00:23:22 INFO - } 00:23:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 00:23:22 INFO - Running post-action listener: _resource_record_post_action 00:23:22 INFO - ##### 00:23:22 INFO - ##### Finished read-buildbot-config step (success) 00:23:22 INFO - ##### 00:23:22 INFO - ##### 00:23:22 INFO - ##### Running download-and-extract step. 00:23:22 INFO - ##### 00:23:22 INFO - Running pre-action listener: _resource_record_pre_action 00:23:22 INFO - Running main action method: download_and_extract 00:23:22 INFO - mkdir: /builds/slave/test/build/tests 00:23:22 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')]} 00:23:22 INFO - https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:23:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 00:23:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 00:23:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 00:23:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:23:25 INFO - Downloaded 1327 bytes. 00:23:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 00:23:25 INFO - Using the following test package requirements: 00:23:25 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 00:23:25 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 00:23:25 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 00:23:25 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 00:23:25 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 00:23:25 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 00:23:25 INFO - u'jsshell-linux-x86_64.zip'], 00:23:25 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 00:23:25 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 00:23:25 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 00:23:25 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 00:23:25 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 00:23:25 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 00:23:25 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 00:23:25 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 00:23:25 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 00:23:25 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 00:23:25 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 00:23:25 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:25 INFO - https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:23:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 00:23:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 00:23:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 00:23:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:23:27 INFO - Downloaded 21968747 bytes. 00:23:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:23:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:23:28 INFO - Return code: 0 00:23:28 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:28 INFO - https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:23:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 00:23:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 00:23:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 00:23:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:23:36 INFO - Downloaded 21968747 bytes. 00:23:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:23:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:23:38 INFO - Return code: 0 00:23: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')]} 00:23:38 INFO - https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:23:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 00:23:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 00:23:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 00:23:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:23:38 INFO - Downloaded 10833369 bytes. 00:23:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:23:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:23:39 INFO - Return code: 0 00:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:39 INFO - https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:23:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 00:23:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 00:23:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 00:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:23:40 INFO - Downloaded 55300789 bytes. 00:23:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 00:23:40 INFO - mkdir: /builds/slave/test/properties 00:23:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:23:40 INFO - Writing to file /builds/slave/test/properties/build_url 00:23:40 INFO - Contents: 00:23:40 INFO - build_url:https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 00:23:41 INFO - Running post-action listener: _resource_record_post_action 00:23:41 INFO - Running post-action listener: set_extra_try_arguments 00:23:41 INFO - ##### 00:23:41 INFO - ##### Finished download-and-extract step (success) 00:23:41 INFO - ##### 00:23:41 INFO - ##### 00:23:41 INFO - ##### Running populate-webroot step. 00:23:41 INFO - ##### 00:23:41 INFO - Running pre-action listener: _resource_record_pre_action 00:23:41 INFO - Running main action method: populate_webroot 00:23:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:23:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:23:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:23:41 INFO - '--tppagecycles', 00:23:41 INFO - '7'], 00:23:41 INFO - 'tests': ['tsvgm']}}, 00:23:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:23:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:23:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:23:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:23:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:41 INFO - 'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:41 INFO - 'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['damp', 'tps']}, 00:23:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:41 INFO - 'tests': ['damp', 'tps']}, 00:23:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['dromaeo_dom']}, 00:23:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:23:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['a11yr', 00:23:41 INFO - 'ts_paint', 00:23:41 INFO - 'tpaint', 00:23:41 INFO - 'sessionrestore', 00:23:41 INFO - 'sessionrestore_no_auto_restore', 00:23:41 INFO - 'tabpaint']}, 00:23:41 INFO - 'other-e10s': {'tests': ['a11yr', 00:23:41 INFO - 'ts_paint', 00:23:41 INFO - 'tpaint', 00:23:41 INFO - 'sessionrestore', 00:23:41 INFO - 'sessionrestore_no_auto_restore', 00:23:41 INFO - 'tabpaint']}, 00:23:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:23:41 INFO - 'ts_paint', 00:23:41 INFO - 'tpaint', 00:23:41 INFO - 'sessionrestore', 00:23:41 INFO - 'sessionrestore_no_auto_restore', 00:23:41 INFO - 'tabpaint']}, 00:23:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:23:41 INFO - 'ts_paint', 00:23:41 INFO - 'tpaint', 00:23:41 INFO - 'sessionrestore', 00:23:41 INFO - 'sessionrestore_no_auto_restore', 00:23:41 INFO - 'tabpaint']}, 00:23:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['a11yr', 00:23:41 INFO - 'ts_paint', 00:23:41 INFO - 'tpaint', 00:23:41 INFO - 'sessionrestore', 00:23:41 INFO - 'sessionrestore_no_auto_restore', 00:23:41 INFO - 'tabpaint']}, 00:23:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['a11yr', 00:23:41 INFO - 'ts_paint', 00:23:41 INFO - 'tpaint', 00:23:41 INFO - 'sessionrestore', 00:23:41 INFO - 'sessionrestore_no_auto_restore', 00:23:41 INFO - 'tabpaint']}, 00:23:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['tsvgx', 00:23:41 INFO - 'tsvgr_opacity', 00:23:41 INFO - 'tart', 00:23:41 INFO - 'tscrollx', 00:23:41 INFO - 'cart']}, 00:23:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:23:41 INFO - 'tsvgr_opacity', 00:23:41 INFO - 'tart', 00:23:41 INFO - 'tscrollx', 00:23:41 INFO - 'cart']}, 00:23:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:41 INFO - 'talos_options': ['--disable-e10s'], 00:23:41 INFO - 'tests': ['tp5o']}, 00:23:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:41 INFO - 'tests': ['tp5o']}, 00:23:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:41 INFO - 'talos_options': ['--disable-e10s', 00:23:41 INFO - '--xperf_path', 00:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:41 INFO - 'tests': ['tp5n']}, 00:23:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:41 INFO - 'talos_options': ['--xperf_path', 00:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:41 INFO - 'tests': ['tp5n']}}, 00:23:41 INFO - 'talos.zip': {'path': '', 00:23:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:23:41 INFO - Running post-action listener: _resource_record_post_action 00:23:41 INFO - ##### 00:23:41 INFO - ##### Finished populate-webroot step (success) 00:23:41 INFO - ##### 00:23:41 INFO - ##### 00:23:41 INFO - ##### Running create-virtualenv step. 00:23:41 INFO - ##### 00:23:41 INFO - Running pre-action listener: _resource_record_pre_action 00:23:41 INFO - Running main action method: create_virtualenv 00:23:41 INFO - Creating virtualenv /builds/slave/test/build/venv 00:23:41 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 00:23:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:23:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:23:41 INFO - Using real prefix '/usr' 00:23:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:23:42 INFO - Installing distribute.............................................................................................................................................................................................done. 00:23:44 INFO - Installing pip.................done. 00:23:44 INFO - Return code: 0 00:23:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:23:44 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')]} 00:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:44 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')]} 00:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:44 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 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:23:44 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 00:23:44 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 00:23:44 INFO - Using env: {'DISPLAY': ':0', 00:23:44 INFO - 'HOME': '/home/cltbld', 00:23:44 INFO - 'LANG': 'en_US.UTF-8', 00:23:44 INFO - 'LANGUAGE': 'en_US:en', 00:23:44 INFO - 'LOGNAME': 'cltbld', 00:23:44 INFO - 'MAIL': '/var/mail/cltbld', 00:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:44 INFO - 'MOZ_NO_REMOTE': '1', 00:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:44 INFO - 'NO_EM_RESTART': '1', 00:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:44 INFO - 'PWD': '/builds/slave/test', 00:23:44 INFO - 'SHELL': '/bin/bash', 00:23:44 INFO - 'SHLVL': '1', 00:23:44 INFO - 'TERM': 'linux', 00:23:44 INFO - 'TMOUT': '86400', 00:23:44 INFO - 'USER': 'cltbld', 00:23:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:44 INFO - '_': '/tools/buildbot/bin/python'} 00:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:44 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 00:23:44 INFO - Cleaning up... 00:23:44 INFO - Return code: 0 00:23:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:23:44 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')]} 00:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:44 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')]} 00:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:23:44 INFO - Using env: {'DISPLAY': ':0', 00:23:44 INFO - 'HOME': '/home/cltbld', 00:23:44 INFO - 'LANG': 'en_US.UTF-8', 00:23:44 INFO - 'LANGUAGE': 'en_US:en', 00:23:44 INFO - 'LOGNAME': 'cltbld', 00:23:44 INFO - 'MAIL': '/var/mail/cltbld', 00:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:44 INFO - 'MOZ_NO_REMOTE': '1', 00:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:44 INFO - 'NO_EM_RESTART': '1', 00:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:44 INFO - 'PWD': '/builds/slave/test', 00:23:44 INFO - 'SHELL': '/bin/bash', 00:23:44 INFO - 'SHLVL': '1', 00:23:44 INFO - 'TERM': 'linux', 00:23:44 INFO - 'TMOUT': '86400', 00:23:44 INFO - 'USER': 'cltbld', 00:23:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:44 INFO - '_': '/tools/buildbot/bin/python'} 00:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:44 INFO - Downloading/unpacking psutil>=3.1.1 00:23:44 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 00:23:44 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 00:23:44 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 00:23:44 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 00:23:44 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 00:23:44 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 00:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:46 INFO - Installing collected packages: psutil 00:23:46 INFO - Running setup.py install for psutil 00:23:46 INFO - building 'psutil._psutil_linux' extension 00:23:46 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 00:23:46 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 00:23:46 INFO - building 'psutil._psutil_posix' extension 00:23:46 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 00:23:46 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 00:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:46 INFO - Successfully installed psutil 00:23:46 INFO - Cleaning up... 00:23:47 INFO - Return code: 0 00:23:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:23:47 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')]} 00:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:47 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')]} 00:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:23:47 INFO - Using env: {'DISPLAY': ':0', 00:23:47 INFO - 'HOME': '/home/cltbld', 00:23:47 INFO - 'LANG': 'en_US.UTF-8', 00:23:47 INFO - 'LANGUAGE': 'en_US:en', 00:23:47 INFO - 'LOGNAME': 'cltbld', 00:23:47 INFO - 'MAIL': '/var/mail/cltbld', 00:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:47 INFO - 'MOZ_NO_REMOTE': '1', 00:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:47 INFO - 'NO_EM_RESTART': '1', 00:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:47 INFO - 'PWD': '/builds/slave/test', 00:23:47 INFO - 'SHELL': '/bin/bash', 00:23:47 INFO - 'SHLVL': '1', 00:23:47 INFO - 'TERM': 'linux', 00:23:47 INFO - 'TMOUT': '86400', 00:23:47 INFO - 'USER': 'cltbld', 00:23:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:47 INFO - '_': '/tools/buildbot/bin/python'} 00:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:23:47 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 00:23:47 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 00:23:47 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 00:23:47 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 00:23:47 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 00:23:47 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 00:23:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:23:49 INFO - Installing collected packages: mozsystemmonitor 00:23:49 INFO - Running setup.py install for mozsystemmonitor 00:23:49 INFO - Successfully installed mozsystemmonitor 00:23:49 INFO - Cleaning up... 00:23:49 INFO - Return code: 0 00:23:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:23:49 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')]} 00:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:49 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')]} 00:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:23:49 INFO - Using env: {'DISPLAY': ':0', 00:23:49 INFO - 'HOME': '/home/cltbld', 00:23:49 INFO - 'LANG': 'en_US.UTF-8', 00:23:49 INFO - 'LANGUAGE': 'en_US:en', 00:23:49 INFO - 'LOGNAME': 'cltbld', 00:23:49 INFO - 'MAIL': '/var/mail/cltbld', 00:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:49 INFO - 'MOZ_NO_REMOTE': '1', 00:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:49 INFO - 'NO_EM_RESTART': '1', 00:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:49 INFO - 'PWD': '/builds/slave/test', 00:23:49 INFO - 'SHELL': '/bin/bash', 00:23:49 INFO - 'SHLVL': '1', 00:23:49 INFO - 'TERM': 'linux', 00:23:49 INFO - 'TMOUT': '86400', 00:23:49 INFO - 'USER': 'cltbld', 00:23:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:49 INFO - '_': '/tools/buildbot/bin/python'} 00:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:49 INFO - Downloading/unpacking jsonschema==2.5.1 00:23:49 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 00:23:49 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 00:23:49 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 00:23:49 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 00:23:49 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 00:23:49 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 00:23:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:23:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:23:51 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 00:23:51 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 00:23:51 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 00:23:51 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 00:23:51 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 00:23:51 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 00:23:51 INFO - Downloading functools32-3.2.3-2.tar.gz 00:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:23:51 INFO - warning: no files found matching '*.txt' 00:23:51 INFO - no previously-included directories found matching 'build' 00:23:51 INFO - no previously-included directories found matching 'dist' 00:23:51 INFO - no previously-included directories found matching '.git*' 00:23:51 INFO - Installing collected packages: jsonschema, functools32 00:23:51 INFO - Running setup.py install for functools32 00:23:51 INFO - warning: no files found matching '*.txt' 00:23:51 INFO - no previously-included directories found matching 'build' 00:23:51 INFO - no previously-included directories found matching 'dist' 00:23:51 INFO - no previously-included directories found matching '.git*' 00:23:51 INFO - Successfully installed jsonschema functools32 00:23:51 INFO - Cleaning up... 00:23:51 INFO - Return code: 0 00:23:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:23:51 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')]} 00:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:51 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')]} 00:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:51 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 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:23:51 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 00:23:51 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 00:23:51 INFO - Using env: {'DISPLAY': ':0', 00:23:51 INFO - 'HOME': '/home/cltbld', 00:23:51 INFO - 'LANG': 'en_US.UTF-8', 00:23:51 INFO - 'LANGUAGE': 'en_US:en', 00:23:51 INFO - 'LOGNAME': 'cltbld', 00:23:51 INFO - 'MAIL': '/var/mail/cltbld', 00:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:51 INFO - 'MOZ_NO_REMOTE': '1', 00:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:51 INFO - 'NO_EM_RESTART': '1', 00:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:51 INFO - 'PWD': '/builds/slave/test', 00:23:51 INFO - 'SHELL': '/bin/bash', 00:23:51 INFO - 'SHLVL': '1', 00:23:51 INFO - 'TERM': 'linux', 00:23:51 INFO - 'TMOUT': '86400', 00:23:51 INFO - 'USER': 'cltbld', 00:23:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:51 INFO - '_': '/tools/buildbot/bin/python'} 00:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:52 INFO - Downloading/unpacking blobuploader==1.2.4 00:23:52 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 00:23:52 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 00:23:52 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 00:23:52 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 00:23:52 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 00:23:52 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 00:23:53 INFO - Downloading blobuploader-1.2.4.tar.gz 00:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:23:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:23:53 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 00:23:53 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 00:23:53 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 00:23:53 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 00:23:53 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 00:23:53 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 00:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:23:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:23:54 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 00:23:54 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 00:23:54 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 00:23:54 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 00:23:54 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 00:23:54 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 00:23:54 INFO - Downloading docopt-0.6.1.tar.gz 00:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:23:54 INFO - Installing collected packages: blobuploader, requests, docopt 00:23:54 INFO - Running setup.py install for blobuploader 00:23:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:23:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:23:54 INFO - Running setup.py install for requests 00:23:55 INFO - Running setup.py install for docopt 00:23:55 INFO - Successfully installed blobuploader requests docopt 00:23:55 INFO - Cleaning up... 00:23:55 INFO - Return code: 0 00:23:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23: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')]} 00:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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')]} 00:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:55 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 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:23:55 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 00:23:55 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 00:23:55 INFO - Using env: {'DISPLAY': ':0', 00:23:55 INFO - 'HOME': '/home/cltbld', 00:23:55 INFO - 'LANG': 'en_US.UTF-8', 00:23:55 INFO - 'LANGUAGE': 'en_US:en', 00:23:55 INFO - 'LOGNAME': 'cltbld', 00:23:55 INFO - 'MAIL': '/var/mail/cltbld', 00:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:55 INFO - 'MOZ_NO_REMOTE': '1', 00:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:55 INFO - 'NO_EM_RESTART': '1', 00:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:55 INFO - 'PWD': '/builds/slave/test', 00:23:55 INFO - 'SHELL': '/bin/bash', 00:23:55 INFO - 'SHLVL': '1', 00:23:55 INFO - 'TERM': 'linux', 00:23:55 INFO - 'TMOUT': '86400', 00:23:55 INFO - 'USER': 'cltbld', 00:23:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:55 INFO - '_': '/tools/buildbot/bin/python'} 00:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:55 INFO - Running setup.py (path:/tmp/pip-5JyGIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:55 INFO - Running setup.py (path:/tmp/pip-2zFSVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:55 INFO - Running setup.py (path:/tmp/pip-ex43Is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:55 INFO - Running setup.py (path:/tmp/pip-eVW5Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:55 INFO - Running setup.py (path:/tmp/pip-I6H2MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:55 INFO - Running setup.py (path:/tmp/pip-EZ2_9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:55 INFO - Running setup.py (path:/tmp/pip-AJCO9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:56 INFO - Running setup.py (path:/tmp/pip-LeQ56Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:56 INFO - Running setup.py (path:/tmp/pip-cZe7rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:56 INFO - Running setup.py (path:/tmp/pip-mV5QWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:56 INFO - Running setup.py (path:/tmp/pip-a6lTNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:56 INFO - Running setup.py (path:/tmp/pip-KbM4_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:56 INFO - Running setup.py (path:/tmp/pip-4MqAGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:56 INFO - Running setup.py (path:/tmp/pip-G5ngTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:56 INFO - Running setup.py (path:/tmp/pip-N51eu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:56 INFO - Running setup.py (path:/tmp/pip-V77lgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:56 INFO - Running setup.py (path:/tmp/pip-YB74pM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:23:56 INFO - Running setup.py install for manifestparser 00:23:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:23:56 INFO - Running setup.py install for mozcrash 00:23:56 INFO - Running setup.py install for mozdebug 00:23:57 INFO - Running setup.py install for mozdevice 00:23:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Running setup.py install for mozfile 00:23:57 INFO - Running setup.py install for mozhttpd 00:23:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Running setup.py install for mozinfo 00:23:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Running setup.py install for mozInstall 00:23:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Running setup.py install for mozleak 00:23:57 INFO - Running setup.py install for mozlog 00:23:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Running setup.py install for moznetwork 00:23:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:23:57 INFO - Running setup.py install for mozprocess 00:23:57 INFO - Running setup.py install for mozprofile 00:23:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Running setup.py install for mozrunner 00:23:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Running setup.py install for mozscreenshot 00:23:58 INFO - Running setup.py install for moztest 00:23:58 INFO - Running setup.py install for mozversion 00:23:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:23:58 INFO - Cleaning up... 00:23:58 INFO - Return code: 0 00:23:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23: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')]} 00:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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')]} 00:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:58 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 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:23:58 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 00:23:58 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 00:23:58 INFO - Using env: {'DISPLAY': ':0', 00:23:58 INFO - 'HOME': '/home/cltbld', 00:23:58 INFO - 'LANG': 'en_US.UTF-8', 00:23:58 INFO - 'LANGUAGE': 'en_US:en', 00:23:58 INFO - 'LOGNAME': 'cltbld', 00:23:58 INFO - 'MAIL': '/var/mail/cltbld', 00:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:58 INFO - 'MOZ_NO_REMOTE': '1', 00:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:58 INFO - 'NO_EM_RESTART': '1', 00:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:58 INFO - 'PWD': '/builds/slave/test', 00:23:58 INFO - 'SHELL': '/bin/bash', 00:23:58 INFO - 'SHLVL': '1', 00:23:58 INFO - 'TERM': 'linux', 00:23:58 INFO - 'TMOUT': '86400', 00:23:58 INFO - 'USER': 'cltbld', 00:23:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:58 INFO - '_': '/tools/buildbot/bin/python'} 00:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:58 INFO - Running setup.py (path:/tmp/pip-Jwll_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:58 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)) 00:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:58 INFO - Running setup.py (path:/tmp/pip-XhUUh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:58 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)) 00:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:58 INFO - Running setup.py (path:/tmp/pip-77Trbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:58 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)) 00:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:58 INFO - Running setup.py (path:/tmp/pip-AwOw8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:59 INFO - Running setup.py (path:/tmp/pip-OwzWlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:59 INFO - Running setup.py (path:/tmp/pip-L2TUx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:59 INFO - Running setup.py (path:/tmp/pip-LHq5EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:59 INFO - Running setup.py (path:/tmp/pip-IjVScF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:59 INFO - Running setup.py (path:/tmp/pip-fB0iyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:59 INFO - Running setup.py (path:/tmp/pip-vOLzpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:59 INFO - Running setup.py (path:/tmp/pip-UG7XmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:59 INFO - Running setup.py (path:/tmp/pip-izvY3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:59 INFO - Running setup.py (path:/tmp/pip-gBaAGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:59 INFO - Running setup.py (path:/tmp/pip-WfoTbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:59 INFO - Running setup.py (path:/tmp/pip-Bl6738-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:59 INFO - Running setup.py (path:/tmp/pip-Q8hhBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:59 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)) 00:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:59 INFO - Running setup.py (path:/tmp/pip-cxOaSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:59 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)) 00:23:59 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)) 00:23:59 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)) 00:23:59 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)) 00:23:59 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)) 00:23:59 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)) 00:23:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:23:59 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 00:23:59 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 00:23:59 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 00:23:59 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 00:23:59 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 00:23:59 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 00:24:01 INFO - Downloading blessings-1.6.tar.gz 00:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:24:01 INFO - Installing collected packages: blessings 00:24:01 INFO - Running setup.py install for blessings 00:24:02 INFO - Successfully installed blessings 00:24:02 INFO - Cleaning up... 00:24:02 INFO - Return code: 0 00:24:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:24:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:24:02 INFO - Reading from file tmpfile_stdout 00:24:02 INFO - Current package versions: 00:24:02 INFO - argparse == 1.2.1 00:24:02 INFO - blessings == 1.6 00:24:02 INFO - blobuploader == 1.2.4 00:24:02 INFO - docopt == 0.6.1 00:24:02 INFO - functools32 == 3.2.3-2 00:24:02 INFO - jsonschema == 2.5.1 00:24:02 INFO - manifestparser == 1.1 00:24:02 INFO - mozInstall == 1.12 00:24:02 INFO - mozcrash == 0.17 00:24:02 INFO - mozdebug == 0.1 00:24:02 INFO - mozdevice == 0.48 00:24:02 INFO - mozfile == 1.2 00:24:02 INFO - mozhttpd == 0.7 00:24:02 INFO - mozinfo == 0.9 00:24:02 INFO - mozleak == 0.1 00:24:02 INFO - mozlog == 3.2 00:24:02 INFO - moznetwork == 0.27 00:24:02 INFO - mozprocess == 0.23 00:24:02 INFO - mozprofile == 0.28 00:24:02 INFO - mozrunner == 6.12 00:24:02 INFO - mozscreenshot == 0.1 00:24:02 INFO - mozsystemmonitor == 0.3 00:24:02 INFO - moztest == 0.7 00:24:02 INFO - mozversion == 1.4 00:24:02 INFO - psutil == 3.1.1 00:24:02 INFO - requests == 1.2.3 00:24:02 INFO - wsgiref == 0.1.2 00:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:24:02 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')]} 00:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:02 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')]} 00:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:02 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 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:24:02 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 00:24:02 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 00:24:02 INFO - Using env: {'DISPLAY': ':0', 00:24:02 INFO - 'HOME': '/home/cltbld', 00:24:02 INFO - 'LANG': 'en_US.UTF-8', 00:24:02 INFO - 'LANGUAGE': 'en_US:en', 00:24:02 INFO - 'LOGNAME': 'cltbld', 00:24:02 INFO - 'MAIL': '/var/mail/cltbld', 00:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:02 INFO - 'MOZ_NO_REMOTE': '1', 00:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:02 INFO - 'NO_EM_RESTART': '1', 00:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:02 INFO - 'PWD': '/builds/slave/test', 00:24:02 INFO - 'SHELL': '/bin/bash', 00:24:02 INFO - 'SHLVL': '1', 00:24:02 INFO - 'TERM': 'linux', 00:24:02 INFO - 'TMOUT': '86400', 00:24:02 INFO - 'USER': 'cltbld', 00:24:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:02 INFO - '_': '/tools/buildbot/bin/python'} 00:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:02 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)) 00:24:02 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)) 00:24:02 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)) 00:24:02 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)) 00:24:02 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)) 00:24:02 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)) 00:24:02 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)) 00:24:02 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)) 00:24:02 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)) 00:24:02 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)) 00:24:02 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)) 00:24:02 INFO - Cleaning up... 00:24:02 INFO - Return code: 0 00:24:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:24:02 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')]} 00:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:02 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')]} 00:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:02 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 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:24:02 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 00:24:02 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 00:24:02 INFO - Using env: {'DISPLAY': ':0', 00:24:02 INFO - 'HOME': '/home/cltbld', 00:24:02 INFO - 'LANG': 'en_US.UTF-8', 00:24:02 INFO - 'LANGUAGE': 'en_US:en', 00:24:02 INFO - 'LOGNAME': 'cltbld', 00:24:02 INFO - 'MAIL': '/var/mail/cltbld', 00:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:02 INFO - 'MOZ_NO_REMOTE': '1', 00:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:02 INFO - 'NO_EM_RESTART': '1', 00:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:02 INFO - 'PWD': '/builds/slave/test', 00:24:02 INFO - 'SHELL': '/bin/bash', 00:24:02 INFO - 'SHLVL': '1', 00:24:02 INFO - 'TERM': 'linux', 00:24:02 INFO - 'TMOUT': '86400', 00:24:02 INFO - 'USER': 'cltbld', 00:24:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:02 INFO - '_': '/tools/buildbot/bin/python'} 00:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:24:02 INFO - Cleaning up... 00:24:02 INFO - Return code: 0 00:24:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:24:02 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')]} 00:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:02 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')]} 00:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:02 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 0x7f76090c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, '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': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', '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 00:24:02 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 00:24:02 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 00:24:02 INFO - Using env: {'DISPLAY': ':0', 00:24:02 INFO - 'HOME': '/home/cltbld', 00:24:02 INFO - 'LANG': 'en_US.UTF-8', 00:24:02 INFO - 'LANGUAGE': 'en_US:en', 00:24:02 INFO - 'LOGNAME': 'cltbld', 00:24:02 INFO - 'MAIL': '/var/mail/cltbld', 00:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:02 INFO - 'MOZ_NO_REMOTE': '1', 00:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:02 INFO - 'NO_EM_RESTART': '1', 00:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:02 INFO - 'PWD': '/builds/slave/test', 00:24:02 INFO - 'SHELL': '/bin/bash', 00:24:02 INFO - 'SHLVL': '1', 00:24:02 INFO - 'TERM': 'linux', 00:24:02 INFO - 'TMOUT': '86400', 00:24:02 INFO - 'USER': 'cltbld', 00:24:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:02 INFO - '_': '/tools/buildbot/bin/python'} 00:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:02 INFO - Downloading/unpacking flake8 00:24:02 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 00:24:02 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 00:24:02 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 00:24:02 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 00:24:02 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 00:24:02 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 00:24:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:24:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:24:04 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 00:24:04 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 00:24:04 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 00:24:04 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 00:24:04 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 00:24:04 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 00:24:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:24:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:24:05 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 00:24:05 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 00:24:05 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 00:24:05 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 00:24:05 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 00:24:05 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 00:24:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:24:05 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 00:24:05 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 00:24:05 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 00:24:05 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 00:24:05 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 00:24:05 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 00:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:24:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:24:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:24:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:24:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:24:05 INFO - no previously-included directories found matching 'docs/_build' 00:24:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:24:05 INFO - Running setup.py install for pep8 00:24:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:24:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:24:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:24:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:24:05 INFO - no previously-included directories found matching 'docs/_build' 00:24:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:24:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:24:05 INFO - Cleaning up... 00:24:05 INFO - Return code: 0 00:24:05 INFO - Running post-action listener: _resource_record_post_action 00:24:05 INFO - Running post-action listener: _start_resource_monitoring 00:24:05 INFO - Starting resource monitoring. 00:24:05 INFO - ##### 00:24:05 INFO - ##### Finished create-virtualenv step (success) 00:24:05 INFO - ##### 00:24:05 INFO - ##### 00:24:05 INFO - ##### Running install step. 00:24:05 INFO - ##### 00:24:05 INFO - Running pre-action listener: _resource_record_pre_action 00:24:05 INFO - Running main action method: install 00:24:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:24:06 INFO - Reading from file tmpfile_stdout 00:24:06 INFO - Detecting whether we're running mozinstall >=1.0... 00:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:24:06 INFO - Reading from file tmpfile_stdout 00:24:06 INFO - Output received: 00:24:06 INFO - Usage: mozinstall [options] installer 00:24:06 INFO - Options: 00:24:06 INFO - -h, --help show this help message and exit 00:24:06 INFO - -d DEST, --destination=DEST 00:24:06 INFO - Directory to install application into. [default: 00:24:06 INFO - "/builds/slave/test"] 00:24:06 INFO - --app=APP Application being installed. [default: firefox] 00:24:06 INFO - mkdir: /builds/slave/test/build/application 00:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:24:19 INFO - Reading from file tmpfile_stdout 00:24:19 INFO - Output received: 00:24:19 INFO - /builds/slave/test/build/application/firefox/firefox 00:24:19 INFO - Running post-action listener: _resource_record_post_action 00:24:19 INFO - ##### 00:24:19 INFO - ##### Finished install step (success) 00:24:19 INFO - ##### 00:24:19 INFO - ##### 00:24:19 INFO - ##### Running run-tests step. 00:24:19 INFO - ##### 00:24:19 INFO - Running pre-action listener: _resource_record_pre_action 00:24:19 INFO - Running main action method: run_tests 00:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:24:19 INFO - Python 2.7.3 00:24:19 INFO - Return code: 0 00:24:19 INFO - grabbing minidump binary from tooltool 00:24:19 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')]} 00:24:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd62e0>, '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 0xf42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf425d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:24:19 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 00:24:19 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 00:24:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:24:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:24:19 INFO - Return code: 0 00:24:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:24:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:24:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:24:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:24:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:24:20 INFO - Return code: 0 00:24:20 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:24:20 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:24:20 INFO - Using env: {'DISPLAY': ':0', 00:24:20 INFO - 'HOME': '/home/cltbld', 00:24:20 INFO - 'LANG': 'en_US.UTF-8', 00:24:20 INFO - 'LANGUAGE': 'en_US:en', 00:24:20 INFO - 'LOGNAME': 'cltbld', 00:24:20 INFO - 'MAIL': '/var/mail/cltbld', 00:24:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:24:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:20 INFO - 'MOZ_NO_REMOTE': '1', 00:24:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:20 INFO - 'NO_EM_RESTART': '1', 00:24:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:20 INFO - 'PWD': '/builds/slave/test', 00:24:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:24:20 INFO - 'SHELL': '/bin/bash', 00:24:20 INFO - 'SHLVL': '1', 00:24:20 INFO - 'TERM': 'linux', 00:24:20 INFO - 'TMOUT': '86400', 00:24:20 INFO - 'USER': 'cltbld', 00:24:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782', 00:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:20 INFO - '_': '/tools/buildbot/bin/python'} 00:24:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:24:20 INFO - mozversion application_buildid: 20160804212522 00:24:20 INFO - mozversion application_changeset: b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb 00:24:20 INFO - mozversion application_display_name: Firefox 00:24:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:24:20 INFO - mozversion application_name: Firefox 00:24:20 INFO - mozversion application_remotingname: firefox 00:24:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:24:20 INFO - mozversion application_vendor: Mozilla 00:24:20 INFO - mozversion application_version: 49.0 00:24:20 INFO - mozversion platform_buildid: 20160804212522 00:24:20 INFO - mozversion platform_changeset: b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb 00:24:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:24:20 INFO - mozversion platform_version: 49.0 00:24:20 INFO - using testdate: 1470381860 00:24:20 INFO - actual date: 1470381860 00:24:20 INFO - starting webserver on 'localhost:45552' 00:24:20 INFO - SUITE-START | Running 2 tests 00:24:20 INFO - TEST-START | dromaeo_css 00:24:20 INFO - operating with platform_type : linux_ 00:24:20 INFO - Initialising browser for dromaeo_css test... 00:24:20 INFO - TEST-INFO | started process 21240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFWFsh/profile http://localhost:45552/getInfo.html) 00:24:24 INFO - PROCESS | 21240 | __metrics Screen width/height:1600/1200 00:24:24 INFO - PROCESS | 21240 | colorDepth:24 00:24:24 INFO - PROCESS | 21240 | Browser inner width/height: 1024/697 00:24:24 INFO - PROCESS | 21240 | __metrics 00:24:25 ERROR - PROCESS | 21240 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 00:24:26 INFO - TEST-INFO | 21240: exit 0 00:24:26 INFO - Browser initialized. 00:24:26 INFO - Running cycle 1/1 for dromaeo_css test... 00:24:26 INFO - TEST-INFO | started process 21366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFWFsh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:37 INFO - PROCESS | 21366 | RSS: Main: 152887296 00:24:37 INFO - PROCESS | 21366 | 00:25:27 INFO - PROCESS | 21366 | 1470381927534 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] 00:27:35 INFO - PROCESS | 21366 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45552/tests/dromaeo/cssquery-ext.html) 00:27:36 INFO - PROCESS | 21366 | RSS: Main: 155725824 00:27:36 INFO - PROCESS | 21366 | 00:30:38 INFO - PROCESS | 21366 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-ext.html (next: http://localhost:45552/tests/dromaeo/cssquery-jquery.html) 00:30:39 INFO - PROCESS | 21366 | RSS: Main: 154517504 00:30:39 INFO - PROCESS | 21366 | 00:33:40 INFO - PROCESS | 21366 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45552/tests/dromaeo/cssquery-mootools.html) 00:33:41 INFO - PROCESS | 21366 | RSS: Main: 153153536 00:33:41 INFO - PROCESS | 21366 | 00:36:43 INFO - PROCESS | 21366 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45552/tests/dromaeo/cssquery-prototype.html) 00:36:43 INFO - PROCESS | 21366 | RSS: Main: 155414528 00:36:43 INFO - PROCESS | 21366 | 00:39:46 INFO - PROCESS | 21366 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45552/tests/dromaeo/cssquery-yui.html) 00:39:46 INFO - PROCESS | 21366 | RSS: Main: 153972736 00:39:46 INFO - PROCESS | 21366 | 00:42:49 INFO - PROCESS | 21366 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-yui.html (next: http://localhost:45552/tests/dromaeo/cssquery-dojo.html) 00:42:49 INFO - PROCESS | 21366 | RSS: Main: 155529216 00:42:49 INFO - PROCESS | 21366 | 00:42:49 INFO - PROCESS | 21366 | __start_tp_report 00:42:49 INFO - PROCESS | 21366 | _x_x_mozilla_page_load 00:42:49 INFO - PROCESS | 21366 | _x_x_mozilla_page_load_details 00:42:49 INFO - PROCESS | 21366 | |i|pagename|runs| 00:42:49 INFO - PROCESS | 21366 | |0;dojo.html;3378.223008707999;3424.503447000185;3443.6728510791468;3453.08493249289;3458.948115778264;5623.072193088141;5643.463870932265;5645.520130788883;5698.059820129673;5713.914291285634;5692.060809966361;5768.855778605537;5770.538356931446;5778.711064446782;5782.653040817554;5031.295618613397;5071.594272458213;5112.590992720592;5149.253358263049;5167.044096842077;5092.872678183038;5094.083065048289;5160.303359046537;5175.378954525462;5177.456367081459;5134.768935397916;5147.639665223436;5149.639525233235;5155.639105262614;5193.039287731763;5152.639315247934;5224.242484839677;5236.319278493809;5239.73801309933;5263.02634012705;5016.849494515171;5070.873228169288;5154.046501397253;5188.195829646411;5208.7916483341;5422.972885135549;5487.039768040617;5496.725163741797;5602.38373778884;5611.354694210137;6063.242094738158;6082;6087.2086628738425;6106.358832322587;6107.328193898667;6129.693515324216;6140.662263575501;6142.96928515359;6150.8769824603705;6178.227721534809;5673.489385955284;5691.573132015074;5713.257276554063;5752.280964879348;5816.098504731774;6317.715702793385;6325.209348831396;6327.715252813635;6333.398327158912;6337.42963133311;5958.582899197101;6045.142101127036;6082.239720034996;6105.450509454082;6110.327863934964;6091.02543593023;6175.413335733098;6177.351378105234;6177.81466556004;6179.907301390483;6082.148499210114;6085.695715214221;6106.419890110521;6118.265808103056;6125.203723516003;5962.19510366095;5993.61041532299;6025;6129.785457508966;6138.570300078952;4636.8145274188655;4653.23221668421;4654.4414670239785;4658.790354434059;4666.95333046672;4161.0845613964875;4167.4790651168605;4170.291050521419;4180.581941805795;4201.852935147255;5817.214676018683;5833.270841144857;5890.587658863838;5894.970525147347;5912.379200184005;6005.759769609254;6055.2128223331565;6094.421030002142;6113.358097399798;6126.846828829315;5923.437273459014;5924.674142922095;5926.4666180044005;5927.585069045212;5943.762249510058;5196.740162991835;5215;5239.869003274948;5258.684478931276;5265.315508983884;6311.33730958252;6317.778877739257;6341.714622841983;6362.554621176473;6382.425581697669;6163.9383606163365;6171.321154672893;6178.382161783786;6180.969095154675;6192.442680158807;6150.415710507495;6163.8150855474405;6194.969025154845;6220.533459990428;6368;6041.154238406539;6061.605995610447;6072.939270607238;6094.847628809138;6100.450959413674;5978.611390259619;6122.957105438777;6148.907766383419;6163.229596300463;6165.691715414122;5893.292804863444;5921.940780592311;5948.315943666534;5996.310424301261;6012.218411606463;5979;5989.730462129128;6020.307664618625;6023.096535519707;6040.456358927542;5720.11338242573;5775.9133612995;5830.950428922834;5908.556858235564;5916.585838991229;5965.254343207099;6016.669083200466;6049.334573196857;6050.969745151246;6073.362296958756;5886.470217680429;5895.233619629421;5897.144913987534;5900.498457631149;5903.7048147593305 00:42:49 INFO - PROCESS | 21366 | |1;ext.html;594.9107633854921;638.3456956619461;640.3372509452715;654.9618854116226;656.4420242793623;46794.53205467945;48385.27422088667;48478.51521484784;48624.75687621557;51299.74350128254;48720.51279487204;48771.26843097356;49181.01637967239;49269.753651231695;49515.00969980598;9064.728058158233;9108.362414630978;9179.770505737342;9243.953780231122;9250.121238482367;9053.09469053096;9085.227755640746;9107.908920910806;9123.133302336268;9150.908490915106;9114.817703645956;9160.17558419742;9190.21883139934;9191.770205744842;9200.171984521392;9047.411918225294;9092.454452732823;9119.954400227989;9129.452232866017;9139.862902056475;8931.687390941352;8969;8979.955100224523;8987.775305617346;9007.909920900773;46179.53820461786;46563.53436465626;46644.06711865744;46690.53309466896;46714.299285510744;3962.980185099056;3993.4409182714444;4045.3527435610454;4213.9578604214175;4378.934315985262;35153.82423087868;35342.646573534446;35411.82294088513;35515.28969420623;35935.64064359349;4708.474356609829;4722.1736196165875;4776.188048031843;4831.830885918976;4841.515172598854;250779;251369;251400.74299628567;251634;252774;64963;64981.67509162424;65044.67477662581;65195;65491;39970.800145999085;40950.38574421386;41038.179236415104;42689.786551067045;68202.63594728078;19692.70460943087;19789.505262368268;19838.801611983694;19887.502812429804;19970.70043949342;13864.722705545833;13930.791038134435;14015.719685606231;14035.087719298213;14039;21288.680669789966;21320.466988325104;21328.893355533433;21359;21385.25151619686;7379.262073792685;7409.184989651134;7624.733134340271;7637.15991240963;7668.855769134628;1069.561479793281;1082.837574363836;1117.4412793603199;1134.432783608196;1190.3334132885611;33434.832825835714;33468.66531334655;33571.992840214836;33839.49240761391;34656.65343346585;1150.3098141115431;1211.8727533609022;1248.1387842388722;1251.5181655062866;1282.9166104203198;17220.741688874677;18042.63914721698;18130.365437209635;18516;19450.805491945182;661873;669129;701146;984966;1008127;59973.40026599678;60296.39703602908;60744.696276518334;60793.39206607966;60822.39177608256;1488.0550850210195;1502.7445334292977;1510.5015344936364;1513.7956375889335;1519.4529969211076;31394.686053139176;32107;32486.675133248365;32806.83596582002;32934.176645583095;52150.73924630504;52242.47757522528;52981.47018529765;52996;53044.73477632587;420327;422043;423136;423239;425521;28822.42355152927;29084.12747617575;29113.85443072771;29124;32896.83551582227;52905.47094529006;53302.73348633232;54137.72931135319;54149.18776218281;54237.18644220261;44909.775451122536;45671.77164114158;45726.31410528778;46827;47226.76386618045;43764.56235437605;44048;44505.33242001308;44910.10179796451;45115;44193.33709994417;44271.77864110659;44542;45599.77200113978;45670.771646141555;38293.4255986166;38911.80544097262;38996.415053774785;39988.60011399965;40017.19965600614;28871.5669264957;29735.702642973294;29915.401691966475;29969.400611988076;30340.393192136475 00:42:49 INFO - PROCESS | 21366 | |2;jquery.html;430.89260600257353;434.43740356238675;436.33458975063024;439.200654808249;439.84605388114164;18547.35084272051;19646.312379066716;20430.489237769063;20463.18147274111;20569;19468.805311946875;19847.801521984813;19886.801131988675;20920;21058.368248952516;5635.99999999999;5816.854578635547;5823.650580965134;5853.239078919734;5870.706464676749;5596.132599447072;5736.770529178828;5766.077427611583;5790.334111577159;5840.766369345221;5649.265595472582;5649.548036157118;5658.151277308396;5745.482906538411;5773.9422605773825;5586.13414920686;5690.2033715279895;5724.141378793172;5867.119932010232;5892.528597712216;5653.208550802891;5750.424957504258;5753.712314384264;5760.279965004374;5984.3417224105315;22432.77567224323;22788.886055569783;22858;23646.054157833667;24044.15845445401;2458.6557881896547;2507.0974449198275;2519.533886231053;2528.557502437066;2549.5920652695663;10845.891541084646;10965.945170274177;11017.394043327613;11159.442027898654;11160.330380177214;2024.4028011736425;2122.4906022554474;2143.710599069137;2162.5566758814407;2200.339898030584;59850;65356;74889.25110748877;75726.59230334593;79419.6029019857;11209.439528023566;11327.546898123983;11794.351310677823;11850.348230847387;12032.097592680584;16170.59573510648;16293;16342.836571634369;16369.754453683205;16605.6678866422;8663.696770612998;8947.955260223658;8981.775455613662;9022.278217742565;9093.772655683528;8766.167214114648;8916.420432671985;8927.151920567536;8939.016708162097;8952.910470895338;4888.6577939543895;4914.140025495595;4924.433690125681;4977.676451030671;5001.399272378343;2102.863313884623;2121.2045482943895;2129.3186180422117;2144.1316266911927;2157.557700671359;978.8629591857145;1050.0549505445008;1069.0378659206622;1073.350622873166;1089.9972025736342;19154.904225478782;19905.502362441053;20167.294144704865;20237.79762202359;20261.189552417738;1024.779672370444;1035.7048241251357;1041.6770801051546;1065.0787069185099;1074.3875990685235;11110.50002749862;11408.94295528517;11460.140489463323;11472.713182170513;11593.24643898144;486181;493547;498905.95392440556;517408;518891;70015.64992175007;94586.52706736422;94796;95126;95313.5234323824;1018.256672628985;1037.4916291017348;1037.5486663301488;1047.8690163729534;1072.5924148823397;17367;17811.643767124846;17928.372506962194;18015.369462068764;18161;40524.59475405208;41688.79155604202;42275;42956.14087718166;43460.130797383244;57256.42743572511;58607.4139258619;58622.7068864653;59013.409865900794;59455.702721486115;8543.8718419225;8830.955845220733;8867.68963086289;9043.773905652411;9091.045440228681;12341.50633974631;12757.936210318889;12762.61712148637;12955.222686638832;13095.738085238432;11052.613158539412;11116.110711142928;11210.719732006764;11325.830112548483;11424.714382140513;11301.378424186749;11352.148588856035;11465.770684586094;11522.654320370402;11583.76832463363;9937.155341795738;11029.44852757375;11195.216334856483;11322.433878305887;11344.376059316817;8451.704190353554;8529.829403411773;8572.528510931708;8761.474311541328;8928.73213803587;11017;11073.446327683745;11194.552217911518;11236.94381528087;11278.661640150809 00:42:49 INFO - PROCESS | 21366 | |3;mootools.html;1542.421591903036;1588.97616535752;1785.6785778559854;1903.1911437639;1905;8549.358798090137;8982.910170898289;9129.269658427327;9740.95129524353;9765.316427850054;8950.060243674418;9106.134917182873;9269.582868770905;9295.860562091573;9348;2448.632705094237;2487.5273697997322;2489.4772097859473;2512.8115391345723;2517.7104632967166;2418.262429958862;2488.2659615413404;2491.750824917503;2495.2763698527406;2496.3135137837057;2469.4073422378588;2476.4799392127675;2483.217786397288;2493.2395619336094;2498.2130628851855;2402.4834660547976;2413.348395933097;2423.660687503751;2427.963580546293;2441.377448750557;2352.5765362234793;2411.46947671512;2417.492326611414;2422.769836865495;2445.144199530168;9342.065793420672;9353;9365.578548965314;9398.624055037859;9400.858987115198;5467.699276539789;5612.017896868032;5613;5620.9601223773325;5649.293838270216;3543.1496440854266;3618.421052631593;3693.759905606127;3710.443433484972;3739.4577786221116;1244;1258.4462836351977;1265.6329664397313;1304.8303720516367;1308.5877948446305;13344.799828002588;13661;13699.383527741176;13700.45198192071;13716.451341946311;4902;5023.045621331935;5035.244713293036;5040.36995375578;5045.344105266292;11600.477978490819;11634.883651163549;11689.123315751352;11693.123015773852;11693.239939403911;5615.466530679579;5619.719014049281;5621.353544342372;5632.493075623213;5636.013697602903;4627.028324051987;5072.847814565495;5161.922571161435;5179.792808287626;5211.1922651989;4392.956070439254;4432.468103827497;4445.044315472189;4448.733076015449;4456.286994080996;1394.9930250348684;1440.1287221231214;1448.4351103069812;1448.804411404468;1457.3514785920377;1073.6403304892792;1077.6389909380446;1081.2431298091367;1084.3927400655657;1085.8262677971486;6445.774397896051;6544.6727663617585;6563.7702680405955;6614.801555953329;6633.237177724527;492.6625261695678;497.37082590523016;502.62805523912044;506.5162769555066;510.33401411158053;4309.612134907873;4381.78091095444;4401.273789824643;4427.070315233773;4434.645228381722;11646.301221926711;12107.334096624594;12114.394280285951;12129.757404851853;12172.20880642773;11957.820632690342;11993.100517461226;11995;12008.699782505333;12010.519579216909;8490.193431623986;8837.160469755363;8838.911610883937;8852.38033337673;9012.909870901338;6622.8344291393105;6798.524103312919;6866.896996544956;6875.690593923386;6933.445324373937;11125.83311250348;11130.220884538005;11199.272047316897;11277.266977646426;11374.943125284652;11358.432078396212;11372.943135284271;11395;11479;11500.884991149982;8231.794205144919;8338.124496927736;8562.700305489278;8572.65709371643;8593.91406085956;9465.95267023688;9472.763180920532;9475.763105922408;9497.85753213716;9505.239580833655;8172.591370431336;8332.916670833214;8347.66609335644;8381.245687887875;8486;8092.312153466786;8242.010958684756;8281.21328473794;8386.161383861809;8417.70538031166;7643.044619422572;7830.530168189927;7839.529628222097;7843.607819609111;7850.882236766339;5456.427075157051;5465.262189604353;5761.971190144022;5854.795082172103;6033.034714445667;5826.854328641818;5917.260342457193;5921.319048309328;5921.970390148022;6047.123167140652 00:42:49 INFO - PROCESS | 21366 | |4;prototype.html;350.3203784657764;350.3763301323644;355.2911940678347;356.3621118198425;357.41384130026745;5789.942100578998;5879.794207202749;5898.439648233416;5902.432441887777;5908.350081491032;5791.536677065835;5806.44838740319;5807.767689292434;5811.73847176877;5835.708214589275;4337.240982828001;4443.266860967937;4450.087732014929;4460.687751857371;4466.865994020184;4400.603945644892;4402.779861006937;4440.800163992628;4461.843835465759;4472.21736196166;4403.911921761563;4422.469303683562;4433.428611405393;4438.223310920592;4512.458504979407;4336.8265269389185;4405.713628614129;4406.9559304407185;4422.800973956164;4442.577955094293;3832.9041773955596;3859.954224261146;3861.1698484825897;3864.787436690981;3868.477755502999;5552.167174923753;5573.6098473106895;5610.4670056344585;5634.690092044936;5636.688957527394;4961.355023846912;5065.696058236517;5086.982603479319;5089.923651145235;5131.230315452674;6021.759129634809;6071.692756752406;6091.269047714259;6098.8780224395705;6135.938640613582;4349.391085248036;4352.7823608819435;4352.911772056986;4354.978225108885;4356.847510337155;6024.909626355608;6127.84680382994;6255.49956003514;6281.96859015702;6372.93627063728;4313.762743049162;4333.263345231318;4361.345798130305;4365.541618130114;4372.213001659668;4422.867313980586;4423.646108311327;4427.667924905645;4428.693535407063;4433.889152771142;4956.182229932093;5078.492150784966;5117.437081920985;5118.769655365518;5140.203268493389;6099.9085013724825;6117.235345581802;6125.223685131262;6129.264488261437;6135.466133466633;1533.8159420869567;1548.783170356151;1551.8137823461032;1551.9922400388152;1553.7280975829185;943.6131186213756;972.1590823937244;980.294188184506;987.7728122531857;992.717075633441;5226.398964119175;5314.7608357624;5319.0213480451075;5324.600654950894;5421.241026256327;5545.861353466195;5583.190437386556;5596.3284405870745;5626.634268772516;5641.605087643826;5336.466353364633;5457.426970168154;5601.607887447921;6002.939970600325;6052.273727152769;3349.7990120592845;3354.446516324828;3380.4422270325613;3391.508231306496;3414.8804791832167;6361.936380636134;6643;6652.73389064432;6686.732530698815;6709.966450167718;6427.839304017437;6466.5473416861305;6468.482521398371;6473.8705225896165;6507.3167317431935;6346.428821406095;6582.597351966593;6635.5023373247195;6646.933530664632;6660.933390666129;6314.715837787218;6319.3364696706185;6322.747090116344;6335.873282534231;6376.840578985562;6116.633002019893;6322.209723784527;6332.968335158294;6370.77702280418;6371.617702937839;6367.26776420699;6459.4832413405875;6461.515386345949;6462.644554549545;6512.381323774234;4572.88567785808;4588.541145885385;4618.63050955916;4619.584237418649;4634.907301854011;6210.839833049531;6302.873942521215;6358.968205158944;6403.327650596807;6438.8390290243115;6017.939820601738;6068.6965651716355;6156.138140660221;6156.876862462636;6188.876222475616;5925.940740592711;6093;6133.325334213144;6145.324014358328;6158.630482171084;5949.970250148722;5975;6001.4298641628975;6033.456988871023;6069.575129740876;6232.189815323979;6243.188385509855;6244.1570387997035;6259.718312676032;6262.874742505033;5864.123480486203;5994.670293133745;6023.247094113236;6036.826742372655;6050.183225264533 00:42:49 INFO - PROCESS | 21366 | |5;yui.html;845.437783873724;846.7078857794063;875.2691502595331;912.393258483109;914.9313801464892;17330.480085597435;18045.729314060267;18086;18661;18668.253269869223;16345.591360216;16648.33406663732;16657.666846663058;16671.49985500434;16845.83154168458;874.3791907745508;889.888763904512;891.1934699097311;893.5621545442718;894.3515950935584;892.6206362296031;894.5214310343968;895.3374502867863;896.4486840593054;897.0088052701768;941.0401390581603;943.1370296178987;943.3302355327692;945.6170251048336;945.754103932979;932.2355668351954;932.8880534335856;933.869258303838;934.8083642853233;935.5228833295;677.8915373540259;678.3284548297199;685.9965700171517;688.1466980943644;688.8932215506604;16087.839121608751;16185.91907040469;16289.91855040729;16293.022418654919;16299.348026078942;15087.170205638686;15987;16235.837641623551;16591.834081659148;16783.6643267134;13202.603921882359;13343.266120363473;13413.731725365536;13525.256110913895;13612.183269003892;4048.3725022621543;4099.959000409987;4108.67130629549;4144.41978123063;4197.391378250137;64661.353386466006;67157.3284267156;67694.3230567693;88105.55947220222;89461;11982.700432489257;12033.518659253532;12035.518579256732;12494.375281235902;12538.373081345897;22469.213577524708;22567;22579.548409031726;22611.982460789302;22617.434564136027;9377.343585949055;9400.670976515788;9421.71734847942;9589.952050239704;9759.65841195569;5093.439721630618;5211.166213405837;5215.608829337815;5323.121684922022;5362.758675859518;3841.654251117357;3937.310970580137;3942.5663177051074;3944.526656801202;3945.8618948337244;668.2882729892649;670.4100391655312;675.1425689374466;686.0224180542806;699.1784653032666;706.0891450029507;775.309974123031;795.8885755994049;828.5774255129807;832.2343444031505;10063.748406289902;10260;10377;10402.47987600617;10461.529231184615;799.1568894815908;818.7420962396826;821.3306155483263;827.4538804389074;843.1273631791066;4988.72562009093;5006.524380183877;5053.722045287471;5065.627665890027;5120.539151476385;107423.46288268665;107449;108260.45869770758;114172;115867.42066289614;68330.31669683338;70583;99073;99504.5024774886;99660;85210.57394712987;87565.12434875697;88116.55941720378;88163.55918220368;89141.55429222943;9312.4638375131;9513.476758778334;9620;9806.166475849634;9813.618104244346;36770.816145919096;37503.43744843775;47325;51412.74293628508;53768.46231537791;71786.64106679642;75918;77000.61499692466;77527.61236193783;78119.60940195262;13534;13659.590212293648;13935.930320348334;14211.857881421054;14468.131912084888;15330.923345383648;16222.837771622133;16402.83597164061;16433.589160271087;16504.587385315463;13941.930290348484;14015;15077.924610376878;15118.470853520073;15364.23178841031;14684.77972830387;14791.334389952694;15087.622809429413;15357.078575285519;15861.365545378518;14734.189619571027;15179.772303415679;15285.159316237714;15511.301991410188;15614.687706245584;11899.226550274205;11918.940405297919;11959.940200298943;12172.817407739069;12222.388880556115;12176.208546444454;12254;12373.75252494927;12654.114212005072;12757.872421275668 00:42:49 INFO - PROCESS | 21366 | __end_tp_report 00:42:49 INFO - PROCESS | 21366 | __start_cc_report 00:42:49 INFO - PROCESS | 21366 | _x_x_mozilla_cycle_collect,327 00:42:49 INFO - PROCESS | 21366 | __end_cc_report 00:42:49 INFO - PROCESS | 21366 | __startTimestamp1470382969352__endTimestamp 00:42:49 INFO - PROCESS | 21366 | 00:42:49 INFO - PROCESS | 21366 | ------- Summary: start ------- 00:42:49 INFO - PROCESS | 21366 | Number of tests: 6 00:42:49 INFO - PROCESS | 21366 | 00:42:49 INFO - PROCESS | 21366 | [#0] dojo.html Cycles:165 Average:5678.75 Median:5923.44 stddev:642.13 (10.8%) stddev-sans-first:618.22 00:42:49 INFO - PROCESS | 21366 | Values: 3378.2 3424.5 3443.7 3453.1 3458.9 5623.1 5643.5 5645.5 5698.1 5713.9 5692.1 5768.9 5770.5 5778.7 5782.7 5031.3 5071.6 5112.6 5149.3 5167.0 5092.9 5094.1 5160.3 5175.4 5177.5 5134.8 5147.6 5149.6 5155.6 5193.0 5152.6 5224.2 5236.3 5239.7 5263.0 5016.8 5070.9 5154.0 5188.2 5208.8 5423.0 5487.0 5496.7 5602.4 5611.4 6063.2 6082.0 6087.2 6106.4 6107.3 6129.7 6140.7 6143.0 6150.9 6178.2 5673.5 5691.6 5713.3 5752.3 5816.1 6317.7 6325.2 6327.7 6333.4 6337.4 5958.6 6045.1 6082.2 6105.5 6110.3 6091.0 6175.4 6177.4 6177.8 6179.9 6082.1 6085.7 6106.4 6118.3 6125.2 5962.2 5993.6 6025.0 6129.8 6138.6 4636.8 4653.2 4654.4 4658.8 4667.0 4161.1 4167.5 4170.3 4180.6 4201.9 5817.2 5833.3 5890.6 5895.0 5912.4 6005.8 6055.2 6094.4 6113.4 6126.8 5923.4 5924.7 5926.5 5927.6 5943.8 5196.7 5215.0 5239.9 5258.7 5265.3 6311.3 6317.8 6341.7 6362.6 6382.4 6163.9 6171.3 6178.4 6181.0 6192.4 6150.4 6163.8 6195.0 6220.5 6368.0 6041.2 6061.6 6072.9 6094.8 6100.5 5978.6 6123.0 6148.9 6163.2 6165.7 5893.3 5921.9 5948.3 5996.3 6012.2 5979.0 5989.7 6020.3 6023.1 6040.5 5720.1 5775.9 5831.0 5908.6 5916.6 5965.3 6016.7 6049.3 6051.0 6073.4 5886.5 5895.2 5897.1 5900.5 5903.7 00:42:49 INFO - PROCESS | 21366 | 00:42:49 INFO - PROCESS | 21366 | [#1] ext.html Cycles:180 Average:66061.75 Median:44725.89 stddev:149052.82 (333.3%) stddev-sans-first:149389.90 00:42:49 INFO - PROCESS | 21366 | Values: 594.9 638.3 640.3 655.0 656.4 46794.5 48385.3 48478.5 48624.8 51299.7 48720.5 48771.3 49181.0 49269.8 49515.0 9064.7 9108.4 9179.8 9244.0 9250.1 9053.1 9085.2 9107.9 9123.1 9150.9 9114.8 9160.2 9190.2 9191.8 9200.2 9047.4 9092.5 9120.0 9129.5 9139.9 8931.7 8969.0 8980.0 8987.8 9007.9 46179.5 46563.5 46644.1 46690.5 46714.3 3963.0 3993.4 4045.4 4214.0 4378.9 35153.8 35342.6 35411.8 35515.3 35935.6 4708.5 4722.2 4776.2 4831.8 4841.5 250779.0 251369.0 251400.7 251634.0 252774.0 64963.0 64981.7 65044.7 65195.0 65491.0 39970.8 40950.4 41038.2 42689.8 68202.6 19692.7 19789.5 19838.8 19887.5 19970.7 13864.7 13930.8 14015.7 14035.1 14039.0 21288.7 21320.5 21328.9 21359.0 21385.3 7379.3 7409.2 7624.7 7637.2 7668.9 1069.6 1082.8 1117.4 1134.4 1190.3 33434.8 33468.7 33572.0 33839.5 34656.7 1150.3 1211.9 1248.1 1251.5 1282.9 17220.7 18042.6 18130.4 18516.0 19450.8 661873.0 669129.0 701146.0 984966.0 1008127.0 59973.4 60296.4 60744.7 60793.4 60822.4 1488.1 1502.7 1510.5 1513.8 1519.5 31394.7 32107.0 32486.7 32806.8 32934.2 52150.7 52242.5 52981.5 52996.0 53044.7 420327.0 422043.0 423136.0 423239.0 425521.0 28822.4 29084.1 29113.9 29124.0 32896.8 52905.5 53302.7 54137.7 54149.2 54237.2 44909.8 45671.8 45726.3 46827.0 47226.8 43764.6 44048.0 44505.3 44910.1 45115.0 44193.3 44271.8 44542.0 45599.8 45670.8 38293.4 38911.8 38996.4 39988.6 40017.2 28871.6 29735.7 29915.4 29969.4 30340.4 00:42:49 INFO - PROCESS | 21366 | 00:42:49 INFO - PROCESS | 21366 | [#2] jquery.html Cycles:180 Average:29259.76 Median:23252.03 stddev:82684.76 (355.6%) stddev-sans-first:82888.38 00:42:49 INFO - PROCESS | 21366 | Values: 430.9 434.4 436.3 439.2 439.8 18547.4 19646.3 20430.5 20463.2 20569.0 19468.8 19847.8 19886.8 20920.0 21058.4 5636.0 5816.9 5823.7 5853.2 5870.7 5596.1 5736.8 5766.1 5790.3 5840.8 5649.3 5649.5 5658.2 5745.5 5773.9 5586.1 5690.2 5724.1 5867.1 5892.5 5653.2 5750.4 5753.7 5760.3 5984.3 22432.8 22788.9 22858.0 23646.1 24044.2 2458.7 2507.1 2519.5 2528.6 2549.6 10845.9 10965.9 11017.4 11159.4 11160.3 2024.4 2122.5 2143.7 2162.6 2200.3 59850.0 65356.0 74889.3 75726.6 79419.6 11209.4 11327.5 11794.4 11850.3 12032.1 16170.6 16293.0 16342.8 16369.8 16605.7 8663.7 8948.0 8981.8 9022.3 9093.8 8766.2 8916.4 8927.2 8939.0 8952.9 4888.7 4914.1 4924.4 4977.7 5001.4 2102.9 2121.2 2129.3 2144.1 2157.6 978.9 1050.1 1069.0 1073.4 1090.0 19154.9 19905.5 20167.3 20237.8 20261.2 1024.8 1035.7 1041.7 1065.1 1074.4 11110.5 11408.9 11460.1 11472.7 11593.2 486181.0 493547.0 498906.0 517408.0 518891.0 70015.6 94586.5 94796.0 95126.0 95313.5 1018.3 1037.5 1037.5 1047.9 1072.6 17367.0 17811.6 17928.4 18015.4 18161.0 40524.6 41688.8 42275.0 42956.1 43460.1 57256.4 58607.4 58622.7 59013.4 59455.7 8543.9 8831.0 8867.7 9043.8 9091.0 12341.5 12757.9 12762.6 12955.2 13095.7 11052.6 11116.1 11210.7 11325.8 11424.7 11301.4 11352.1 11465.8 11522.7 11583.8 9937.2 11029.4 11195.2 11322.4 11344.4 8451.7 8529.8 8572.5 8761.5 8928.7 11017.0 11073.4 11194.6 11236.9 11278.7 00:42:49 INFO - PROCESS | 21366 | 00:42:49 INFO - PROCESS | 21366 | [#3] mootools.html Cycles:180 Average:6334.65 Median:4764.51 stddev:3661.44 (76.8%) stddev-sans-first:3654.00 00:42:49 INFO - PROCESS | 21366 | Values: 1542.4 1589.0 1785.7 1903.2 1905.0 8549.4 8982.9 9129.3 9741.0 9765.3 8950.1 9106.1 9269.6 9295.9 9348.0 2448.6 2487.5 2489.5 2512.8 2517.7 2418.3 2488.3 2491.8 2495.3 2496.3 2469.4 2476.5 2483.2 2493.2 2498.2 2402.5 2413.3 2423.7 2428.0 2441.4 2352.6 2411.5 2417.5 2422.8 2445.1 9342.1 9353.0 9365.6 9398.6 9400.9 5467.7 5612.0 5613.0 5621.0 5649.3 3543.1 3618.4 3693.8 3710.4 3739.5 1244.0 1258.4 1265.6 1304.8 1308.6 13344.8 13661.0 13699.4 13700.5 13716.5 4902.0 5023.0 5035.2 5040.4 5045.3 11600.5 11634.9 11689.1 11693.1 11693.2 5615.5 5619.7 5621.4 5632.5 5636.0 4627.0 5072.8 5161.9 5179.8 5211.2 4393.0 4432.5 4445.0 4448.7 4456.3 1395.0 1440.1 1448.4 1448.8 1457.4 1073.6 1077.6 1081.2 1084.4 1085.8 6445.8 6544.7 6563.8 6614.8 6633.2 492.7 497.4 502.6 506.5 510.3 4309.6 4381.8 4401.3 4427.1 4434.6 11646.3 12107.3 12114.4 12129.8 12172.2 11957.8 11993.1 11995.0 12008.7 12010.5 8490.2 8837.2 8838.9 8852.4 9012.9 6622.8 6798.5 6866.9 6875.7 6933.4 11125.8 11130.2 11199.3 11277.3 11374.9 11358.4 11372.9 11395.0 11479.0 11500.9 8231.8 8338.1 8562.7 8572.7 8593.9 9466.0 9472.8 9475.8 9497.9 9505.2 8172.6 8332.9 8347.7 8381.2 8486.0 8092.3 8242.0 8281.2 8386.2 8417.7 7643.0 7830.5 7839.5 7843.6 7850.9 5456.4 5465.3 5762.0 5854.8 6033.0 5826.9 5917.3 5921.3 5922.0 6047.1 00:42:49 INFO - PROCESS | 21366 | 00:42:49 INFO - PROCESS | 21366 | [#4] prototype.html Cycles:180 Average:5099.20 Median:5807.11 stddev:1525.96 (26.3%) stddev-sans-first:1488.03 00:42:49 INFO - PROCESS | 21366 | Values: 350.3 350.4 355.3 356.4 357.4 5789.9 5879.8 5898.4 5902.4 5908.4 5791.5 5806.4 5807.8 5811.7 5835.7 4337.2 4443.3 4450.1 4460.7 4466.9 4400.6 4402.8 4440.8 4461.8 4472.2 4403.9 4422.5 4433.4 4438.2 4512.5 4336.8 4405.7 4407.0 4422.8 4442.6 3832.9 3860.0 3861.2 3864.8 3868.5 5552.2 5573.6 5610.5 5634.7 5636.7 4961.4 5065.7 5087.0 5089.9 5131.2 6021.8 6071.7 6091.3 6098.9 6135.9 4349.4 4352.8 4352.9 4355.0 4356.8 6024.9 6127.8 6255.5 6282.0 6372.9 4313.8 4333.3 4361.3 4365.5 4372.2 4422.9 4423.6 4427.7 4428.7 4433.9 4956.2 5078.5 5117.4 5118.8 5140.2 6099.9 6117.2 6125.2 6129.3 6135.5 1533.8 1548.8 1551.8 1552.0 1553.7 943.6 972.2 980.3 987.8 992.7 5226.4 5314.8 5319.0 5324.6 5421.2 5545.9 5583.2 5596.3 5626.6 5641.6 5336.5 5457.4 5601.6 6002.9 6052.3 3349.8 3354.4 3380.4 3391.5 3414.9 6361.9 6643.0 6652.7 6686.7 6710.0 6427.8 6466.5 6468.5 6473.9 6507.3 6346.4 6582.6 6635.5 6646.9 6660.9 6314.7 6319.3 6322.7 6335.9 6376.8 6116.6 6322.2 6333.0 6370.8 6371.6 6367.3 6459.5 6461.5 6462.6 6512.4 4572.9 4588.5 4618.6 4619.6 4634.9 6210.8 6302.9 6359.0 6403.3 6438.8 6017.9 6068.7 6156.1 6156.9 6188.9 5925.9 6093.0 6133.3 6145.3 6158.6 5950.0 5975.0 6001.4 6033.5 6069.6 6232.2 6243.2 6244.2 6259.7 6262.9 5864.1 5994.7 6023.2 6036.8 6050.2 00:42:49 INFO - PROCESS | 21366 | 00:42:49 INFO - PROCESS | 21366 | [#5] yui.html Cycles:180 Average:20914.89 Median:4170.91 stddev:28725.80 (688.7%) stddev-sans-first:28766.86 00:42:49 INFO - PROCESS | 21366 | Values: 845.4 846.7 875.3 912.4 914.9 17330.5 18045.7 18086.0 18661.0 18668.3 16345.6 16648.3 16657.7 16671.5 16845.8 874.4 889.9 891.2 893.6 894.4 892.6 894.5 895.3 896.4 897.0 941.0 943.1 943.3 945.6 945.8 932.2 932.9 933.9 934.8 935.5 677.9 678.3 686.0 688.1 688.9 16087.8 16185.9 16289.9 16293.0 16299.3 15087.2 15987.0 16235.8 16591.8 16783.7 13202.6 13343.3 13413.7 13525.3 13612.2 4048.4 4100.0 4108.7 4144.4 4197.4 64661.4 67157.3 67694.3 88105.6 89461.0 11982.7 12033.5 12035.5 12494.4 12538.4 22469.2 22567.0 22579.5 22612.0 22617.4 9377.3 9400.7 9421.7 9590.0 9759.7 5093.4 5211.2 5215.6 5323.1 5362.8 3841.7 3937.3 3942.6 3944.5 3945.9 668.3 670.4 675.1 686.0 699.2 706.1 775.3 795.9 828.6 832.2 10063.7 10260.0 10377.0 10402.5 10461.5 799.2 818.7 821.3 827.5 843.1 4988.7 5006.5 5053.7 5065.6 5120.5 107423.5 107449.0 108260.5 114172.0 115867.4 68330.3 70583.0 99073.0 99504.5 99660.0 85210.6 87565.1 88116.6 88163.6 89141.6 9312.5 9513.5 9620.0 9806.2 9813.6 36770.8 37503.4 47325.0 51412.7 53768.5 71786.6 75918.0 77000.6 77527.6 78119.6 13534.0 13659.6 13935.9 14211.9 14468.1 15330.9 16222.8 16402.8 16433.6 16504.6 13941.9 14015.0 15077.9 15118.5 15364.2 14684.8 14791.3 15087.6 15357.1 15861.4 14734.2 15179.8 15285.2 15511.3 15614.7 11899.2 11918.9 11959.9 12172.8 12222.4 12176.2 12254.0 12373.8 12654.1 12757.9 00:42:49 INFO - PROCESS | 21366 | -------- Summary: end -------- 00:42:49 INFO - PROCESS | 21366 | 00:42:49 INFO - TEST-INFO | 21366: exit 0 00:42:50 INFO - TEST-OK | dromaeo_css | took 1109538ms 00:42:50 INFO - TEST-START | kraken 00:42:50 INFO - operating with platform_type : linux_ 00:42:50 INFO - Initialising browser for kraken test... 00:42:50 INFO - TEST-INFO | started process 21599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3zaLNZ/profile http://localhost:45552/getInfo.html) 00:42:54 INFO - PROCESS | 21599 | __metrics Screen width/height:1600/1200 00:42:54 INFO - PROCESS | 21599 | colorDepth:24 00:42:54 INFO - PROCESS | 21599 | Browser inner width/height: 1024/697 00:42:54 INFO - PROCESS | 21599 | __metrics 00:42:54 ERROR - PROCESS | 21599 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 00:42:55 INFO - TEST-INFO | 21599: exit 0 00:42:55 INFO - Browser initialized. 00:42:55 INFO - Running cycle 1/1 for kraken test... 00:42:55 INFO - TEST-INFO | started process 21727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3zaLNZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:43:07 INFO - PROCESS | 21727 | RSS: Main: 152592384 00:43:07 INFO - PROCESS | 21727 | 00:43:09 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45552/tests/kraken/driver.html?testName=audio-beat-detection) 00:43:10 INFO - PROCESS | 21727 | RSS: Main: 157880320 00:43:10 INFO - PROCESS | 21727 | 00:43:13 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45552/tests/kraken/driver.html?testName=audio-dft) 00:43:13 INFO - PROCESS | 21727 | RSS: Main: 156618752 00:43:13 INFO - PROCESS | 21727 | 00:43:16 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45552/tests/kraken/driver.html?testName=audio-fft) 00:43:17 INFO - PROCESS | 21727 | RSS: Main: 158130176 00:43:17 INFO - PROCESS | 21727 | 00:43:19 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45552/tests/kraken/driver.html?testName=audio-oscillator) 00:43:20 INFO - PROCESS | 21727 | RSS: Main: 157773824 00:43:20 INFO - PROCESS | 21727 | 00:43:22 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45552/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:43:22 INFO - PROCESS | 21727 | RSS: Main: 157401088 00:43:22 INFO - PROCESS | 21727 | 00:43:25 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45552/tests/kraken/driver.html?testName=imaging-darkroom) 00:43:26 INFO - PROCESS | 21727 | RSS: Main: 157143040 00:43:26 INFO - PROCESS | 21727 | 00:43:29 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45552/tests/kraken/driver.html?testName=imaging-desaturate) 00:43:30 INFO - PROCESS | 21727 | RSS: Main: 157970432 00:43:30 INFO - PROCESS | 21727 | 00:43:33 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45552/tests/kraken/driver.html?testName=json-parse-financial) 00:43:33 INFO - PROCESS | 21727 | RSS: Main: 158162944 00:43:33 INFO - PROCESS | 21727 | 00:43:35 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45552/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:43:36 INFO - PROCESS | 21727 | RSS: Main: 158158848 00:43:36 INFO - PROCESS | 21727 | 00:43:37 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:43:38 INFO - PROCESS | 21727 | RSS: Main: 158085120 00:43:38 INFO - PROCESS | 21727 | 00:43:40 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:43:41 INFO - PROCESS | 21727 | RSS: Main: 158347264 00:43:41 INFO - PROCESS | 21727 | 00:43:43 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:43:44 INFO - PROCESS | 21727 | RSS: Main: 158593024 00:43:44 INFO - PROCESS | 21727 | 00:43:47 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:43:47 INFO - PROCESS | 21727 | RSS: Main: 158060544 00:43:47 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45552/tests/kraken/driver.html?testName=ai-astar) 00:43:49 INFO - PROCESS | 21727 | RSS: Main: 159027200 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | __start_tp_report 00:43:49 INFO - PROCESS | 21727 | _x_x_mozilla_page_load 00:43:49 INFO - PROCESS | 21727 | _x_x_mozilla_page_load_details 00:43:49 INFO - PROCESS | 21727 | |i|pagename|runs| 00:43:49 INFO - PROCESS | 21727 | |0;ai-astar;112;106;111;111;113;111;111;111;111;111 00:43:49 INFO - PROCESS | 21727 | |1;audio-beat-detection;150;131;157;179;124;162;158;134;182;125 00:43:49 INFO - PROCESS | 21727 | |2;audio-dft;163;162;162;162;164;163;162;161;162;162 00:43:49 INFO - PROCESS | 21727 | |3;audio-fft;74;74;76;166;77;77;75;75;158;75 00:43:49 INFO - PROCESS | 21727 | |4;audio-oscillator;85;84;145;85;84;85;144;84;84;152 00:43:49 INFO - PROCESS | 21727 | |5;imaging-gaussian-blur;117;118;117;117;117;118;118;117;119;117 00:43:49 INFO - PROCESS | 21727 | |6;imaging-darkroom;147;148;148;147;148;148;146;146;147;149 00:43:49 INFO - PROCESS | 21727 | |7;imaging-desaturate;95;96;96;96;96;96;95;96;97;97 00:43:49 INFO - PROCESS | 21727 | |8;json-parse-financial;52;52;52;52;52;61;52;53;51;57 00:43:49 INFO - PROCESS | 21727 | |9;json-stringify-tinderbox;60;59;60;60;59;59;59;59;60;60 00:43:49 INFO - PROCESS | 21727 | |10;stanford-crypto-aes;76;76;77;85;79;80;81;83;108;78 00:43:49 INFO - PROCESS | 21727 | |11;stanford-crypto-ccm;119;127;122;129;131;123;128;123;134;139 00:43:49 INFO - PROCESS | 21727 | |12;stanford-crypto-pbkdf2;161;157;157;160;155;159;160;158;155;163 00:43:49 INFO - PROCESS | 21727 | |13;stanford-crypto-sha256-iterative;62;68;63;62;72;62;61;64;63;61 00:43:49 INFO - PROCESS | 21727 | __end_tp_report 00:43:49 INFO - PROCESS | 21727 | __start_cc_report 00:43:49 INFO - PROCESS | 21727 | _x_x_mozilla_cycle_collect,841 00:43:49 INFO - PROCESS | 21727 | __end_cc_report 00:43:49 INFO - PROCESS | 21727 | __startTimestamp1470383029523__endTimestamp 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | ------- Summary: start ------- 00:43:49 INFO - PROCESS | 21727 | Number of tests: 14 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.81 (1.6%) stddev-sans-first:1.87 00:43:49 INFO - PROCESS | 21727 | Values: 112.0 106.0 111.0 111.0 113.0 111.0 111.0 111.0 111.0 111.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:157.50 stddev:21.19 (13.5%) stddev-sans-first:22.47 00:43:49 INFO - PROCESS | 21727 | Values: 150.0 131.0 157.0 179.0 124.0 162.0 158.0 134.0 182.0 125.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 00:43:49 INFO - PROCESS | 21727 | Values: 163.0 162.0 162.0 162.0 164.0 163.0 162.0 161.0 162.0 162.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.00 stddev:36.59 (48.8%) stddev-sans-first:38.18 00:43:49 INFO - PROCESS | 21727 | Values: 74.0 74.0 76.0 166.0 77.0 77.0 75.0 75.0 158.0 75.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:84.00 stddev:30.30 (36.1%) stddev-sans-first:31.41 00:43:49 INFO - PROCESS | 21727 | Values: 85.0 84.0 145.0 85.0 84.0 85.0 144.0 84.0 84.0 152.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 00:43:49 INFO - PROCESS | 21727 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 119.0 117.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 00:43:49 INFO - PROCESS | 21727 | Values: 147.0 148.0 148.0 147.0 148.0 148.0 146.0 146.0 147.0 149.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 00:43:49 INFO - PROCESS | 21727 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 97.0 97.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:52.00 stddev:3.13 (6.0%) stddev-sans-first:3.28 00:43:49 INFO - PROCESS | 21727 | Values: 52.0 52.0 52.0 52.0 52.0 61.0 52.0 53.0 51.0 57.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 00:43:49 INFO - PROCESS | 21727 | Values: 60.0 59.0 60.0 60.0 59.0 59.0 59.0 59.0 60.0 60.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:79.50 stddev:9.50 (11.9%) stddev-sans-first:9.80 00:43:49 INFO - PROCESS | 21727 | Values: 76.0 76.0 77.0 85.0 79.0 80.0 81.0 83.0 108.0 78.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:128.50 stddev:6.08 (4.7%) stddev-sans-first:5.61 00:43:49 INFO - PROCESS | 21727 | Values: 119.0 127.0 122.0 129.0 131.0 123.0 128.0 123.0 134.0 139.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.50 stddev:2.59 (1.6%) stddev-sans-first:2.59 00:43:49 INFO - PROCESS | 21727 | Values: 161.0 157.0 157.0 160.0 155.0 159.0 160.0 158.0 155.0 163.0 00:43:49 INFO - PROCESS | 21727 | 00:43:49 INFO - PROCESS | 21727 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:3.52 (5.6%) stddev-sans-first:3.67 00:43:49 INFO - PROCESS | 21727 | Values: 62.0 68.0 63.0 62.0 72.0 62.0 61.0 64.0 63.0 61.0 00:43:49 INFO - PROCESS | 21727 | -------- Summary: end -------- 00:43:49 INFO - PROCESS | 21727 | 00:43:50 INFO - TEST-INFO | 21727: exit 0 00:43:50 INFO - TEST-OK | kraken | took 60392ms 00:43:50 INFO - SUITE-END | took 1169s 00:43:50 INFO - Completed test suite (00:19:30) 00:43:50 INFO - javascript benchmark 00:43:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7726.79422364983, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3378.223008707999, 3424.503447000185, 3443.6728510791468, 3453.08493249289, 3458.948115778264, 5623.072193088141, 5643.463870932265, 5645.520130788883, 5698.059820129673, 5713.914291285634, 5692.060809966361, 5768.855778605537, 5770.538356931446, 5778.711064446782, 5782.653040817554, 5031.295618613397, 5071.594272458213, 5112.590992720592, 5149.253358263049, 5167.044096842077, 5092.872678183038, 5094.083065048289, 5160.303359046537, 5175.378954525462, 5177.456367081459, 5134.768935397916, 5147.639665223436, 5149.639525233235, 5155.639105262614, 5193.039287731763, 5152.639315247934, 5224.242484839677, 5236.319278493809, 5239.73801309933, 5263.02634012705, 5016.849494515171, 5070.873228169288, 5154.046501397253, 5188.195829646411, 5208.7916483341, 5422.972885135549, 5487.039768040617, 5496.725163741797, 5602.38373778884, 5611.354694210137, 6063.242094738158, 6082.0, 6087.2086628738425, 6106.358832322587, 6107.328193898667, 6129.693515324216, 6140.662263575501, 6142.96928515359, 6150.8769824603705, 6178.227721534809, 5673.489385955284, 5691.573132015074, 5713.257276554063, 5752.280964879348, 5816.098504731774, 6317.715702793385, 6325.209348831396, 6327.715252813635, 6333.398327158912, 6337.42963133311, 5958.582899197101, 6045.142101127036, 6082.239720034996, 6105.450509454082, 6110.327863934964, 6091.02543593023, 6175.413335733098, 6177.351378105234, 6177.81466556004, 6179.907301390483, 6082.148499210114, 6085.695715214221, 6106.419890110521, 6118.265808103056, 6125.203723516003, 5962.19510366095, 5993.61041532299, 6025.0, 6129.785457508966, 6138.570300078952, 4636.8145274188655, 4653.23221668421, 4654.4414670239785, 4658.790354434059, 4666.95333046672, 4161.0845613964875, 4167.4790651168605, 4170.291050521419, 4180.581941805795, 4201.852935147255, 5817.214676018683, 5833.270841144857, 5890.587658863838, 5894.970525147347, 5912.379200184005, 6005.759769609254, 6055.2128223331565, 6094.421030002142, 6113.358097399798, 6126.846828829315, 5923.437273459014, 5924.674142922095, 5926.4666180044005, 5927.585069045212, 5943.762249510058, 5196.740162991835, 5215.0, 5239.869003274948, 5258.684478931276, 5265.315508983884, 6311.33730958252, 6317.778877739257, 6341.714622841983, 6362.554621176473, 6382.425581697669, 6163.9383606163365, 6171.321154672893, 6178.382161783786, 6180.969095154675, 6192.442680158807, 6150.415710507495, 6163.8150855474405, 6194.969025154845, 6220.533459990428, 6368.0, 6041.154238406539, 6061.605995610447, 6072.939270607238, 6094.847628809138, 6100.450959413674, 5978.611390259619, 6122.957105438777, 6148.907766383419, 6163.229596300463, 6165.691715414122, 5893.292804863444, 5921.940780592311, 5948.315943666534, 5996.310424301261, 6012.218411606463, 5979.0, 5989.730462129128, 6020.307664618625, 6023.096535519707, 6040.456358927542, 5720.11338242573, 5775.9133612995, 5830.950428922834, 5908.556858235564, 5916.585838991229, 5965.254343207099, 6016.669083200466, 6049.334573196857, 6050.969745151246, 6073.362296958756, 5886.470217680429, 5895.233619629421, 5897.144913987534, 5900.498457631149, 5903.7048147593305], "value": 5636.363796544645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.9107633854921, 638.3456956619461, 640.3372509452715, 654.9618854116226, 656.4420242793623, 46794.53205467945, 48385.27422088667, 48478.51521484784, 48624.75687621557, 51299.74350128254, 48720.51279487204, 48771.26843097356, 49181.01637967239, 49269.753651231695, 49515.00969980598, 9064.728058158233, 9108.362414630978, 9179.770505737342, 9243.953780231122, 9250.121238482367, 9053.09469053096, 9085.227755640746, 9107.908920910806, 9123.133302336268, 9150.908490915106, 9114.817703645956, 9160.17558419742, 9190.21883139934, 9191.770205744842, 9200.171984521392, 9047.411918225294, 9092.454452732823, 9119.954400227989, 9129.452232866017, 9139.862902056475, 8931.687390941352, 8969.0, 8979.955100224523, 8987.775305617346, 9007.909920900773, 46179.53820461786, 46563.53436465626, 46644.06711865744, 46690.53309466896, 46714.299285510744, 3962.980185099056, 3993.4409182714444, 4045.3527435610454, 4213.9578604214175, 4378.934315985262, 35153.82423087868, 35342.646573534446, 35411.82294088513, 35515.28969420623, 35935.64064359349, 4708.474356609829, 4722.1736196165875, 4776.188048031843, 4831.830885918976, 4841.515172598854, 250779.0, 251369.0, 251400.74299628567, 251634.0, 252774.0, 64963.0, 64981.67509162424, 65044.67477662581, 65195.0, 65491.0, 39970.800145999085, 40950.38574421386, 41038.179236415104, 42689.786551067045, 68202.63594728078, 19692.70460943087, 19789.505262368268, 19838.801611983694, 19887.502812429804, 19970.70043949342, 13864.722705545833, 13930.791038134435, 14015.719685606231, 14035.087719298213, 14039.0, 21288.680669789966, 21320.466988325104, 21328.893355533433, 21359.0, 21385.25151619686, 7379.262073792685, 7409.184989651134, 7624.733134340271, 7637.15991240963, 7668.855769134628, 1069.561479793281, 1082.837574363836, 1117.4412793603199, 1134.432783608196, 1190.3334132885611, 33434.832825835714, 33468.66531334655, 33571.992840214836, 33839.49240761391, 34656.65343346585, 1150.3098141115431, 1211.8727533609022, 1248.1387842388722, 1251.5181655062866, 1282.9166104203198, 17220.741688874677, 18042.63914721698, 18130.365437209635, 18516.0, 19450.805491945182, 661873.0, 669129.0, 701146.0, 984966.0, 1008127.0, 59973.40026599678, 60296.39703602908, 60744.696276518334, 60793.39206607966, 60822.39177608256, 1488.0550850210195, 1502.7445334292977, 1510.5015344936364, 1513.7956375889335, 1519.4529969211076, 31394.686053139176, 32107.0, 32486.675133248365, 32806.83596582002, 32934.176645583095, 52150.73924630504, 52242.47757522528, 52981.47018529765, 52996.0, 53044.73477632587, 420327.0, 422043.0, 423136.0, 423239.0, 425521.0, 28822.42355152927, 29084.12747617575, 29113.85443072771, 29124.0, 32896.83551582227, 52905.47094529006, 53302.73348633232, 54137.72931135319, 54149.18776218281, 54237.18644220261, 44909.775451122536, 45671.77164114158, 45726.31410528778, 46827.0, 47226.76386618045, 43764.56235437605, 44048.0, 44505.33242001308, 44910.10179796451, 45115.0, 44193.33709994417, 44271.77864110659, 44542.0, 45599.77200113978, 45670.771646141555, 38293.4255986166, 38911.80544097262, 38996.415053774785, 39988.60011399965, 40017.19965600614, 28871.5669264957, 29735.702642973294, 29915.401691966475, 29969.400611988076, 30340.393192136475], "value": 21424.591353287342, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.89260600257353, 434.43740356238675, 436.33458975063024, 439.200654808249, 439.84605388114164, 18547.35084272051, 19646.312379066716, 20430.489237769063, 20463.18147274111, 20569.0, 19468.805311946875, 19847.801521984813, 19886.801131988675, 20920.0, 21058.368248952516, 5635.99999999999, 5816.854578635547, 5823.650580965134, 5853.239078919734, 5870.706464676749, 5596.132599447072, 5736.770529178828, 5766.077427611583, 5790.334111577159, 5840.766369345221, 5649.265595472582, 5649.548036157118, 5658.151277308396, 5745.482906538411, 5773.9422605773825, 5586.13414920686, 5690.2033715279895, 5724.141378793172, 5867.119932010232, 5892.528597712216, 5653.208550802891, 5750.424957504258, 5753.712314384264, 5760.279965004374, 5984.3417224105315, 22432.77567224323, 22788.886055569783, 22858.0, 23646.054157833667, 24044.15845445401, 2458.6557881896547, 2507.0974449198275, 2519.533886231053, 2528.557502437066, 2549.5920652695663, 10845.891541084646, 10965.945170274177, 11017.394043327613, 11159.442027898654, 11160.330380177214, 2024.4028011736425, 2122.4906022554474, 2143.710599069137, 2162.5566758814407, 2200.339898030584, 59850.0, 65356.0, 74889.25110748877, 75726.59230334593, 79419.6029019857, 11209.439528023566, 11327.546898123983, 11794.351310677823, 11850.348230847387, 12032.097592680584, 16170.59573510648, 16293.0, 16342.836571634369, 16369.754453683205, 16605.6678866422, 8663.696770612998, 8947.955260223658, 8981.775455613662, 9022.278217742565, 9093.772655683528, 8766.167214114648, 8916.420432671985, 8927.151920567536, 8939.016708162097, 8952.910470895338, 4888.6577939543895, 4914.140025495595, 4924.433690125681, 4977.676451030671, 5001.399272378343, 2102.863313884623, 2121.2045482943895, 2129.3186180422117, 2144.1316266911927, 2157.557700671359, 978.8629591857145, 1050.0549505445008, 1069.0378659206622, 1073.350622873166, 1089.9972025736342, 19154.904225478782, 19905.502362441053, 20167.294144704865, 20237.79762202359, 20261.189552417738, 1024.779672370444, 1035.7048241251357, 1041.6770801051546, 1065.0787069185099, 1074.3875990685235, 11110.50002749862, 11408.94295528517, 11460.140489463323, 11472.713182170513, 11593.24643898144, 486181.0, 493547.0, 498905.95392440556, 517408.0, 518891.0, 70015.64992175007, 94586.52706736422, 94796.0, 95126.0, 95313.5234323824, 1018.256672628985, 1037.4916291017348, 1037.5486663301488, 1047.8690163729534, 1072.5924148823397, 17367.0, 17811.643767124846, 17928.372506962194, 18015.369462068764, 18161.0, 40524.59475405208, 41688.79155604202, 42275.0, 42956.14087718166, 43460.130797383244, 57256.42743572511, 58607.4139258619, 58622.7068864653, 59013.409865900794, 59455.702721486115, 8543.8718419225, 8830.955845220733, 8867.68963086289, 9043.773905652411, 9091.045440228681, 12341.50633974631, 12757.936210318889, 12762.61712148637, 12955.222686638832, 13095.738085238432, 11052.613158539412, 11116.110711142928, 11210.719732006764, 11325.830112548483, 11424.714382140513, 11301.378424186749, 11352.148588856035, 11465.770684586094, 11522.654320370402, 11583.76832463363, 9937.155341795738, 11029.44852757375, 11195.216334856483, 11322.433878305887, 11344.376059316817, 8451.704190353554, 8529.829403411773, 8572.528510931708, 8761.474311541328, 8928.73213803587, 11017.0, 11073.446327683745, 11194.552217911518, 11236.94381528087, 11278.661640150809], "value": 9467.64039261205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.421591903036, 1588.97616535752, 1785.6785778559854, 1903.1911437639, 1905.0, 8549.358798090137, 8982.910170898289, 9129.269658427327, 9740.95129524353, 9765.316427850054, 8950.060243674418, 9106.134917182873, 9269.582868770905, 9295.860562091573, 9348.0, 2448.632705094237, 2487.5273697997322, 2489.4772097859473, 2512.8115391345723, 2517.7104632967166, 2418.262429958862, 2488.2659615413404, 2491.750824917503, 2495.2763698527406, 2496.3135137837057, 2469.4073422378588, 2476.4799392127675, 2483.217786397288, 2493.2395619336094, 2498.2130628851855, 2402.4834660547976, 2413.348395933097, 2423.660687503751, 2427.963580546293, 2441.377448750557, 2352.5765362234793, 2411.46947671512, 2417.492326611414, 2422.769836865495, 2445.144199530168, 9342.065793420672, 9353.0, 9365.578548965314, 9398.624055037859, 9400.858987115198, 5467.699276539789, 5612.017896868032, 5613.0, 5620.9601223773325, 5649.293838270216, 3543.1496440854266, 3618.421052631593, 3693.759905606127, 3710.443433484972, 3739.4577786221116, 1244.0, 1258.4462836351977, 1265.6329664397313, 1304.8303720516367, 1308.5877948446305, 13344.799828002588, 13661.0, 13699.383527741176, 13700.45198192071, 13716.451341946311, 4902.0, 5023.045621331935, 5035.244713293036, 5040.36995375578, 5045.344105266292, 11600.477978490819, 11634.883651163549, 11689.123315751352, 11693.123015773852, 11693.239939403911, 5615.466530679579, 5619.719014049281, 5621.353544342372, 5632.493075623213, 5636.013697602903, 4627.028324051987, 5072.847814565495, 5161.922571161435, 5179.792808287626, 5211.1922651989, 4392.956070439254, 4432.468103827497, 4445.044315472189, 4448.733076015449, 4456.286994080996, 1394.9930250348684, 1440.1287221231214, 1448.4351103069812, 1448.804411404468, 1457.3514785920377, 1073.6403304892792, 1077.6389909380446, 1081.2431298091367, 1084.3927400655657, 1085.8262677971486, 6445.774397896051, 6544.6727663617585, 6563.7702680405955, 6614.801555953329, 6633.237177724527, 492.6625261695678, 497.37082590523016, 502.62805523912044, 506.5162769555066, 510.33401411158053, 4309.612134907873, 4381.78091095444, 4401.273789824643, 4427.070315233773, 4434.645228381722, 11646.301221926711, 12107.334096624594, 12114.394280285951, 12129.757404851853, 12172.20880642773, 11957.820632690342, 11993.100517461226, 11995.0, 12008.699782505333, 12010.519579216909, 8490.193431623986, 8837.160469755363, 8838.911610883937, 8852.38033337673, 9012.909870901338, 6622.8344291393105, 6798.524103312919, 6866.896996544956, 6875.690593923386, 6933.445324373937, 11125.83311250348, 11130.220884538005, 11199.272047316897, 11277.266977646426, 11374.943125284652, 11358.432078396212, 11372.943135284271, 11395.0, 11479.0, 11500.884991149982, 8231.794205144919, 8338.124496927736, 8562.700305489278, 8572.65709371643, 8593.91406085956, 9465.95267023688, 9472.763180920532, 9475.763105922408, 9497.85753213716, 9505.239580833655, 8172.591370431336, 8332.916670833214, 8347.66609335644, 8381.245687887875, 8486.0, 8092.312153466786, 8242.010958684756, 8281.21328473794, 8386.161383861809, 8417.70538031166, 7643.044619422572, 7830.530168189927, 7839.529628222097, 7843.607819609111, 7850.882236766339, 5456.427075157051, 5465.262189604353, 5761.971190144022, 5854.795082172103, 6033.034714445667, 5826.854328641818, 5917.260342457193, 5921.319048309328, 5921.970390148022, 6047.123167140652], "value": 4972.681698359454, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3203784657764, 350.3763301323644, 355.2911940678347, 356.3621118198425, 357.41384130026745, 5789.942100578998, 5879.794207202749, 5898.439648233416, 5902.432441887777, 5908.350081491032, 5791.536677065835, 5806.44838740319, 5807.767689292434, 5811.73847176877, 5835.708214589275, 4337.240982828001, 4443.266860967937, 4450.087732014929, 4460.687751857371, 4466.865994020184, 4400.603945644892, 4402.779861006937, 4440.800163992628, 4461.843835465759, 4472.21736196166, 4403.911921761563, 4422.469303683562, 4433.428611405393, 4438.223310920592, 4512.458504979407, 4336.8265269389185, 4405.713628614129, 4406.9559304407185, 4422.800973956164, 4442.577955094293, 3832.9041773955596, 3859.954224261146, 3861.1698484825897, 3864.787436690981, 3868.477755502999, 5552.167174923753, 5573.6098473106895, 5610.4670056344585, 5634.690092044936, 5636.688957527394, 4961.355023846912, 5065.696058236517, 5086.982603479319, 5089.923651145235, 5131.230315452674, 6021.759129634809, 6071.692756752406, 6091.269047714259, 6098.8780224395705, 6135.938640613582, 4349.391085248036, 4352.7823608819435, 4352.911772056986, 4354.978225108885, 4356.847510337155, 6024.909626355608, 6127.84680382994, 6255.49956003514, 6281.96859015702, 6372.93627063728, 4313.762743049162, 4333.263345231318, 4361.345798130305, 4365.541618130114, 4372.213001659668, 4422.867313980586, 4423.646108311327, 4427.667924905645, 4428.693535407063, 4433.889152771142, 4956.182229932093, 5078.492150784966, 5117.437081920985, 5118.769655365518, 5140.203268493389, 6099.9085013724825, 6117.235345581802, 6125.223685131262, 6129.264488261437, 6135.466133466633, 1533.8159420869567, 1548.783170356151, 1551.8137823461032, 1551.9922400388152, 1553.7280975829185, 943.6131186213756, 972.1590823937244, 980.294188184506, 987.7728122531857, 992.717075633441, 5226.398964119175, 5314.7608357624, 5319.0213480451075, 5324.600654950894, 5421.241026256327, 5545.861353466195, 5583.190437386556, 5596.3284405870745, 5626.634268772516, 5641.605087643826, 5336.466353364633, 5457.426970168154, 5601.607887447921, 6002.939970600325, 6052.273727152769, 3349.7990120592845, 3354.446516324828, 3380.4422270325613, 3391.508231306496, 3414.8804791832167, 6361.936380636134, 6643.0, 6652.73389064432, 6686.732530698815, 6709.966450167718, 6427.839304017437, 6466.5473416861305, 6468.482521398371, 6473.8705225896165, 6507.3167317431935, 6346.428821406095, 6582.597351966593, 6635.5023373247195, 6646.933530664632, 6660.933390666129, 6314.715837787218, 6319.3364696706185, 6322.747090116344, 6335.873282534231, 6376.840578985562, 6116.633002019893, 6322.209723784527, 6332.968335158294, 6370.77702280418, 6371.617702937839, 6367.26776420699, 6459.4832413405875, 6461.515386345949, 6462.644554549545, 6512.381323774234, 4572.88567785808, 4588.541145885385, 4618.63050955916, 4619.584237418649, 4634.907301854011, 6210.839833049531, 6302.873942521215, 6358.968205158944, 6403.327650596807, 6438.8390290243115, 6017.939820601738, 6068.6965651716355, 6156.138140660221, 6156.876862462636, 6188.876222475616, 5925.940740592711, 6093.0, 6133.325334213144, 6145.324014358328, 6158.630482171084, 5949.970250148722, 5975.0, 6001.4298641628975, 6033.456988871023, 6069.575129740876, 6232.189815323979, 6243.188385509855, 6244.1570387997035, 6259.718312676032, 6262.874742505033, 5864.123480486203, 5994.670293133745, 6023.247094113236, 6036.826742372655, 6050.183225264533], "value": 4608.2290495741445, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.437783873724, 846.7078857794063, 875.2691502595331, 912.393258483109, 914.9313801464892, 17330.480085597435, 18045.729314060267, 18086.0, 18661.0, 18668.253269869223, 16345.591360216, 16648.33406663732, 16657.666846663058, 16671.49985500434, 16845.83154168458, 874.3791907745508, 889.888763904512, 891.1934699097311, 893.5621545442718, 894.3515950935584, 892.6206362296031, 894.5214310343968, 895.3374502867863, 896.4486840593054, 897.0088052701768, 941.0401390581603, 943.1370296178987, 943.3302355327692, 945.6170251048336, 945.754103932979, 932.2355668351954, 932.8880534335856, 933.869258303838, 934.8083642853233, 935.5228833295, 677.8915373540259, 678.3284548297199, 685.9965700171517, 688.1466980943644, 688.8932215506604, 16087.839121608751, 16185.91907040469, 16289.91855040729, 16293.022418654919, 16299.348026078942, 15087.170205638686, 15987.0, 16235.837641623551, 16591.834081659148, 16783.6643267134, 13202.603921882359, 13343.266120363473, 13413.731725365536, 13525.256110913895, 13612.183269003892, 4048.3725022621543, 4099.959000409987, 4108.67130629549, 4144.41978123063, 4197.391378250137, 64661.353386466006, 67157.3284267156, 67694.3230567693, 88105.55947220222, 89461.0, 11982.700432489257, 12033.518659253532, 12035.518579256732, 12494.375281235902, 12538.373081345897, 22469.213577524708, 22567.0, 22579.548409031726, 22611.982460789302, 22617.434564136027, 9377.343585949055, 9400.670976515788, 9421.71734847942, 9589.952050239704, 9759.65841195569, 5093.439721630618, 5211.166213405837, 5215.608829337815, 5323.121684922022, 5362.758675859518, 3841.654251117357, 3937.310970580137, 3942.5663177051074, 3944.526656801202, 3945.8618948337244, 668.2882729892649, 670.4100391655312, 675.1425689374466, 686.0224180542806, 699.1784653032666, 706.0891450029507, 775.309974123031, 795.8885755994049, 828.5774255129807, 832.2343444031505, 10063.748406289902, 10260.0, 10377.0, 10402.47987600617, 10461.529231184615, 799.1568894815908, 818.7420962396826, 821.3306155483263, 827.4538804389074, 843.1273631791066, 4988.72562009093, 5006.524380183877, 5053.722045287471, 5065.627665890027, 5120.539151476385, 107423.46288268665, 107449.0, 108260.45869770758, 114172.0, 115867.42066289614, 68330.31669683338, 70583.0, 99073.0, 99504.5024774886, 99660.0, 85210.57394712987, 87565.12434875697, 88116.55941720378, 88163.55918220368, 89141.55429222943, 9312.4638375131, 9513.476758778334, 9620.0, 9806.166475849634, 9813.618104244346, 36770.816145919096, 37503.43744843775, 47325.0, 51412.74293628508, 53768.46231537791, 71786.64106679642, 75918.0, 77000.61499692466, 77527.61236193783, 78119.60940195262, 13534.0, 13659.590212293648, 13935.930320348334, 14211.857881421054, 14468.131912084888, 15330.923345383648, 16222.837771622133, 16402.83597164061, 16433.589160271087, 16504.587385315463, 13941.930290348484, 14015.0, 15077.924610376878, 15118.470853520073, 15364.23178841031, 14684.77972830387, 14791.334389952694, 15087.622809429413, 15357.078575285519, 15861.365545378518, 14734.189619571027, 15179.772303415679, 15285.159316237714, 15511.301991410188, 15614.687706245584, 11899.226550274205, 11918.940405297919, 11959.940200298943, 12172.817407739069, 12222.388880556115, 12176.208546444454, 12254.0, 12373.75252494927, 12654.114212005072, 12757.872421275668], "value": 8122.262992115509, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 111.0, 113.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 131.0, 157.0, 179.0, 124.0, 162.0, 158.0, 134.0, 182.0, 125.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 164.0, 163.0, 162.0, 161.0, 162.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 166.0, 77.0, 77.0, 75.0, 75.0, 158.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 145.0, 85.0, 84.0, 85.0, 144.0, 84.0, 84.0, 152.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 119.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 146.0, 146.0, 147.0, 149.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 52.0, 61.0, 52.0, 53.0, 51.0, 57.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 85.0, 79.0, 80.0, 81.0, 83.0, 108.0, 78.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 127.0, 122.0, 129.0, 131.0, 123.0, 128.0, 123.0, 134.0, 139.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 157.0, 160.0, 155.0, 159.0, 160.0, 158.0, 155.0, 163.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 68.0, 63.0, 62.0, 72.0, 62.0, 61.0, 64.0, 63.0, 61.0], "value": 63.8, "unit": "score"}]}]} 00:43:50 INFO - Return code: 0 00:43:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:43:50 ERROR - # TBPL SUCCESS # 00:43:50 INFO - Running post-action listener: _resource_record_post_action 00:43:50 INFO - ##### 00:43:50 INFO - ##### Finished run-tests step (success) 00:43:50 INFO - ##### 00:43:50 INFO - Running post-run listener: _resource_record_post_run 00:43:50 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 36864; Write bytes: 458452992; Read time: 56; Write time: 395284 00:43:50 INFO - TinderboxPrint: CPU usage
13.3% 00:43:50 INFO - TinderboxPrint: I/O read bytes / time
36,864 / 56 00:43:50 INFO - TinderboxPrint: I/O write bytes / time
458,452,992 / 395,284 00:43:50 INFO - TinderboxPrint: CPU idle
8,189.6 (86.7%) 00:43:50 INFO - TinderboxPrint: CPU user
1,206.9 (12.8%) 00:43:50 INFO - TinderboxPrint: Swap in / out
0 / 0 00:43:50 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 235008000; Read time: 0; Write time: 284068 00:43:50 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 12288; Write bytes: 223137792; Read time: 44; Write time: 111196 00:43:51 INFO - Running post-run listener: _upload_blobber_files 00:43:51 INFO - Blob upload gear active. 00:43:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:43:51 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 00:43:51 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'] 00:43:51 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 00:43:51 INFO - (blobuploader) - INFO - Open directory for files ... 00:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:43:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:52 INFO - (blobuploader) - INFO - Done attempting. 00:43:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:43:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:43:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:53 INFO - (blobuploader) - INFO - Done attempting. 00:43:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:43:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:43:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:58 INFO - (blobuploader) - INFO - Done attempting. 00:43:58 INFO - (blobuploader) - INFO - Iteration through files over. 00:43:58 INFO - Return code: 0 00:43:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:43:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:43:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9abcb870a5d712c02fd374a4dff038e435764ff26115094a58b2ad269c98420198b015828b77921397b048ad7af6a1c5988a4e7290f0d838f6e0c7e254673910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb395b2504237b6a300342b6ff8833d21ca362d26395689160ca2f4e8a58a39f03d744b112bca14823fb803a8f0ef2e41ac6afcecc5a00a8bcd3da10c621d838", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbeb3ac4495ecd213ce5ad4b367e4ae6635ce9f2f8ee8805eb32556ccde3528088aa4bd1b3448c6d48fe11ebd5c5114dfc7b50a0f077766f3fb3a72c22f880d8"} 00:43:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:43:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:43:58 INFO - Contents: 00:43:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9abcb870a5d712c02fd374a4dff038e435764ff26115094a58b2ad269c98420198b015828b77921397b048ad7af6a1c5988a4e7290f0d838f6e0c7e254673910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb395b2504237b6a300342b6ff8833d21ca362d26395689160ca2f4e8a58a39f03d744b112bca14823fb803a8f0ef2e41ac6afcecc5a00a8bcd3da10c621d838", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbeb3ac4495ecd213ce5ad4b367e4ae6635ce9f2f8ee8805eb32556ccde3528088aa4bd1b3448c6d48fe11ebd5c5114dfc7b50a0f077766f3fb3a72c22f880d8"} 00:43:58 INFO - Running post-run listener: copy_logs_to_upload_dir 00:43:58 INFO - Copying logs to upload dir... 00:43:58 INFO - mkdir: /builds/slave/test/build/upload/logs 00:43:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.698711 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-05 00:43:57.980294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 00:43:57.984166) ========= 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=0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9abcb870a5d712c02fd374a4dff038e435764ff26115094a58b2ad269c98420198b015828b77921397b048ad7af6a1c5988a4e7290f0d838f6e0c7e254673910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb395b2504237b6a300342b6ff8833d21ca362d26395689160ca2f4e8a58a39f03d744b112bca14823fb803a8f0ef2e41ac6afcecc5a00a8bcd3da10c621d838", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbeb3ac4495ecd213ce5ad4b367e4ae6635ce9f2f8ee8805eb32556ccde3528088aa4bd1b3448c6d48fe11ebd5c5114dfc7b50a0f077766f3fb3a72c22f880d8"} build_url:https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9abcb870a5d712c02fd374a4dff038e435764ff26115094a58b2ad269c98420198b015828b77921397b048ad7af6a1c5988a4e7290f0d838f6e0c7e254673910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb395b2504237b6a300342b6ff8833d21ca362d26395689160ca2f4e8a58a39f03d744b112bca14823fb803a8f0ef2e41ac6afcecc5a00a8bcd3da10c621d838", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbeb3ac4495ecd213ce5ad4b367e4ae6635ce9f2f8ee8805eb32556ccde3528088aa4bd1b3448c6d48fe11ebd5c5114dfc7b50a0f077766f3fb3a72c22f880d8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 00:43:58.016848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:43:58.017485) ========= 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=0333a256a5e4f052382dd180000001b1-1470381245.765407-430014782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:43:58.101015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 00:43:58.101520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 00:43:58.101980) ========= ========= Total master_lag: 0.31 =========