builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1470381793.73 results: success (0) buildid: 20160804212522 builduid: 12fabcd8e57144588b832717041f2d82 revision: b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:13.727313) ========= 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:13.727794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-08-05 00:23:13.728123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-08-05 00:23:20.777567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:20.777932) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-08-05 00:23:21 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070168 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:20.888097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:20.892513) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015215 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:20.971301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:20.975797) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 00:23:21,400 truncating revision to first 12 chars 2016-08-05 00:23:21,401 Setting DEBUG logging. 2016-08-05 00:23:21,401 attempt 1/10 2016-08-05 00:23:21,401 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:21,935 unpacking tar archive at: mozilla-beta-b4ead0ffd25a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.896740 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:21.896683) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:21.897012) ========= script_repo_revision: b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:21.897558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:21.897980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 00:23:21.908499) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-05 00:23:21.908790) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942 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 --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', 00:23:22 INFO - 'system_bits': '32', 00:23:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:23:22 INFO - 'title': 'talos-linux64-ix-012', 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", 00:23:22 INFO - "repository": "", 00:23:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 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": 325, 00:23:22 INFO - "slavename": "talos-linux64-ix-012", 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:35 INFO - Downloaded 21968747 bytes. 00:23:35 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:35 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:36 INFO - Return code: 0 00:23:36 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:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:36 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:36 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:36 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:36 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:36 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:37 INFO - Downloaded 21968747 bytes. 00:23:37 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:37 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:40 INFO - Downloaded 10833369 bytes. 00:23:40 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:40 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:40 INFO - Return code: 0 00:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:40 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:40 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:40 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:40 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:40 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:41 INFO - Downloaded 55300789 bytes. 00:23:41 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:41 INFO - mkdir: /builds/slave/test/properties 00:23:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:23:41 INFO - Writing to file /builds/slave/test/properties/build_url 00:23:41 INFO - Contents: 00:23:41 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:42 INFO - Running post-action listener: _resource_record_post_action 00:23:42 INFO - Running post-action listener: set_extra_try_arguments 00:23:42 INFO - ##### 00:23:42 INFO - ##### Finished download-and-extract step (success) 00:23:42 INFO - ##### 00:23:42 INFO - ##### 00:23:42 INFO - ##### Running populate-webroot step. 00:23:42 INFO - ##### 00:23:42 INFO - Running pre-action listener: _resource_record_pre_action 00:23:42 INFO - Running main action method: populate_webroot 00:23:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:23:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:23:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:23:42 INFO - '--tppagecycles', 00:23:42 INFO - '7'], 00:23:42 INFO - 'tests': ['tsvgm']}}, 00:23:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:23:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:23:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:23:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:23:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:42 INFO - 'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:42 INFO - 'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['damp', 'tps']}, 00:23:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:42 INFO - 'tests': ['damp', 'tps']}, 00:23:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['dromaeo_dom']}, 00:23:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:23:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['a11yr', 00:23:42 INFO - 'ts_paint', 00:23:42 INFO - 'tpaint', 00:23:42 INFO - 'sessionrestore', 00:23:42 INFO - 'sessionrestore_no_auto_restore', 00:23:42 INFO - 'tabpaint']}, 00:23:42 INFO - 'other-e10s': {'tests': ['a11yr', 00:23:42 INFO - 'ts_paint', 00:23:42 INFO - 'tpaint', 00:23:42 INFO - 'sessionrestore', 00:23:42 INFO - 'sessionrestore_no_auto_restore', 00:23:42 INFO - 'tabpaint']}, 00:23:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:23:42 INFO - 'ts_paint', 00:23:42 INFO - 'tpaint', 00:23:42 INFO - 'sessionrestore', 00:23:42 INFO - 'sessionrestore_no_auto_restore', 00:23:42 INFO - 'tabpaint']}, 00:23:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:23:42 INFO - 'ts_paint', 00:23:42 INFO - 'tpaint', 00:23:42 INFO - 'sessionrestore', 00:23:42 INFO - 'sessionrestore_no_auto_restore', 00:23:42 INFO - 'tabpaint']}, 00:23:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['a11yr', 00:23:42 INFO - 'ts_paint', 00:23:42 INFO - 'tpaint', 00:23:42 INFO - 'sessionrestore', 00:23:42 INFO - 'sessionrestore_no_auto_restore', 00:23:42 INFO - 'tabpaint']}, 00:23:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['a11yr', 00:23:42 INFO - 'ts_paint', 00:23:42 INFO - 'tpaint', 00:23:42 INFO - 'sessionrestore', 00:23:42 INFO - 'sessionrestore_no_auto_restore', 00:23:42 INFO - 'tabpaint']}, 00:23:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['tsvgx', 00:23:42 INFO - 'tsvgr_opacity', 00:23:42 INFO - 'tart', 00:23:42 INFO - 'tscrollx', 00:23:42 INFO - 'cart']}, 00:23:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:23:42 INFO - 'tsvgr_opacity', 00:23:42 INFO - 'tart', 00:23:42 INFO - 'tscrollx', 00:23:42 INFO - 'cart']}, 00:23:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:42 INFO - 'talos_options': ['--disable-e10s'], 00:23:42 INFO - 'tests': ['tp5o']}, 00:23:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:42 INFO - 'tests': ['tp5o']}, 00:23:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:42 INFO - 'talos_options': ['--disable-e10s', 00:23:42 INFO - '--xperf_path', 00:23:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:42 INFO - 'tests': ['tp5n']}, 00:23:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:42 INFO - 'talos_options': ['--xperf_path', 00:23:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:42 INFO - 'tests': ['tp5n']}}, 00:23:42 INFO - 'talos.zip': {'path': '', 00:23:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:23:42 INFO - Running post-action listener: _resource_record_post_action 00:23:42 INFO - ##### 00:23:42 INFO - ##### Finished populate-webroot step (success) 00:23:42 INFO - ##### 00:23:42 INFO - ##### 00:23:42 INFO - ##### Running create-virtualenv step. 00:23:42 INFO - ##### 00:23:42 INFO - Running pre-action listener: _resource_record_pre_action 00:23:42 INFO - Running main action method: create_virtualenv 00:23:42 INFO - Creating virtualenv /builds/slave/test/build/venv 00:23:42 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:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:23:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:23:42 INFO - Using real prefix '/usr' 00:23:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:23:43 INFO - Installing distribute.............................................................................................................................................................................................done. 00:23:45 INFO - Installing pip.................done. 00:23:45 INFO - Return code: 0 00:23:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:23:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:45 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 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 00:23:45 INFO - 'HOME': '/home/cltbld', 00:23:45 INFO - 'LANG': 'en_US.UTF-8', 00:23:45 INFO - 'LANGUAGE': 'en_US:en', 00:23:45 INFO - 'LOGNAME': 'cltbld', 00:23:45 INFO - 'MAIL': '/var/mail/cltbld', 00:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:45 INFO - 'MOZ_NO_REMOTE': '1', 00:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:45 INFO - 'NO_EM_RESTART': '1', 00:23:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:45 INFO - 'PWD': '/builds/slave/test', 00:23:45 INFO - 'SHELL': '/bin/bash', 00:23:45 INFO - 'SHLVL': '1', 00:23:45 INFO - 'TERM': 'linux', 00:23:45 INFO - 'TMOUT': '86400', 00:23:45 INFO - 'USER': 'cltbld', 00:23:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:45 INFO - '_': '/tools/buildbot/bin/python'} 00:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:45 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:45 INFO - Cleaning up... 00:23:45 INFO - Return code: 0 00:23:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:23:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:45 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 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 00:23:45 INFO - 'HOME': '/home/cltbld', 00:23:45 INFO - 'LANG': 'en_US.UTF-8', 00:23:45 INFO - 'LANGUAGE': 'en_US:en', 00:23:45 INFO - 'LOGNAME': 'cltbld', 00:23:45 INFO - 'MAIL': '/var/mail/cltbld', 00:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:45 INFO - 'MOZ_NO_REMOTE': '1', 00:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:45 INFO - 'NO_EM_RESTART': '1', 00:23:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:45 INFO - 'PWD': '/builds/slave/test', 00:23:45 INFO - 'SHELL': '/bin/bash', 00:23:45 INFO - 'SHLVL': '1', 00:23:45 INFO - 'TERM': 'linux', 00:23:45 INFO - 'TMOUT': '86400', 00:23:45 INFO - 'USER': 'cltbld', 00:23:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:45 INFO - '_': '/tools/buildbot/bin/python'} 00:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:45 INFO - Downloading/unpacking psutil>=3.1.1 00:23:45 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:45 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:45 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:45 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:45 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:45 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:23:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:47 INFO - Installing collected packages: psutil 00:23:47 INFO - Running setup.py install for psutil 00:23:47 INFO - building 'psutil._psutil_linux' extension 00:23:47 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:47 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:47 INFO - building 'psutil._psutil_posix' extension 00:23:47 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:48 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:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:48 INFO - Successfully installed psutil 00:23:48 INFO - Cleaning up... 00:23:48 INFO - Return code: 0 00:23:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:48 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 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:48 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:48 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:48 INFO - Using env: {'DISPLAY': ':0', 00:23:48 INFO - 'HOME': '/home/cltbld', 00:23:48 INFO - 'LANG': 'en_US.UTF-8', 00:23:48 INFO - 'LANGUAGE': 'en_US:en', 00:23:48 INFO - 'LOGNAME': 'cltbld', 00:23:48 INFO - 'MAIL': '/var/mail/cltbld', 00:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:48 INFO - 'MOZ_NO_REMOTE': '1', 00:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:48 INFO - 'NO_EM_RESTART': '1', 00:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:48 INFO - 'PWD': '/builds/slave/test', 00:23:48 INFO - 'SHELL': '/bin/bash', 00:23:48 INFO - 'SHLVL': '1', 00:23:48 INFO - 'TERM': 'linux', 00:23:48 INFO - 'TMOUT': '86400', 00:23:48 INFO - 'USER': 'cltbld', 00:23:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:48 INFO - '_': '/tools/buildbot/bin/python'} 00:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:23:50 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:50 INFO - Installing collected packages: mozsystemmonitor 00:23:50 INFO - Running setup.py install for mozsystemmonitor 00:23:50 INFO - Successfully installed mozsystemmonitor 00:23:50 INFO - Cleaning up... 00:23:50 INFO - Return code: 0 00:23:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:23:50 INFO - Using env: {'DISPLAY': ':0', 00:23:50 INFO - 'HOME': '/home/cltbld', 00:23:50 INFO - 'LANG': 'en_US.UTF-8', 00:23:50 INFO - 'LANGUAGE': 'en_US:en', 00:23:50 INFO - 'LOGNAME': 'cltbld', 00:23:50 INFO - 'MAIL': '/var/mail/cltbld', 00:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:50 INFO - 'MOZ_NO_REMOTE': '1', 00:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:50 INFO - 'NO_EM_RESTART': '1', 00:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:50 INFO - 'PWD': '/builds/slave/test', 00:23:50 INFO - 'SHELL': '/bin/bash', 00:23:50 INFO - 'SHLVL': '1', 00:23:50 INFO - 'TERM': 'linux', 00:23:50 INFO - 'TMOUT': '86400', 00:23:50 INFO - 'USER': 'cltbld', 00:23:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:50 INFO - '_': '/tools/buildbot/bin/python'} 00:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:50 INFO - Downloading/unpacking jsonschema==2.5.1 00:23:50 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:50 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:50 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:50 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:50 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:50 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:23:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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:52 INFO - Downloading functools32-3.2.3-2.tar.gz 00:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:23:52 INFO - warning: no files found matching '*.txt' 00:23:52 INFO - no previously-included directories found matching 'build' 00:23:52 INFO - no previously-included directories found matching 'dist' 00:23:52 INFO - no previously-included directories found matching '.git*' 00:23:52 INFO - Installing collected packages: jsonschema, functools32 00:23:52 INFO - Running setup.py install for functools32 00:23:53 INFO - warning: no files found matching '*.txt' 00:23:53 INFO - no previously-included directories found matching 'build' 00:23:53 INFO - no previously-included directories found matching 'dist' 00:23:53 INFO - no previously-included directories found matching '.git*' 00:23:53 INFO - Successfully installed jsonschema functools32 00:23:53 INFO - Cleaning up... 00:23:53 INFO - Return code: 0 00:23:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:23:53 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:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:53 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:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:53 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 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:53 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:53 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:53 INFO - Using env: {'DISPLAY': ':0', 00:23:53 INFO - 'HOME': '/home/cltbld', 00:23:53 INFO - 'LANG': 'en_US.UTF-8', 00:23:53 INFO - 'LANGUAGE': 'en_US:en', 00:23:53 INFO - 'LOGNAME': 'cltbld', 00:23:53 INFO - 'MAIL': '/var/mail/cltbld', 00:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:53 INFO - 'MOZ_NO_REMOTE': '1', 00:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:53 INFO - 'NO_EM_RESTART': '1', 00:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:53 INFO - 'PWD': '/builds/slave/test', 00:23:53 INFO - 'SHELL': '/bin/bash', 00:23:53 INFO - 'SHLVL': '1', 00:23:53 INFO - 'TERM': 'linux', 00:23:53 INFO - 'TMOUT': '86400', 00:23:53 INFO - 'USER': 'cltbld', 00:23:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:53 INFO - '_': '/tools/buildbot/bin/python'} 00:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:53 INFO - Downloading/unpacking 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:55 INFO - Downloading blobuploader-1.2.4.tar.gz 00:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:23:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:23:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:56 INFO - Downloading docopt-0.6.1.tar.gz 00:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:23:56 INFO - Installing collected packages: blobuploader, requests, docopt 00:23:56 INFO - Running setup.py install for blobuploader 00:23:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:23:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:23:56 INFO - Running setup.py install for requests 00:23:56 INFO - Running setup.py install for docopt 00:23:56 INFO - Successfully installed blobuploader requests docopt 00:23:56 INFO - Cleaning up... 00:23:56 INFO - Return code: 0 00:23:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:56 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 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 00:23:56 INFO - 'HOME': '/home/cltbld', 00:23:56 INFO - 'LANG': 'en_US.UTF-8', 00:23:56 INFO - 'LANGUAGE': 'en_US:en', 00:23:56 INFO - 'LOGNAME': 'cltbld', 00:23:56 INFO - 'MAIL': '/var/mail/cltbld', 00:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:56 INFO - 'MOZ_NO_REMOTE': '1', 00:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:56 INFO - 'NO_EM_RESTART': '1', 00:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:56 INFO - 'PWD': '/builds/slave/test', 00:23:56 INFO - 'SHELL': '/bin/bash', 00:23:56 INFO - 'SHLVL': '1', 00:23:56 INFO - 'TERM': 'linux', 00:23:56 INFO - 'TMOUT': '86400', 00:23:56 INFO - 'USER': 'cltbld', 00:23:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:56 INFO - '_': '/tools/buildbot/bin/python'} 00:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:57 INFO - Running setup.py (path:/tmp/pip-WRwpeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:57 INFO - Running setup.py (path:/tmp/pip-Ac60wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:57 INFO - Running setup.py (path:/tmp/pip-cUDWGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:57 INFO - Running setup.py (path:/tmp/pip-08q2Us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:57 INFO - Running setup.py (path:/tmp/pip-mFBQFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:57 INFO - Running setup.py (path:/tmp/pip-OTySiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:57 INFO - Running setup.py (path:/tmp/pip-FHYAPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:57 INFO - Running setup.py (path:/tmp/pip-wuvChs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:57 INFO - Running setup.py (path:/tmp/pip-ZeY6kX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:57 INFO - Running setup.py (path:/tmp/pip-XxY8i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:57 INFO - Running setup.py (path:/tmp/pip-aKn4pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:57 INFO - Running setup.py (path:/tmp/pip-_zkbOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:57 INFO - Running setup.py (path:/tmp/pip-_vx4AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:57 INFO - Running setup.py (path:/tmp/pip-x7kR5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:58 INFO - Running setup.py (path:/tmp/pip-aRsQXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:58 INFO - Running setup.py (path:/tmp/pip-PIqaX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:58 INFO - Running setup.py (path:/tmp/pip-y6dsvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:23:58 INFO - Running setup.py install for manifestparser 00:23:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Running setup.py install for mozcrash 00:23:58 INFO - Running setup.py install for mozdebug 00:23:58 INFO - Running setup.py install for mozdevice 00:23:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Running setup.py install for mozfile 00:23:58 INFO - Running setup.py install for mozhttpd 00:23:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Running setup.py install for mozinfo 00:23:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:23:58 INFO - Running setup.py install for mozInstall 00:23:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Running setup.py install for mozleak 00:23:59 INFO - Running setup.py install for mozlog 00:23:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Running setup.py install for moznetwork 00:23:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Running setup.py install for mozprocess 00:23:59 INFO - Running setup.py install for mozprofile 00:23:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Running setup.py install for mozrunner 00:23:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:23:59 INFO - Running setup.py install for mozscreenshot 00:23:59 INFO - Running setup.py install for moztest 00:23:59 INFO - Running setup.py install for mozversion 00:24:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:24:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:24:00 INFO - Cleaning up... 00:24:00 INFO - Return code: 0 00:24:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:00 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 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:00 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:24:00 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:24:00 INFO - Using env: {'DISPLAY': ':0', 00:24:00 INFO - 'HOME': '/home/cltbld', 00:24:00 INFO - 'LANG': 'en_US.UTF-8', 00:24:00 INFO - 'LANGUAGE': 'en_US:en', 00:24:00 INFO - 'LOGNAME': 'cltbld', 00:24:00 INFO - 'MAIL': '/var/mail/cltbld', 00:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:00 INFO - 'MOZ_NO_REMOTE': '1', 00:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:00 INFO - 'NO_EM_RESTART': '1', 00:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:00 INFO - 'PWD': '/builds/slave/test', 00:24:00 INFO - 'SHELL': '/bin/bash', 00:24:00 INFO - 'SHLVL': '1', 00:24:00 INFO - 'TERM': 'linux', 00:24:00 INFO - 'TMOUT': '86400', 00:24:00 INFO - 'USER': 'cltbld', 00:24:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:00 INFO - '_': '/tools/buildbot/bin/python'} 00:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:24:00 INFO - Running setup.py (path:/tmp/pip-gAJ6V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:24:00 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:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:24:00 INFO - Running setup.py (path:/tmp/pip-w2gpe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:24:00 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:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:24:00 INFO - Running setup.py (path:/tmp/pip-6bJSv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:24:00 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:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:24:00 INFO - Running setup.py (path:/tmp/pip-tBNzLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:24:00 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:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:24:00 INFO - Running setup.py (path:/tmp/pip-4M8RHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:24:00 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:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:24:00 INFO - Running setup.py (path:/tmp/pip-b5gcD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:24:00 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:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:24:00 INFO - Running setup.py (path:/tmp/pip-RgcyVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:24:00 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:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:24:00 INFO - Running setup.py (path:/tmp/pip-CBRhSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:24:00 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:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:24:00 INFO - Running setup.py (path:/tmp/pip-71mHhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:24:00 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:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:24:00 INFO - Running setup.py (path:/tmp/pip-3ZIEuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:24:01 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:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:24:01 INFO - Running setup.py (path:/tmp/pip-2a63zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:24:01 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:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:24:01 INFO - Running setup.py (path:/tmp/pip-G4lEei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:24:01 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:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:24:01 INFO - Running setup.py (path:/tmp/pip-aw3EYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:24:01 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:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:24:01 INFO - Running setup.py (path:/tmp/pip-N7rXs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:24:01 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:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:24:01 INFO - Running setup.py (path:/tmp/pip-sqeok5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:24:01 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:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:24:01 INFO - Running setup.py (path:/tmp/pip-kXgVfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:24:01 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:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:24:01 INFO - Running setup.py (path:/tmp/pip-_IXBOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:24:01 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:24:01 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:24:01 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:24:01 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:24:01 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:24:01 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:24:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:03 INFO - Downloading blessings-1.6.tar.gz 00:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:24:03 INFO - Installing collected packages: blessings 00:24:03 INFO - Running setup.py install for blessings 00:24:03 INFO - Successfully installed blessings 00:24:03 INFO - Cleaning up... 00:24:03 INFO - Return code: 0 00:24:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:24:03 INFO - Reading from file tmpfile_stdout 00:24:03 INFO - Current package versions: 00:24:03 INFO - argparse == 1.2.1 00:24:03 INFO - blessings == 1.6 00:24:03 INFO - blobuploader == 1.2.4 00:24:03 INFO - docopt == 0.6.1 00:24:03 INFO - functools32 == 3.2.3-2 00:24:03 INFO - jsonschema == 2.5.1 00:24:03 INFO - manifestparser == 1.1 00:24:03 INFO - mozInstall == 1.12 00:24:03 INFO - mozcrash == 0.17 00:24:03 INFO - mozdebug == 0.1 00:24:03 INFO - mozdevice == 0.48 00:24:03 INFO - mozfile == 1.2 00:24:03 INFO - mozhttpd == 0.7 00:24:03 INFO - mozinfo == 0.9 00:24:03 INFO - mozleak == 0.1 00:24:03 INFO - mozlog == 3.2 00:24:03 INFO - moznetwork == 0.27 00:24:03 INFO - mozprocess == 0.23 00:24:03 INFO - mozprofile == 0.28 00:24:03 INFO - mozrunner == 6.12 00:24:03 INFO - mozscreenshot == 0.1 00:24:03 INFO - mozsystemmonitor == 0.3 00:24:03 INFO - moztest == 0.7 00:24:03 INFO - mozversion == 1.4 00:24:03 INFO - psutil == 3.1.1 00:24:03 INFO - requests == 1.2.3 00:24:03 INFO - wsgiref == 0.1.2 00:24:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:24:03 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:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:03 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:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:03 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 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 00:24:03 INFO - 'HOME': '/home/cltbld', 00:24:03 INFO - 'LANG': 'en_US.UTF-8', 00:24:03 INFO - 'LANGUAGE': 'en_US:en', 00:24:03 INFO - 'LOGNAME': 'cltbld', 00:24:03 INFO - 'MAIL': '/var/mail/cltbld', 00:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:03 INFO - 'MOZ_NO_REMOTE': '1', 00:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:03 INFO - 'NO_EM_RESTART': '1', 00:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:03 INFO - 'PWD': '/builds/slave/test', 00:24:03 INFO - 'SHELL': '/bin/bash', 00:24:03 INFO - 'SHLVL': '1', 00:24:03 INFO - 'TERM': 'linux', 00:24:03 INFO - 'TMOUT': '86400', 00:24:03 INFO - 'USER': 'cltbld', 00:24:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:03 INFO - '_': '/tools/buildbot/bin/python'} 00:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 INFO - Cleaning up... 00:24:04 INFO - Return code: 0 00:24:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:04 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 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:04 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:04 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:04 INFO - Using env: {'DISPLAY': ':0', 00:24:04 INFO - 'HOME': '/home/cltbld', 00:24:04 INFO - 'LANG': 'en_US.UTF-8', 00:24:04 INFO - 'LANGUAGE': 'en_US:en', 00:24:04 INFO - 'LOGNAME': 'cltbld', 00:24:04 INFO - 'MAIL': '/var/mail/cltbld', 00:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:04 INFO - 'MOZ_NO_REMOTE': '1', 00:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:04 INFO - 'NO_EM_RESTART': '1', 00:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:04 INFO - 'PWD': '/builds/slave/test', 00:24:04 INFO - 'SHELL': '/bin/bash', 00:24:04 INFO - 'SHLVL': '1', 00:24:04 INFO - 'TERM': 'linux', 00:24:04 INFO - 'TMOUT': '86400', 00:24:04 INFO - 'USER': 'cltbld', 00:24:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:04 INFO - '_': '/tools/buildbot/bin/python'} 00:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:24:04 INFO - Cleaning up... 00:24:04 INFO - Return code: 0 00:24:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:04 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 0x7facaf59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', '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:04 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:04 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:04 INFO - Using env: {'DISPLAY': ':0', 00:24:04 INFO - 'HOME': '/home/cltbld', 00:24:04 INFO - 'LANG': 'en_US.UTF-8', 00:24:04 INFO - 'LANGUAGE': 'en_US:en', 00:24:04 INFO - 'LOGNAME': 'cltbld', 00:24:04 INFO - 'MAIL': '/var/mail/cltbld', 00:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:04 INFO - 'MOZ_NO_REMOTE': '1', 00:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:04 INFO - 'NO_EM_RESTART': '1', 00:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:04 INFO - 'PWD': '/builds/slave/test', 00:24:04 INFO - 'SHELL': '/bin/bash', 00:24:04 INFO - 'SHLVL': '1', 00:24:04 INFO - 'TERM': 'linux', 00:24:04 INFO - 'TMOUT': '86400', 00:24:04 INFO - 'USER': 'cltbld', 00:24:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:04 INFO - '_': '/tools/buildbot/bin/python'} 00:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:04 INFO - Downloading/unpacking 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:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:24:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:24:06 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:06 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:06 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:06 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:06 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:06 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:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:24:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:24:06 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:06 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:06 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:06 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:06 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:06 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:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:24:06 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:06 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:06 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:06 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:06 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:06 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:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:24:07 INFO - no previously-included directories found matching 'docs/_build' 00:24:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:24:07 INFO - Running setup.py install for pep8 00:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:24:07 INFO - no previously-included directories found matching 'docs/_build' 00:24:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:24:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:24:07 INFO - Cleaning up... 00:24:07 INFO - Return code: 0 00:24:07 INFO - Running post-action listener: _resource_record_post_action 00:24:07 INFO - Running post-action listener: _start_resource_monitoring 00:24:07 INFO - Starting resource monitoring. 00:24:07 INFO - ##### 00:24:07 INFO - ##### Finished create-virtualenv step (success) 00:24:07 INFO - ##### 00:24:07 INFO - ##### 00:24:07 INFO - ##### Running install step. 00:24:07 INFO - ##### 00:24:07 INFO - Running pre-action listener: _resource_record_pre_action 00:24:07 INFO - Running main action method: install 00:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:24:07 INFO - Reading from file tmpfile_stdout 00:24:07 INFO - Detecting whether we're running mozinstall >=1.0... 00:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:24:07 INFO - Reading from file tmpfile_stdout 00:24:07 INFO - Output received: 00:24:07 INFO - Usage: mozinstall [options] installer 00:24:07 INFO - Options: 00:24:07 INFO - -h, --help show this help message and exit 00:24:07 INFO - -d DEST, --destination=DEST 00:24:07 INFO - Directory to install application into. [default: 00:24:07 INFO - "/builds/slave/test"] 00:24:07 INFO - --app=APP Application being installed. [default: firefox] 00:24:07 INFO - mkdir: /builds/slave/test/build/application 00:24:07 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:07 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:20 INFO - Reading from file tmpfile_stdout 00:24:20 INFO - Output received: 00:24:20 INFO - /builds/slave/test/build/application/firefox/firefox 00:24:20 INFO - Running post-action listener: _resource_record_post_action 00:24:20 INFO - ##### 00:24:20 INFO - ##### Finished install step (success) 00:24:20 INFO - ##### 00:24:20 INFO - ##### 00:24:20 INFO - ##### Running run-tests step. 00:24:20 INFO - ##### 00:24:20 INFO - Running pre-action listener: _resource_record_pre_action 00:24:20 INFO - Running main action method: run_tests 00:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:24:20 INFO - Python 2.7.3 00:24:20 INFO - Return code: 0 00:24:20 INFO - grabbing minidump binary from tooltool 00:24:20 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:20 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 0x25051c0>, '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 0x25060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:24:20 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:20 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:20 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:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:24:20 INFO - Return code: 0 00:24:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:24:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:24:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:24:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:24:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:24:21 INFO - Return code: 0 00:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:24:21 INFO - Using env: {'DISPLAY': ':0', 00:24:21 INFO - 'HOME': '/home/cltbld', 00:24:21 INFO - 'LANG': 'en_US.UTF-8', 00:24:21 INFO - 'LANGUAGE': 'en_US:en', 00:24:21 INFO - 'LOGNAME': 'cltbld', 00:24:21 INFO - 'MAIL': '/var/mail/cltbld', 00:24:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:24:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:21 INFO - 'MOZ_NO_REMOTE': '1', 00:24:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:21 INFO - 'NO_EM_RESTART': '1', 00:24:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:21 INFO - 'PWD': '/builds/slave/test', 00:24:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:24:21 INFO - 'SHELL': '/bin/bash', 00:24:21 INFO - 'SHLVL': '1', 00:24:21 INFO - 'TERM': 'linux', 00:24:21 INFO - 'TMOUT': '86400', 00:24:21 INFO - 'USER': 'cltbld', 00:24:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942', 00:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:21 INFO - '_': '/tools/buildbot/bin/python'} 00:24:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f7RoPVv9QbSn2sxrhHbFeg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:24:22 INFO - mozversion application_buildid: 20160804212522 00:24:22 INFO - mozversion application_changeset: b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb 00:24:22 INFO - mozversion application_display_name: Firefox 00:24:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:24:22 INFO - mozversion application_name: Firefox 00:24:22 INFO - mozversion application_remotingname: firefox 00:24:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:24:22 INFO - mozversion application_vendor: Mozilla 00:24:22 INFO - mozversion application_version: 49.0 00:24:22 INFO - mozversion platform_buildid: 20160804212522 00:24:22 INFO - mozversion platform_changeset: b4ead0ffd25ac75f0ef6124f34b74e86c1d573eb 00:24:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:24:22 INFO - mozversion platform_version: 49.0 00:24:22 INFO - using testdate: 1470381862 00:24:22 INFO - actual date: 1470381862 00:24:22 INFO - starting webserver on 'localhost:56974' 00:24:22 INFO - SUITE-START | Running 2 tests 00:24:22 INFO - TEST-START | dromaeo_css 00:24:22 INFO - operating with platform_type : linux_ 00:24:22 INFO - Initialising browser for dromaeo_css test... 00:24:22 INFO - TEST-INFO | started process 717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNDAdD4/profile http://localhost:56974/getInfo.html) 00:24:25 INFO - PROCESS | 717 | __metrics Screen width/height:1600/1200 00:24:25 INFO - PROCESS | 717 | colorDepth:24 00:24:25 INFO - PROCESS | 717 | Browser inner width/height: 1024/697 00:24:25 INFO - PROCESS | 717 | __metrics 00:24:25 INFO - PROCESS | 717 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:24:25 ERROR - PROCESS | 717 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:24:26 INFO - TEST-INFO | 717: 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 815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNDAdD4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:38 INFO - PROCESS | 815 | RSS: Main: 141168640 00:24:38 INFO - PROCESS | 815 | 00:25:29 INFO - PROCESS | 815 | 1470381929293 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:37 INFO - PROCESS | 815 | Cycle 1(1): loaded http://localhost:56974/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56974/tests/dromaeo/cssquery-ext.html) 00:27:38 INFO - PROCESS | 815 | RSS: Main: 250130432 00:27:38 INFO - PROCESS | 815 | 00:30:40 INFO - PROCESS | 815 | Cycle 1(1): loaded http://localhost:56974/tests/dromaeo/cssquery-ext.html (next: http://localhost:56974/tests/dromaeo/cssquery-jquery.html) 00:30:41 INFO - PROCESS | 815 | RSS: Main: 228605952 00:30:41 INFO - PROCESS | 815 | 00:33:43 INFO - PROCESS | 815 | Cycle 1(1): loaded http://localhost:56974/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56974/tests/dromaeo/cssquery-mootools.html) 00:33:43 INFO - PROCESS | 815 | RSS: Main: 228478976 00:33:43 INFO - PROCESS | 815 | 00:36:45 INFO - PROCESS | 815 | Cycle 1(1): loaded http://localhost:56974/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56974/tests/dromaeo/cssquery-prototype.html) 00:36:46 INFO - PROCESS | 815 | RSS: Main: 221376512 00:36:46 INFO - PROCESS | 815 | 00:39:48 INFO - PROCESS | 815 | Cycle 1(1): loaded http://localhost:56974/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56974/tests/dromaeo/cssquery-yui.html) 00:39:49 INFO - PROCESS | 815 | RSS: Main: 209793024 00:39:49 INFO - PROCESS | 815 | 00:42:51 INFO - PROCESS | 815 | Cycle 1(1): loaded http://localhost:56974/tests/dromaeo/cssquery-yui.html (next: http://localhost:56974/tests/dromaeo/cssquery-dojo.html) 00:42:52 INFO - PROCESS | 815 | RSS: Main: 257654784 00:42:52 INFO - PROCESS | 815 | 00:42:52 INFO - PROCESS | 815 | __start_tp_report 00:42:52 INFO - PROCESS | 815 | _x_x_mozilla_page_load 00:42:52 INFO - PROCESS | 815 | _x_x_mozilla_page_load_details 00:42:52 INFO - PROCESS | 815 | |i|pagename|runs| 00:42:52 INFO - PROCESS | 815 | |0;dojo.html;3365.2932884094344;3383.5601371821667;3384.323135372926;3414.6414626464207;3419.9829000855007;5502.477264659856;5567.109262517998;5571.359293681227;5584;5613.410591887854;5471.50756431921;5517.531009864157;5520.861978450541;5529.834104976857;5562.721863906809;4884.316195732583;4922.655414121013;4947.579455746266;4949.381327334083;4987.301777751118;4951.207806750921;4960.082384758831;4960.727160006199;4965.851024469272;5011.649184557083;4962.156433406311;4981.750912454363;5068.670536415139;5073.746312684351;5100.795968161269;4947.703137811743;5008.098542262392;5053.873653158664;5064.493550644925;5077.720725360104;4789.592884604813;4816.710997340171;4819.879503012417;4841.298011788271;4889.6088312935235;5327.866803329909;5359.651622644555;5361.142217245222;5379.246905433242;5382.30030096085;5713.114467257582;5797.275340582427;5827.883442331172;5840.8247752567495;5844.912326315109;5802.941970580325;5865.237519122529;5879.970600147015;5932.762689492415;5967.761289548413;5533.778648854041;5556.16657501374;5583.748731307101;5584.776608935637;5585.636933599303;5872.853178670567;6055.757769689163;6065.909588114823;6115.1744514490865;6116.969415152896;5768.3366412862215;5831.679257640785;5835.183074369592;5902.970485147547;5931.58478906481;5941.70291485424;5952.821415357546;5956.672383018976;5957.821265362046;5962.3739507351975;5714.114312281603;5815.360310365856;5915.08316210988;5953.761849526057;5957.076653118774;5851.385604511465;5877.853053673693;5915.142304365929;5917.733701983421;5958.851028724316;4536.387587675622;4542.931856022163;4543.5002149763495;4545.136424079415;4567.383403240587;3985.3025720498795;3993.520777506718;4020.4170395292517;4060.5127384714024;4098.877033688994;5651.57613179005;5668.206451096849;5680.943190568124;5681.233033540502;5701.2018317435595;5917.497012753965;5948;5948.196993405835;5948.226730525004;5984.73068711909;5532.834014979557;5667.149927510906;5676.290463692038;5716.056850619601;5717.142428635738;5151.072806894795;5152.3044389007;5156.1492353761205;5157.690538567698;5159.922601160985;6135.171751813448;6171.13604095418;6183.288921774054;6195.504359651217;6201.131841542187;5730.283714535683;5831.912521312269;5891.646501209942;5896.528277737685;5957.880842383215;6137.3862613738265;6143.84640383994;6158.538109641705;6159.353267906805;6164.198654174928;5677.74450149736;5870.207521984477;5872.55955803325;5873.911891321719;5880.852978675396;5818.50542703858;5835;5892.027815410409;5958.97020514912;5959.195508606283;5750.7987220447085;5768.7404066817935;5782.884342313214;5792.21805056312;5794.159846822272;5632.295963004624;5716.114002329646;5802.071668533014;5806.361300256884;5810.099434587646;5628.971855140698;5721.685307308138;5723.427657234243;5725.541956643375;5759.366469688414;5863.677497737665;5864;5868.501177399969;5871.412858714265;5903.380145084704;5570.832875013594;5607.943920560905;5660.433956604306;5696.572757043155;5749.166370876116 00:42:52 INFO - PROCESS | 815 | |1;ext.html;593.5340757505356;642.8425035866212;645.6707079389513;657.7927952694902;659.5844617890729;32754;35479.64520354796;35500.822495887514;35572.644273557285;45400.54599454004;44498.55501444985;47832.28251576221;47954.52045479544;47981.28028079573;48069.759651201784;9006.819863602725;9211.493367864765;9212.907870921306;9217.631294748202;9221.861672074925;8151.592420378987;9015.639374425047;10552.736181595445;10772.56909723614;10789.352638841656;11062.39156846373;11120.332780033224;11130.610428635;11133.7216569586;11135.944320278388;10917.672469825919;10977;10984.945075274572;10989.945050274777;10990.615328463506;10856.294340867818;10932.289401188897;10942.507587158598;10943.124550035978;10945.069669078139;44068;44414.77792611049;44469.11061778746;44513.33230001553;44526.33210501845;3791.241751649681;3880.554166893524;4511.684182107254;4564.840230591946;4587.266037434028;34126.82936585326;34165.829170853984;34361.14097147567;34519.13702157441;35731.28537429237;4592.127495775825;4631.907361852778;4674.205385084544;4691.15559199344;4703.318018887277;375324.1233793841;375905;377295;377756;378530;37729.62270377261;60572.697136514034;60698;60763.08855367173;60902.69548652229;38720.22559548793;40655.7967210162;40662.59337406647;40733.1853362937;40754;17561.38535151289;17773.644527109387;17799.377021804175;17830.37593684215;17847.73228401575;12457.875421245853;14519.564413067625;15167.317470713844;15295.617609559627;15304.540863774104;9071.501067441222;9120.407173533698;9162.312826538036;9229.815403691888;9271.860922086174;3450.4306789379975;3521.8063006534376;3529.3823580873245;3546.964530354715;3587.712982961357;1066.7279843639822;1154.520873837365;1188.2454641302836;1190.5475919150667;1239.3741160713782;32433.837830810695;33153.3369332612;33525.49711754326;34047;34077.14807129792;1089.782043591285;1171.654361963223;1204.391782150026;1239.3307613888398;1251.9624411267675;15904.44334448312;16330.510084697478;16338.591535211477;16586.6682666346;17055.658886822195;676296;681012;681574;682840;683550;59508.40491595115;59751.402485974584;60296.69851650801;60359;60446;1328.2827273272326;1445.645816774897;1454.8326942401548;1491.9701605968037;1495.7008598280388;32543.674563254066;33311.83344083264;33406.331873362884;33513.664863351056;33867.830660846535;51177;51738;51841.48158518367;51892.221616676536;51905;352319;472975.90536141297;475318;478577;481056;44678;44869;45249.32126018178;45414;46030.30954535618;49025.754871225414;49350;50551.241731373324;50848.74575627098;58948;44810.55189448064;45206.77396612996;47904;48516.7574162141;49572.00855982932;46132.53867461282;46141.30788038249;47067.76466117647;47307.290390644856;48575;47684.284735728295;48505.27242091301;48740;48880.755596223215;49052;40664.662161491244;43406.56593434025;43652;43855.34216986811;43914.56085439105;30543.847280763453;30626.234344141576;30807.845960770053;30936.226594335323;31062.844685776425 00:42:52 INFO - PROCESS | 815 | |2;jquery.html;427.98930026749315;432.80956379193157;437.28591210553174;437.7633186248848;447.42952735262554;18818.717719234224;19649;20281.695774563374;21033.894830525864;21100.100990910814;18956.431307060775;18993.05034748264;19660.508487287825;19675.803241967576;19694.409167724993;5596.888062238752;5745.138229265623;5797.681127537984;5801.883962320751;5804.390538993408;5597;5705.971470142665;5808.477237048664;5908.379620139888;5910.793122240722;5807.970960145193;5952.285725712921;5972.761089556412;5987.311459182184;6385.872282554346;6318.2733985591785;6380.553361264713;6439.64581947995;6445.484361251112;6452.2257329120575;5850.473457388855;5960.374160713106;5987.790427335066;5994.400559944014;5998.7600495980105;14319.78520322196;16362.509124726277;22283.777162228333;23141.537169256688;23207.883960580257;2345.5895218336723;2383.797377222938;2395.3652282145244;2504.2987963370288;2529.4435224250637;10289.3311934724;10298.073173414354;10325.173986081096;10863.83704244437;10887.564497420093;1961.2449207055245;2091.5398612305266;2101.0650260634025;2102.95794084119;2116.5555233401005;59207.703961479914;61422.69288653528;67814;70748.6462567689;71067;11057.447127643585;11306.491207895664;11395.658130256106;11500.367479788525;11608.071354291636;16389.754153687467;16407.42574009928;16441.342346306013;16562.50312490627;16566.254518546695;7596.3922886168975;7985.880211796828;8191.426600138052;8538.615762290712;8583.785405364915;8112.6349314281;8324.875126873101;8354.081051084377;8427.32581393487;8481.745547633582;4981.452040275567;5004.324416203839;5013.548780609763;5016.197408414636;5105.795768169231;2000.9499762506055;2054.907529161191;2081.9375418737463;2084.2392526727635;2115.4288342147534;992.905673960987;1045.8797238317538;1105.0717397386234;1118.9888101118884;1121.3328069798456;17989.280428782964;19268;19347;19496.51258718515;20643;1040.9739756506149;1041.8124737547314;1070.4166229404993;1078.3637653784306;1078.439211609974;10739.516721747541;11175.888241117647;11177.161712871404;11185;11266.380349080879;564968;566114;568424;577926;582159;59349;61168;83695;93832;94523.52738236402;994.3983889746744;1045.1795340657548;1103.5309993252995;1114.4817659788237;1116.8827273136367;17264.65470690554;17354.566135846704;17363.47909562715;17517.56206094807;17729.734053989458;40783.59216407798;41547.7922610385;42124.57875421207;42150.57849421589;43233.78383108064;57994.130088049555;58566.70716646389;59067.70466147642;59116.11325830202;59491;8566.400351975302;8642.913570864212;8683.784270202303;8895.154960278764;8949.865752013855;11729.882701172879;12922.483100675867;12985.675358116123;13062.673433164247;13072.934635326763;10983.340999539734;11145.609903653332;11192.160587955774;11225.66323010311;11250.212485125963;11338.263012904135;11385.601503947322;11464.770704586028;11467;11560.6531804046;11065.114790816877;11335;11418.143639226924;11580.768384632092;11621.186516943733;8452.492850428995;8524.27543658796;8615.956920215358;8729.65081396737;8856.424332418372;8884.822303553763;10653.467326633792;11485.655430337103;11537.307761534335;11550.191486595857 00:42:52 INFO - PROCESS | 815 | |3;mootools.html;1522.535626633877;1562.2891584329127;1746.7816522934634;1873.7845147808007;1897.3643829317186;9213.309001824864;9766.804663906718;9859.112679858812;9862.35894666847;9866.45734484603;8411.537365444898;8634.74095777126;9153.40502867313;9352.064793520645;9494.715158545238;2371.691680081591;2394.8802559872024;2397.041183526586;2401.9639705404434;2402.927912162629;2447.5227330670527;2479.6404521344393;2519.911803086892;2521.1932181701864;2522.495500899818;2152.6770984352315;2356.2813341930705;2454.337328921199;2454.5459090068393;2471.480988992305;2440.7437219092008;2442.3894026493376;2447.816413768957;2463.938401539967;2480.0947654106303;2409.3737825769995;2415.975840241593;2447.6328550717535;2450.130203777651;2485.614729716897;9539.713808585753;9549.665761698307;9605.327627066108;9636.180924621416;9646.131848133702;5356.651817631841;5482.945170548283;5490.972545137289;5493.121100623921;5495.642783219078;3583.3191693578137;3643.7631553949172;3746.662800347982;3752.061984503874;3752.81235938202;1185.0401175048153;1240.1806609328182;1253.078986944595;1273.1215461331744;1290.3612711707672;13723.1079979801;13730.313484325743;13745.862541374658;13756.380962856696;13789.931050344785;4886.218205087169;5056.57019153376;5078.339815823993;5104.9489505104475;5154;10292.279540432248;10326.845097323547;10367.066963973128;10384.480775961172;10389.37663740178;5425.83722488326;5467.425920278393;5469.808556700496;5473.151661492475;5476.069068258405;5019.347484826949;5119.385673719177;5120.5391514763105;5247.081760691864;5294.497022782906;3860.0542866997766;3905.628965248354;3951.604839516083;3964;3998.8600398986478;1134.466800603715;1184.6505280942142;1210.5883999440232;1212.9090318225992;1306.5557710378516;1047.8690163729534;1052.4737631184407;1057.7567159553346;1128.0637071231022;1131.5530365505579;6156.168917196211;6418.19772528434;6437.517186211053;6503.447206987365;6621.9006714899315;967.3760424526141;1071.844582535528;1096.3476731344838;1105.3312745788842;1145.478807142748;4451.888702782391;4489.859111317588;4552.385427967249;4582.725036497821;4646.047560250141;11756.35340056288;12037.879621203676;12039.879601204051;12058.397080146133;12075;11172.664820055412;11629.360385178727;11850.466728997217;11913.16607837443;11969.102317326235;8760.299176065899;8906.376553641312;8931.374803763674;8981.056989016059;8985.101489850962;6299.338569450325;6417.294097649348;6452.451541619015;6508.219013718384;6521.836954076186;10613.787724245627;10894.945525272324;10941.56233750641;10964.725881853017;11069.612563560559;11162.665120046411;11179.72050698739;11270.098392128446;11296.209265351346;11297.096232301561;8100.554469504234;8276.917230827856;8440.95779521123;8446.450980686235;8572.871406928776;9086.22767064807;9090.681826136053;9150.63397464094;9192.080791921022;9205.723828285161;8202.917970820215;8242.464239824392;8261.752147435587;8332.541710205754;8580.313574914117;7984.520928744294;8029.357651387758;8080.111187769458;8121.350291976746;8461.576921153795;7287.708491660274;7712.38300935935;7713.305802477804;7726.536407815549;7727.768166955;5502.147167189092;5595.804146854841;5626.606137570331;5688.317401911797;5779.2775903012125;5746.827595172152;5749.942500574941;5805.448482394166;5863.912041319299;5969.015112506561 00:42:52 INFO - PROCESS | 815 | |4;prototype.html;344.107042225425;347.89563131060675;351.9243362677024;354.88998410492746;359.48593511278875;5450.264214331064;5480.287562616864;5495.093309603921;5500.697461639613;5520.641158324706;5369.973150134244;5390.487903649157;5391.78432862686;5392.2181283713835;5407.918881216775;4111.691623128255;4266.87199384019;4297.699161058727;4303.978480107595;4310.913781724364;4273.807678654468;4295.7852107394665;4296.613304802567;4307.483102027745;4308.116836048603;4266.421424073097;4276.486821581415;4286.378475121106;4289.185054839586;4307.440032795732;4162.292410290258;4204.159168166364;4216.894577635553;4270.765107919063;4272.530021697611;3781.2059467511854;3796.886093417202;3802.7718336899875;3803.581606023363;3815.6184381561898;5199.752059505729;5264.842054738364;5313.176457649032;5319.414864364917;5345.118055520873;4685.4143232095985;4945;4946.159152944008;4957.182064959277;4983.476734942851;5646.983542962265;5658;5684.943150568482;5727.255456790632;5743.396943320933;4169.332906734908;4190.91618167638;4195.748255104703;4210.473690788652;4225.661947044229;5622.803201887914;5635.21107045014;5749.31008279005;5959.480332515224;5969.37321581232;4301.290287102655;4327;4329.653627709776;4350.32569951658;4356.803943822536;4393.121375724804;4403.713758605681;4421.292593185075;4443.800028998703;4445.133199026223;4732.952670473252;4817.421909370828;4865.829695960624;4880.048390563877;4904.141775189328;5722.7424765885635;5723.399043100498;5729.341125770507;5733.283339582552;5735.827925162252;1458.0231245065831;1498.932548035341;1515.8484151584973;1520.0651599266594;1524.41310095614;950.6720181537358;954.7279025477706;961.2937036759807;969.8448248280382;975.3757595139117;4809.422869255712;4977.983916513817;4985.975070124626;5024.346834911438;5045.117104506697;5234.555062819627;5244.325394049062;5251.264822924793;5268.736563171826;5274.525292723673;4944.332515110486;4993.625478089158;5057.432196019246;5070.76886170084;5084.9745751271;2621.108823000189;2759.530879750447;2776.194903478009;2780.887644941999;2787.4703806276743;5273.78904843802;5278.181881808326;5278.498542638443;5309.778750887318;5345.567766666158;5210.400803907523;5259.105951988171;5274.7626356814035;5300.284461597712;5301.395051365109;4929.584503593213;5252;5354.812581559705;5403.51403364078;5424.606069084055;5055.34280543527;5068.619853510928;5119.083900815954;5160.741962901915;5201;4797.592204662643;4990.276409920469;5078.187490001582;5103.642745007963;5135.92296115566;5363.356397232357;5773.884522309614;5869.207656966255;6046.516278697782;6075.483583895419;4369.956300436955;4371.322445021026;4375.38744575766;4384.610387338972;4385.386045953505;5635.055905712523;5873.882522349443;5888;5892;5921.289445266596;5722.656640601577;5757.222774925499;5767.163761254511;5774.769009239583;5775.584981679515;5728.627639203439;5770.798022069207;5779.5262208136655;5790.507806836466;5859.121131830259;5382.434844341445;5599.160125981135;5628.212050312877;5636.633618814764;5637.605367624227;5732.283464566929;5748.45389687979;5761.135829625589;5765.365809760839;5773.220615216892;5663.2071509989455;5669.234653321749;5674.886502270014;5694.715264236855;5698.2592263005545 00:42:52 INFO - PROCESS | 815 | |5;yui.html;820.8112134209132;833.8415701016803;859.9355048371366;897.3942588752592;913.1558028616853;15255.466058687949;16593.668126637476;16902.15489225537;17591.120443977783;18171.818281817177;17155.228014739336;17264;17337.653246935053;17346.82653173471;17389.13054347284;733.2923728601899;865.4374656473279;901.589776651622;901.882755241821;902.3863772634589;898.2589363774879;901.5176880369004;901.5447199164413;904.4076130134739;904.5748498205866;940.8118376324728;942.2979879989383;942.839717248066;943.1276069635594;943.1982814607563;762.5691484311374;904.1275169461436;925.4539821505277;927.2257664849858;932.1098351074708;687.8039758668756;688.2051230828351;688.7382794538044;688.7727050073464;688.8415664397166;14687.339069741887;14714.55856324312;14778.926105369512;14782.334794934146;14816.111033337926;14857.554273371708;15232.543023709306;15250;15302.234888255543;15324.080555166725;14411.78382324266;14432.350544225535;14454.277286135757;14512.201828899406;14805.407783688639;4721.905561888743;4766.928496072562;4797.088553174885;4801.303810947428;4916;79639.6018019912;80567;80611.99999999942;80674.59662701708;80717;11796.29222246668;11857.288562686266;12257.325847078497;12470.251784892935;12551.372431378395;21969.23107691223;22006.559868802855;22054;22087;22111.889440552695;8931.642734290686;8961.731148065568;9088.136627020422;9210;9325.114114159143;5297.894042119136;5356.276902618175;5356.517913387814;5364.275822763877;5520.282363292827;3674.283514714605;3906.609339066071;4158.397032430281;4164.8542301019925;4203.180379825904;605.6366180291877;721.6608194148741;724.8912663100472;726.1649103530982;727.0366764037672;685.2873012067494;740.9444291678038;761.7562380038445;777.3819813248368;804.65399878053;10552.20858435605;10861.239713219999;10870.891291087146;10875.891241087487;10974.231803773659;734.1813877526627;740.3780824107776;758.8634045871686;796.6056801883105;802.7110240313483;5037.471065538139;5208.463503266546;5297.629165958423;5312.681239125587;5335.519803217729;104309.47845260878;106998.46500767602;108294;108611.45694271478;111980.04240987901;96011.51994239984;96985;97623.51188244013;100095.49952250192;101892;86104.56947715346;86404;86491.56754216188;88261.55869220741;89533;10063.89936100659;10109.49452527356;10201.336913100624;10221.897781022391;10227.94886025565;52375.73812130915;54064.729676351366;54188.72905635447;54910.72544637251;56248.71875640596;66675.33324666691;67665.32334676787;69177.65411172912;69528.30471695219;70300.64849675719;13716.177029378268;13993.860061399255;14252.429902803771;14715.55853324402;14735.336909838868;15972.874749554;16272;16742.58143546421;16801.243944022302;17493;11289.943550282196;12770.685720549678;15096.094234345974;15112.697746045238;15457.922710386376;14867.107973521623;14890.255487225812;14969.519641512945;15111.395544178109;15890.920545397199;14455.402060209266;14652.926735366254;15016.099034057992;15227.086374817547;15820.28808703634;12420.62738117858;12464.314462704639;12526.248425094524;12613.243205407705;12758.61724148277;11412.885871141514;11693.239939403911;11786.528538858693;12063.758724825278;12665.556705515262 00:42:52 INFO - PROCESS | 815 | __end_tp_report 00:42:52 INFO - PROCESS | 815 | __start_cc_report 00:42:52 INFO - PROCESS | 815 | _x_x_mozilla_cycle_collect,871 00:42:52 INFO - PROCESS | 815 | __end_cc_report 00:42:52 INFO - PROCESS | 815 | __startTimestamp1470382972065__endTimestamp 00:42:52 INFO - PROCESS | 815 | 00:42:52 INFO - PROCESS | 815 | ------- Summary: start ------- 00:42:52 INFO - PROCESS | 815 | Number of tests: 6 00:42:52 INFO - PROCESS | 815 | 00:42:52 INFO - PROCESS | 815 | [#0] dojo.html Cycles:165 Average:5492.69 Median:5716.06 stddev:611.51 (10.7%) stddev-sans-first:590.17 00:42:52 INFO - PROCESS | 815 | Values: 3365.3 3383.6 3384.3 3414.6 3420.0 5502.5 5567.1 5571.4 5584.0 5613.4 5471.5 5517.5 5520.9 5529.8 5562.7 4884.3 4922.7 4947.6 4949.4 4987.3 4951.2 4960.1 4960.7 4965.9 5011.6 4962.2 4981.8 5068.7 5073.7 5100.8 4947.7 5008.1 5053.9 5064.5 5077.7 4789.6 4816.7 4819.9 4841.3 4889.6 5327.9 5359.7 5361.1 5379.2 5382.3 5713.1 5797.3 5827.9 5840.8 5844.9 5802.9 5865.2 5880.0 5932.8 5967.8 5533.8 5556.2 5583.7 5584.8 5585.6 5872.9 6055.8 6065.9 6115.2 6117.0 5768.3 5831.7 5835.2 5903.0 5931.6 5941.7 5952.8 5956.7 5957.8 5962.4 5714.1 5815.4 5915.1 5953.8 5957.1 5851.4 5877.9 5915.1 5917.7 5958.9 4536.4 4542.9 4543.5 4545.1 4567.4 3985.3 3993.5 4020.4 4060.5 4098.9 5651.6 5668.2 5680.9 5681.2 5701.2 5917.5 5948.0 5948.2 5948.2 5984.7 5532.8 5667.1 5676.3 5716.1 5717.1 5151.1 5152.3 5156.1 5157.7 5159.9 6135.2 6171.1 6183.3 6195.5 6201.1 5730.3 5831.9 5891.6 5896.5 5957.9 6137.4 6143.8 6158.5 6159.4 6164.2 5677.7 5870.2 5872.6 5873.9 5880.9 5818.5 5835.0 5892.0 5959.0 5959.2 5750.8 5768.7 5782.9 5792.2 5794.2 5632.3 5716.1 5802.1 5806.4 5810.1 5629.0 5721.7 5723.4 5725.5 5759.4 5863.7 5864.0 5868.5 5871.4 5903.4 5570.8 5607.9 5660.4 5696.6 5749.2 00:42:52 INFO - PROCESS | 815 | 00:42:52 INFO - PROCESS | 815 | [#1] ext.html Cycles:180 Average:66356.15 Median:40743.59 stddev:138857.22 (340.8%) stddev-sans-first:139158.96 00:42:52 INFO - PROCESS | 815 | Values: 593.5 642.8 645.7 657.8 659.6 32754.0 35479.6 35500.8 35572.6 45400.5 44498.6 47832.3 47954.5 47981.3 48069.8 9006.8 9211.5 9212.9 9217.6 9221.9 8151.6 9015.6 10552.7 10772.6 10789.4 11062.4 11120.3 11130.6 11133.7 11135.9 10917.7 10977.0 10984.9 10989.9 10990.6 10856.3 10932.3 10942.5 10943.1 10945.1 44068.0 44414.8 44469.1 44513.3 44526.3 3791.2 3880.6 4511.7 4564.8 4587.3 34126.8 34165.8 34361.1 34519.1 35731.3 4592.1 4631.9 4674.2 4691.2 4703.3 375324.1 375905.0 377295.0 377756.0 378530.0 37729.6 60572.7 60698.0 60763.1 60902.7 38720.2 40655.8 40662.6 40733.2 40754.0 17561.4 17773.6 17799.4 17830.4 17847.7 12457.9 14519.6 15167.3 15295.6 15304.5 9071.5 9120.4 9162.3 9229.8 9271.9 3450.4 3521.8 3529.4 3547.0 3587.7 1066.7 1154.5 1188.2 1190.5 1239.4 32433.8 33153.3 33525.5 34047.0 34077.1 1089.8 1171.7 1204.4 1239.3 1252.0 15904.4 16330.5 16338.6 16586.7 17055.7 676296.0 681012.0 681574.0 682840.0 683550.0 59508.4 59751.4 60296.7 60359.0 60446.0 1328.3 1445.6 1454.8 1492.0 1495.7 32543.7 33311.8 33406.3 33513.7 33867.8 51177.0 51738.0 51841.5 51892.2 51905.0 352319.0 472975.9 475318.0 478577.0 481056.0 44678.0 44869.0 45249.3 45414.0 46030.3 49025.8 49350.0 50551.2 50848.7 58948.0 44810.6 45206.8 47904.0 48516.8 49572.0 46132.5 46141.3 47067.8 47307.3 48575.0 47684.3 48505.3 48740.0 48880.8 49052.0 40664.7 43406.6 43652.0 43855.3 43914.6 30543.8 30626.2 30807.8 30936.2 31062.8 00:42:52 INFO - PROCESS | 815 | 00:42:52 INFO - PROCESS | 815 | [#2] jquery.html Cycles:180 Average:30546.54 Median:23174.71 stddev:93540.60 (403.6%) stddev-sans-first:93775.66 00:42:52 INFO - PROCESS | 815 | Values: 428.0 432.8 437.3 437.8 447.4 18818.7 19649.0 20281.7 21033.9 21100.1 18956.4 18993.1 19660.5 19675.8 19694.4 5596.9 5745.1 5797.7 5801.9 5804.4 5597.0 5706.0 5808.5 5908.4 5910.8 5808.0 5952.3 5972.8 5987.3 6385.9 6318.3 6380.6 6439.6 6445.5 6452.2 5850.5 5960.4 5987.8 5994.4 5998.8 14319.8 16362.5 22283.8 23141.5 23207.9 2345.6 2383.8 2395.4 2504.3 2529.4 10289.3 10298.1 10325.2 10863.8 10887.6 1961.2 2091.5 2101.1 2103.0 2116.6 59207.7 61422.7 67814.0 70748.6 71067.0 11057.4 11306.5 11395.7 11500.4 11608.1 16389.8 16407.4 16441.3 16562.5 16566.3 7596.4 7985.9 8191.4 8538.6 8583.8 8112.6 8324.9 8354.1 8427.3 8481.7 4981.5 5004.3 5013.5 5016.2 5105.8 2000.9 2054.9 2081.9 2084.2 2115.4 992.9 1045.9 1105.1 1119.0 1121.3 17989.3 19268.0 19347.0 19496.5 20643.0 1041.0 1041.8 1070.4 1078.4 1078.4 10739.5 11175.9 11177.2 11185.0 11266.4 564968.0 566114.0 568424.0 577926.0 582159.0 59349.0 61168.0 83695.0 93832.0 94523.5 994.4 1045.2 1103.5 1114.5 1116.9 17264.7 17354.6 17363.5 17517.6 17729.7 40783.6 41547.8 42124.6 42150.6 43233.8 57994.1 58566.7 59067.7 59116.1 59491.0 8566.4 8642.9 8683.8 8895.2 8949.9 11729.9 12922.5 12985.7 13062.7 13072.9 10983.3 11145.6 11192.2 11225.7 11250.2 11338.3 11385.6 11464.8 11467.0 11560.7 11065.1 11335.0 11418.1 11580.8 11621.2 8452.5 8524.3 8616.0 8729.7 8856.4 8884.8 10653.5 11485.7 11537.3 11550.2 00:42:52 INFO - PROCESS | 815 | 00:42:52 INFO - PROCESS | 815 | [#3] mootools.html Cycles:180 Average:6248.17 Median:4521.12 stddev:3584.42 (79.3%) stddev-sans-first:3576.89 00:42:52 INFO - PROCESS | 815 | Values: 1522.5 1562.3 1746.8 1873.8 1897.4 9213.3 9766.8 9859.1 9862.4 9866.5 8411.5 8634.7 9153.4 9352.1 9494.7 2371.7 2394.9 2397.0 2402.0 2402.9 2447.5 2479.6 2519.9 2521.2 2522.5 2152.7 2356.3 2454.3 2454.5 2471.5 2440.7 2442.4 2447.8 2463.9 2480.1 2409.4 2416.0 2447.6 2450.1 2485.6 9539.7 9549.7 9605.3 9636.2 9646.1 5356.7 5482.9 5491.0 5493.1 5495.6 3583.3 3643.8 3746.7 3752.1 3752.8 1185.0 1240.2 1253.1 1273.1 1290.4 13723.1 13730.3 13745.9 13756.4 13789.9 4886.2 5056.6 5078.3 5104.9 5154.0 10292.3 10326.8 10367.1 10384.5 10389.4 5425.8 5467.4 5469.8 5473.2 5476.1 5019.3 5119.4 5120.5 5247.1 5294.5 3860.1 3905.6 3951.6 3964.0 3998.9 1134.5 1184.7 1210.6 1212.9 1306.6 1047.9 1052.5 1057.8 1128.1 1131.6 6156.2 6418.2 6437.5 6503.4 6621.9 967.4 1071.8 1096.3 1105.3 1145.5 4451.9 4489.9 4552.4 4582.7 4646.0 11756.4 12037.9 12039.9 12058.4 12075.0 11172.7 11629.4 11850.5 11913.2 11969.1 8760.3 8906.4 8931.4 8981.1 8985.1 6299.3 6417.3 6452.5 6508.2 6521.8 10613.8 10894.9 10941.6 10964.7 11069.6 11162.7 11179.7 11270.1 11296.2 11297.1 8100.6 8276.9 8441.0 8446.5 8572.9 9086.2 9090.7 9150.6 9192.1 9205.7 8202.9 8242.5 8261.8 8332.5 8580.3 7984.5 8029.4 8080.1 8121.4 8461.6 7287.7 7712.4 7713.3 7726.5 7727.8 5502.1 5595.8 5626.6 5688.3 5779.3 5746.8 5749.9 5805.4 5863.9 5969.0 00:42:52 INFO - PROCESS | 815 | 00:42:52 INFO - PROCESS | 815 | [#4] prototype.html Cycles:180 Average:4676.07 Median:5200.38 stddev:1331.47 (25.6%) stddev-sans-first:1294.90 00:42:52 INFO - PROCESS | 815 | Values: 344.1 347.9 351.9 354.9 359.5 5450.3 5480.3 5495.1 5500.7 5520.6 5370.0 5390.5 5391.8 5392.2 5407.9 4111.7 4266.9 4297.7 4304.0 4310.9 4273.8 4295.8 4296.6 4307.5 4308.1 4266.4 4276.5 4286.4 4289.2 4307.4 4162.3 4204.2 4216.9 4270.8 4272.5 3781.2 3796.9 3802.8 3803.6 3815.6 5199.8 5264.8 5313.2 5319.4 5345.1 4685.4 4945.0 4946.2 4957.2 4983.5 5647.0 5658.0 5684.9 5727.3 5743.4 4169.3 4190.9 4195.7 4210.5 4225.7 5622.8 5635.2 5749.3 5959.5 5969.4 4301.3 4327.0 4329.7 4350.3 4356.8 4393.1 4403.7 4421.3 4443.8 4445.1 4733.0 4817.4 4865.8 4880.0 4904.1 5722.7 5723.4 5729.3 5733.3 5735.8 1458.0 1498.9 1515.8 1520.1 1524.4 950.7 954.7 961.3 969.8 975.4 4809.4 4978.0 4986.0 5024.3 5045.1 5234.6 5244.3 5251.3 5268.7 5274.5 4944.3 4993.6 5057.4 5070.8 5085.0 2621.1 2759.5 2776.2 2780.9 2787.5 5273.8 5278.2 5278.5 5309.8 5345.6 5210.4 5259.1 5274.8 5300.3 5301.4 4929.6 5252.0 5354.8 5403.5 5424.6 5055.3 5068.6 5119.1 5160.7 5201.0 4797.6 4990.3 5078.2 5103.6 5135.9 5363.4 5773.9 5869.2 6046.5 6075.5 4370.0 4371.3 4375.4 4384.6 4385.4 5635.1 5873.9 5888.0 5892.0 5921.3 5722.7 5757.2 5767.2 5774.8 5775.6 5728.6 5770.8 5779.5 5790.5 5859.1 5382.4 5599.2 5628.2 5636.6 5637.6 5732.3 5748.5 5761.1 5765.4 5773.2 5663.2 5669.2 5674.9 5694.7 5698.3 00:42:52 INFO - PROCESS | 815 | 00:42:52 INFO - PROCESS | 815 | [#5] yui.html Cycles:180 Average:21298.49 Median:4184.02 stddev:29215.72 (698.3%) stddev-sans-first:29257.21 00:42:52 INFO - PROCESS | 815 | Values: 820.8 833.8 859.9 897.4 913.2 15255.5 16593.7 16902.2 17591.1 18171.8 17155.2 17264.0 17337.7 17346.8 17389.1 733.3 865.4 901.6 901.9 902.4 898.3 901.5 901.5 904.4 904.6 940.8 942.3 942.8 943.1 943.2 762.6 904.1 925.5 927.2 932.1 687.8 688.2 688.7 688.8 688.8 14687.3 14714.6 14778.9 14782.3 14816.1 14857.6 15232.5 15250.0 15302.2 15324.1 14411.8 14432.4 14454.3 14512.2 14805.4 4721.9 4766.9 4797.1 4801.3 4916.0 79639.6 80567.0 80612.0 80674.6 80717.0 11796.3 11857.3 12257.3 12470.3 12551.4 21969.2 22006.6 22054.0 22087.0 22111.9 8931.6 8961.7 9088.1 9210.0 9325.1 5297.9 5356.3 5356.5 5364.3 5520.3 3674.3 3906.6 4158.4 4164.9 4203.2 605.6 721.7 724.9 726.2 727.0 685.3 740.9 761.8 777.4 804.7 10552.2 10861.2 10870.9 10875.9 10974.2 734.2 740.4 758.9 796.6 802.7 5037.5 5208.5 5297.6 5312.7 5335.5 104309.5 106998.5 108294.0 108611.5 111980.0 96011.5 96985.0 97623.5 100095.5 101892.0 86104.6 86404.0 86491.6 88261.6 89533.0 10063.9 10109.5 10201.3 10221.9 10227.9 52375.7 54064.7 54188.7 54910.7 56248.7 66675.3 67665.3 69177.7 69528.3 70300.6 13716.2 13993.9 14252.4 14715.6 14735.3 15972.9 16272.0 16742.6 16801.2 17493.0 11289.9 12770.7 15096.1 15112.7 15457.9 14867.1 14890.3 14969.5 15111.4 15890.9 14455.4 14652.9 15016.1 15227.1 15820.3 12420.6 12464.3 12526.2 12613.2 12758.6 11412.9 11693.2 11786.5 12063.8 12665.6 00:42:52 INFO - PROCESS | 815 | -------- Summary: end -------- 00:42:52 INFO - PROCESS | 815 | 00:42:52 INFO - TEST-INFO | 815: exit 0 00:42:52 INFO - TEST-OK | dromaeo_css | took 1110784ms 00:42:52 INFO - TEST-START | kraken 00:42:52 INFO - operating with platform_type : linux_ 00:42:52 INFO - Initialising browser for kraken test... 00:42:52 INFO - TEST-INFO | started process 1007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcgKhTC/profile http://localhost:56974/getInfo.html) 00:42:55 INFO - PROCESS | 1007 | __metrics Screen width/height:1600/1200 00:42:55 INFO - PROCESS | 1007 | colorDepth:24 00:42:55 INFO - PROCESS | 1007 | Browser inner width/height: 1024/697 00:42:55 INFO - PROCESS | 1007 | __metrics 00:42:56 INFO - PROCESS | 1007 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:42:56 ERROR - PROCESS | 1007 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:42:57 INFO - TEST-INFO | 1007: exit 0 00:42:57 INFO - Browser initialized. 00:42:57 INFO - Running cycle 1/1 for kraken test... 00:42:57 INFO - TEST-INFO | started process 1110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcgKhTC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:43:09 INFO - PROCESS | 1110 | RSS: Main: 140922880 00:43:09 INFO - PROCESS | 1110 | 00:43:11 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56974/tests/kraken/driver.html?testName=audio-beat-detection) 00:43:12 INFO - PROCESS | 1110 | RSS: Main: 191594496 00:43:12 INFO - PROCESS | 1110 | 00:43:15 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56974/tests/kraken/driver.html?testName=audio-dft) 00:43:15 INFO - PROCESS | 1110 | RSS: Main: 184725504 00:43:15 INFO - PROCESS | 1110 | 00:43:18 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56974/tests/kraken/driver.html?testName=audio-fft) 00:43:19 INFO - PROCESS | 1110 | RSS: Main: 276254720 00:43:19 INFO - PROCESS | 1110 | 00:43:21 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56974/tests/kraken/driver.html?testName=audio-oscillator) 00:43:21 INFO - PROCESS | 1110 | RSS: Main: 184274944 00:43:21 INFO - PROCESS | 1110 | 00:43:24 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56974/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:43:24 INFO - PROCESS | 1110 | RSS: Main: 185282560 00:43:24 INFO - PROCESS | 1110 | 00:43:27 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56974/tests/kraken/driver.html?testName=imaging-darkroom) 00:43:28 INFO - PROCESS | 1110 | RSS: Main: 219877376 00:43:28 INFO - PROCESS | 1110 | 00:43:31 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56974/tests/kraken/driver.html?testName=imaging-desaturate) 00:43:32 INFO - PROCESS | 1110 | RSS: Main: 219217920 00:43:32 INFO - PROCESS | 1110 | 00:43:34 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56974/tests/kraken/driver.html?testName=json-parse-financial) 00:43:35 INFO - PROCESS | 1110 | RSS: Main: 218148864 00:43:35 INFO - PROCESS | 1110 | 00:43:36 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56974/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:43:37 INFO - PROCESS | 1110 | RSS: Main: 198172672 00:43:37 INFO - PROCESS | 1110 | 00:43:39 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56974/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:43:39 INFO - PROCESS | 1110 | RSS: Main: 199667712 00:43:39 INFO - PROCESS | 1110 | 00:43:41 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56974/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:43:42 INFO - PROCESS | 1110 | RSS: Main: 207659008 00:43:42 INFO - PROCESS | 1110 | 00:43:45 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:43:45 INFO - PROCESS | 1110 | RSS: Main: 211595264 00:43:45 INFO - PROCESS | 1110 | 00:43:48 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:43:48 INFO - PROCESS | 1110 | RSS: Main: 211701760 00:43:48 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | Cycle 1(1): loaded http://localhost:56974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56974/tests/kraken/driver.html?testName=ai-astar) 00:43:50 INFO - PROCESS | 1110 | RSS: Main: 253861888 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | __start_tp_report 00:43:50 INFO - PROCESS | 1110 | _x_x_mozilla_page_load 00:43:50 INFO - PROCESS | 1110 | _x_x_mozilla_page_load_details 00:43:50 INFO - PROCESS | 1110 | |i|pagename|runs| 00:43:50 INFO - PROCESS | 1110 | |0;ai-astar;111;106;110;110;113;110;112;110;109;111 00:43:50 INFO - PROCESS | 1110 | |1;audio-beat-detection;154;123;124;179;127;134;133;159;168;124 00:43:50 INFO - PROCESS | 1110 | |2;audio-dft;160;160;161;160;161;163;160;162;160;159 00:43:50 INFO - PROCESS | 1110 | |3;audio-fft;74;75;76;112;74;75;75;75;105;75 00:43:50 INFO - PROCESS | 1110 | |4;audio-oscillator;84;84;110;84;84;85;129;83;83;118 00:43:50 INFO - PROCESS | 1110 | |5;imaging-gaussian-blur;117;116;116;116;116;117;116;117;116;117 00:43:50 INFO - PROCESS | 1110 | |6;imaging-darkroom;146;146;146;145;146;146;146;145;146;146 00:43:50 INFO - PROCESS | 1110 | |7;imaging-desaturate;95;94;94;95;95;94;95;95;95;95 00:43:50 INFO - PROCESS | 1110 | |8;json-parse-financial;61;49;51;51;53;55;52;51;50;52 00:43:50 INFO - PROCESS | 1110 | |9;json-stringify-tinderbox;58;59;59;60;60;59;62;59;59;60 00:43:50 INFO - PROCESS | 1110 | |10;stanford-crypto-aes;82;79;75;78;76;77;83;82;103;79 00:43:50 INFO - PROCESS | 1110 | |11;stanford-crypto-ccm;138;124;120;117;119;117;117;124;125;130 00:43:50 INFO - PROCESS | 1110 | |12;stanford-crypto-pbkdf2;155;156;155;154;162;153;155;155;162;154 00:43:50 INFO - PROCESS | 1110 | |13;stanford-crypto-sha256-iterative;64;63;62;63;62;61;61;63;61;67 00:43:50 INFO - PROCESS | 1110 | __end_tp_report 00:43:50 INFO - PROCESS | 1110 | __start_cc_report 00:43:50 INFO - PROCESS | 1110 | _x_x_mozilla_cycle_collect,1552 00:43:50 INFO - PROCESS | 1110 | __end_cc_report 00:43:50 INFO - PROCESS | 1110 | __startTimestamp1470383030790__endTimestamp 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | ------- Summary: start ------- 00:43:50 INFO - PROCESS | 1110 | Number of tests: 14 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.87 (1.7%) stddev-sans-first:1.96 00:43:50 INFO - PROCESS | 1110 | Values: 111.0 106.0 110.0 110.0 113.0 110.0 112.0 110.0 109.0 111.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:144.00 stddev:20.69 (14.4%) stddev-sans-first:21.53 00:43:50 INFO - PROCESS | 1110 | Values: 154.0 123.0 124.0 179.0 127.0 134.0 133.0 159.0 168.0 124.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 00:43:50 INFO - PROCESS | 1110 | Values: 160.0 160.0 161.0 160.0 161.0 163.0 160.0 162.0 160.0 159.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:14.28 (19.0%) stddev-sans-first:14.88 00:43:50 INFO - PROCESS | 1110 | Values: 74.0 75.0 76.0 112.0 74.0 75.0 75.0 75.0 105.0 75.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.00 stddev:17.57 (20.9%) stddev-sans-first:18.23 00:43:50 INFO - PROCESS | 1110 | Values: 84.0 84.0 110.0 84.0 84.0 85.0 129.0 83.0 83.0 118.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 00:43:50 INFO - PROCESS | 1110 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 00:43:50 INFO - PROCESS | 1110 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 00:43:50 INFO - PROCESS | 1110 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:3.41 (6.6%) stddev-sans-first:1.74 00:43:50 INFO - PROCESS | 1110 | Values: 61.0 49.0 51.0 51.0 53.0 55.0 52.0 51.0 50.0 52.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:1.08 (1.8%) stddev-sans-first:1.00 00:43:50 INFO - PROCESS | 1110 | Values: 58.0 59.0 59.0 60.0 60.0 59.0 62.0 59.0 59.0 60.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:79.00 stddev:8.04 (10.2%) stddev-sans-first:8.53 00:43:50 INFO - PROCESS | 1110 | Values: 82.0 79.0 75.0 78.0 76.0 77.0 83.0 82.0 103.0 79.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:124.00 stddev:6.77 (5.5%) stddev-sans-first:4.56 00:43:50 INFO - PROCESS | 1110 | Values: 138.0 124.0 120.0 117.0 119.0 117.0 117.0 124.0 125.0 130.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:155.00 stddev:3.21 (2.1%) stddev-sans-first:3.38 00:43:50 INFO - PROCESS | 1110 | Values: 155.0 156.0 155.0 154.0 162.0 153.0 155.0 155.0 162.0 154.0 00:43:50 INFO - PROCESS | 1110 | 00:43:50 INFO - PROCESS | 1110 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.83 (2.9%) stddev-sans-first:1.88 00:43:50 INFO - PROCESS | 1110 | Values: 64.0 63.0 62.0 63.0 62.0 61.0 61.0 63.0 61.0 67.0 00:43:50 INFO - PROCESS | 1110 | -------- Summary: end -------- 00:43:50 INFO - PROCESS | 1110 | 00:43:51 INFO - TEST-INFO | 1110: exit 0 00:43:51 INFO - TEST-OK | kraken | took 58895ms 00:43:51 INFO - SUITE-END | took 1169s 00:43:51 INFO - Completed test suite (00:19:29) 00:43:51 INFO - javascript benchmark 00:43:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.2932884094344, 3383.5601371821667, 3384.323135372926, 3414.6414626464207, 3419.9829000855007, 5502.477264659856, 5567.109262517998, 5571.359293681227, 5584.0, 5613.410591887854, 5471.50756431921, 5517.531009864157, 5520.861978450541, 5529.834104976857, 5562.721863906809, 4884.316195732583, 4922.655414121013, 4947.579455746266, 4949.381327334083, 4987.301777751118, 4951.207806750921, 4960.082384758831, 4960.727160006199, 4965.851024469272, 5011.649184557083, 4962.156433406311, 4981.750912454363, 5068.670536415139, 5073.746312684351, 5100.795968161269, 4947.703137811743, 5008.098542262392, 5053.873653158664, 5064.493550644925, 5077.720725360104, 4789.592884604813, 4816.710997340171, 4819.879503012417, 4841.298011788271, 4889.6088312935235, 5327.866803329909, 5359.651622644555, 5361.142217245222, 5379.246905433242, 5382.30030096085, 5713.114467257582, 5797.275340582427, 5827.883442331172, 5840.8247752567495, 5844.912326315109, 5802.941970580325, 5865.237519122529, 5879.970600147015, 5932.762689492415, 5967.761289548413, 5533.778648854041, 5556.16657501374, 5583.748731307101, 5584.776608935637, 5585.636933599303, 5872.853178670567, 6055.757769689163, 6065.909588114823, 6115.1744514490865, 6116.969415152896, 5768.3366412862215, 5831.679257640785, 5835.183074369592, 5902.970485147547, 5931.58478906481, 5941.70291485424, 5952.821415357546, 5956.672383018976, 5957.821265362046, 5962.3739507351975, 5714.114312281603, 5815.360310365856, 5915.08316210988, 5953.761849526057, 5957.076653118774, 5851.385604511465, 5877.853053673693, 5915.142304365929, 5917.733701983421, 5958.851028724316, 4536.387587675622, 4542.931856022163, 4543.5002149763495, 4545.136424079415, 4567.383403240587, 3985.3025720498795, 3993.520777506718, 4020.4170395292517, 4060.5127384714024, 4098.877033688994, 5651.57613179005, 5668.206451096849, 5680.943190568124, 5681.233033540502, 5701.2018317435595, 5917.497012753965, 5948.0, 5948.196993405835, 5948.226730525004, 5984.73068711909, 5532.834014979557, 5667.149927510906, 5676.290463692038, 5716.056850619601, 5717.142428635738, 5151.072806894795, 5152.3044389007, 5156.1492353761205, 5157.690538567698, 5159.922601160985, 6135.171751813448, 6171.13604095418, 6183.288921774054, 6195.504359651217, 6201.131841542187, 5730.283714535683, 5831.912521312269, 5891.646501209942, 5896.528277737685, 5957.880842383215, 6137.3862613738265, 6143.84640383994, 6158.538109641705, 6159.353267906805, 6164.198654174928, 5677.74450149736, 5870.207521984477, 5872.55955803325, 5873.911891321719, 5880.852978675396, 5818.50542703858, 5835.0, 5892.027815410409, 5958.97020514912, 5959.195508606283, 5750.7987220447085, 5768.7404066817935, 5782.884342313214, 5792.21805056312, 5794.159846822272, 5632.295963004624, 5716.114002329646, 5802.071668533014, 5806.361300256884, 5810.099434587646, 5628.971855140698, 5721.685307308138, 5723.427657234243, 5725.541956643375, 5759.366469688414, 5863.677497737665, 5864.0, 5868.501177399969, 5871.412858714265, 5903.380145084704, 5570.832875013594, 5607.943920560905, 5660.433956604306, 5696.572757043155, 5749.166370876116], "value": 5453.362997931936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.5340757505356, 642.8425035866212, 645.6707079389513, 657.7927952694902, 659.5844617890729, 32754.0, 35479.64520354796, 35500.822495887514, 35572.644273557285, 45400.54599454004, 44498.55501444985, 47832.28251576221, 47954.52045479544, 47981.28028079573, 48069.759651201784, 9006.819863602725, 9211.493367864765, 9212.907870921306, 9217.631294748202, 9221.861672074925, 8151.592420378987, 9015.639374425047, 10552.736181595445, 10772.56909723614, 10789.352638841656, 11062.39156846373, 11120.332780033224, 11130.610428635, 11133.7216569586, 11135.944320278388, 10917.672469825919, 10977.0, 10984.945075274572, 10989.945050274777, 10990.615328463506, 10856.294340867818, 10932.289401188897, 10942.507587158598, 10943.124550035978, 10945.069669078139, 44068.0, 44414.77792611049, 44469.11061778746, 44513.33230001553, 44526.33210501845, 3791.241751649681, 3880.554166893524, 4511.684182107254, 4564.840230591946, 4587.266037434028, 34126.82936585326, 34165.829170853984, 34361.14097147567, 34519.13702157441, 35731.28537429237, 4592.127495775825, 4631.907361852778, 4674.205385084544, 4691.15559199344, 4703.318018887277, 375324.1233793841, 375905.0, 377295.0, 377756.0, 378530.0, 37729.62270377261, 60572.697136514034, 60698.0, 60763.08855367173, 60902.69548652229, 38720.22559548793, 40655.7967210162, 40662.59337406647, 40733.1853362937, 40754.0, 17561.38535151289, 17773.644527109387, 17799.377021804175, 17830.37593684215, 17847.73228401575, 12457.875421245853, 14519.564413067625, 15167.317470713844, 15295.617609559627, 15304.540863774104, 9071.501067441222, 9120.407173533698, 9162.312826538036, 9229.815403691888, 9271.860922086174, 3450.4306789379975, 3521.8063006534376, 3529.3823580873245, 3546.964530354715, 3587.712982961357, 1066.7279843639822, 1154.520873837365, 1188.2454641302836, 1190.5475919150667, 1239.3741160713782, 32433.837830810695, 33153.3369332612, 33525.49711754326, 34047.0, 34077.14807129792, 1089.782043591285, 1171.654361963223, 1204.391782150026, 1239.3307613888398, 1251.9624411267675, 15904.44334448312, 16330.510084697478, 16338.591535211477, 16586.6682666346, 17055.658886822195, 676296.0, 681012.0, 681574.0, 682840.0, 683550.0, 59508.40491595115, 59751.402485974584, 60296.69851650801, 60359.0, 60446.0, 1328.2827273272326, 1445.645816774897, 1454.8326942401548, 1491.9701605968037, 1495.7008598280388, 32543.674563254066, 33311.83344083264, 33406.331873362884, 33513.664863351056, 33867.830660846535, 51177.0, 51738.0, 51841.48158518367, 51892.221616676536, 51905.0, 352319.0, 472975.90536141297, 475318.0, 478577.0, 481056.0, 44678.0, 44869.0, 45249.32126018178, 45414.0, 46030.30954535618, 49025.754871225414, 49350.0, 50551.241731373324, 50848.74575627098, 58948.0, 44810.55189448064, 45206.77396612996, 47904.0, 48516.7574162141, 49572.00855982932, 46132.53867461282, 46141.30788038249, 47067.76466117647, 47307.290390644856, 48575.0, 47684.284735728295, 48505.27242091301, 48740.0, 48880.755596223215, 49052.0, 40664.662161491244, 43406.56593434025, 43652.0, 43855.34216986811, 43914.56085439105, 30543.847280763453, 30626.234344141576, 30807.845960770053, 30936.226594335323, 31062.844685776425], "value": 20920.29886666197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.98930026749315, 432.80956379193157, 437.28591210553174, 437.7633186248848, 447.42952735262554, 18818.717719234224, 19649.0, 20281.695774563374, 21033.894830525864, 21100.100990910814, 18956.431307060775, 18993.05034748264, 19660.508487287825, 19675.803241967576, 19694.409167724993, 5596.888062238752, 5745.138229265623, 5797.681127537984, 5801.883962320751, 5804.390538993408, 5597.0, 5705.971470142665, 5808.477237048664, 5908.379620139888, 5910.793122240722, 5807.970960145193, 5952.285725712921, 5972.761089556412, 5987.311459182184, 6385.872282554346, 6318.2733985591785, 6380.553361264713, 6439.64581947995, 6445.484361251112, 6452.2257329120575, 5850.473457388855, 5960.374160713106, 5987.790427335066, 5994.400559944014, 5998.7600495980105, 14319.78520322196, 16362.509124726277, 22283.777162228333, 23141.537169256688, 23207.883960580257, 2345.5895218336723, 2383.797377222938, 2395.3652282145244, 2504.2987963370288, 2529.4435224250637, 10289.3311934724, 10298.073173414354, 10325.173986081096, 10863.83704244437, 10887.564497420093, 1961.2449207055245, 2091.5398612305266, 2101.0650260634025, 2102.95794084119, 2116.5555233401005, 59207.703961479914, 61422.69288653528, 67814.0, 70748.6462567689, 71067.0, 11057.447127643585, 11306.491207895664, 11395.658130256106, 11500.367479788525, 11608.071354291636, 16389.754153687467, 16407.42574009928, 16441.342346306013, 16562.50312490627, 16566.254518546695, 7596.3922886168975, 7985.880211796828, 8191.426600138052, 8538.615762290712, 8583.785405364915, 8112.6349314281, 8324.875126873101, 8354.081051084377, 8427.32581393487, 8481.745547633582, 4981.452040275567, 5004.324416203839, 5013.548780609763, 5016.197408414636, 5105.795768169231, 2000.9499762506055, 2054.907529161191, 2081.9375418737463, 2084.2392526727635, 2115.4288342147534, 992.905673960987, 1045.8797238317538, 1105.0717397386234, 1118.9888101118884, 1121.3328069798456, 17989.280428782964, 19268.0, 19347.0, 19496.51258718515, 20643.0, 1040.9739756506149, 1041.8124737547314, 1070.4166229404993, 1078.3637653784306, 1078.439211609974, 10739.516721747541, 11175.888241117647, 11177.161712871404, 11185.0, 11266.380349080879, 564968.0, 566114.0, 568424.0, 577926.0, 582159.0, 59349.0, 61168.0, 83695.0, 93832.0, 94523.52738236402, 994.3983889746744, 1045.1795340657548, 1103.5309993252995, 1114.4817659788237, 1116.8827273136367, 17264.65470690554, 17354.566135846704, 17363.47909562715, 17517.56206094807, 17729.734053989458, 40783.59216407798, 41547.7922610385, 42124.57875421207, 42150.57849421589, 43233.78383108064, 57994.130088049555, 58566.70716646389, 59067.70466147642, 59116.11325830202, 59491.0, 8566.400351975302, 8642.913570864212, 8683.784270202303, 8895.154960278764, 8949.865752013855, 11729.882701172879, 12922.483100675867, 12985.675358116123, 13062.673433164247, 13072.934635326763, 10983.340999539734, 11145.609903653332, 11192.160587955774, 11225.66323010311, 11250.212485125963, 11338.263012904135, 11385.601503947322, 11464.770704586028, 11467.0, 11560.6531804046, 11065.114790816877, 11335.0, 11418.143639226924, 11580.768384632092, 11621.186516943733, 8452.492850428995, 8524.27543658796, 8615.956920215358, 8729.65081396737, 8856.424332418372, 8884.822303553763, 10653.467326633792, 11485.655430337103, 11537.307761534335, 11550.191486595857], "value": 9365.35906883642, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1522.535626633877, 1562.2891584329127, 1746.7816522934634, 1873.7845147808007, 1897.3643829317186, 9213.309001824864, 9766.804663906718, 9859.112679858812, 9862.35894666847, 9866.45734484603, 8411.537365444898, 8634.74095777126, 9153.40502867313, 9352.064793520645, 9494.715158545238, 2371.691680081591, 2394.8802559872024, 2397.041183526586, 2401.9639705404434, 2402.927912162629, 2447.5227330670527, 2479.6404521344393, 2519.911803086892, 2521.1932181701864, 2522.495500899818, 2152.6770984352315, 2356.2813341930705, 2454.337328921199, 2454.5459090068393, 2471.480988992305, 2440.7437219092008, 2442.3894026493376, 2447.816413768957, 2463.938401539967, 2480.0947654106303, 2409.3737825769995, 2415.975840241593, 2447.6328550717535, 2450.130203777651, 2485.614729716897, 9539.713808585753, 9549.665761698307, 9605.327627066108, 9636.180924621416, 9646.131848133702, 5356.651817631841, 5482.945170548283, 5490.972545137289, 5493.121100623921, 5495.642783219078, 3583.3191693578137, 3643.7631553949172, 3746.662800347982, 3752.061984503874, 3752.81235938202, 1185.0401175048153, 1240.1806609328182, 1253.078986944595, 1273.1215461331744, 1290.3612711707672, 13723.1079979801, 13730.313484325743, 13745.862541374658, 13756.380962856696, 13789.931050344785, 4886.218205087169, 5056.57019153376, 5078.339815823993, 5104.9489505104475, 5154.0, 10292.279540432248, 10326.845097323547, 10367.066963973128, 10384.480775961172, 10389.37663740178, 5425.83722488326, 5467.425920278393, 5469.808556700496, 5473.151661492475, 5476.069068258405, 5019.347484826949, 5119.385673719177, 5120.5391514763105, 5247.081760691864, 5294.497022782906, 3860.0542866997766, 3905.628965248354, 3951.604839516083, 3964.0, 3998.8600398986478, 1134.466800603715, 1184.6505280942142, 1210.5883999440232, 1212.9090318225992, 1306.5557710378516, 1047.8690163729534, 1052.4737631184407, 1057.7567159553346, 1128.0637071231022, 1131.5530365505579, 6156.168917196211, 6418.19772528434, 6437.517186211053, 6503.447206987365, 6621.9006714899315, 967.3760424526141, 1071.844582535528, 1096.3476731344838, 1105.3312745788842, 1145.478807142748, 4451.888702782391, 4489.859111317588, 4552.385427967249, 4582.725036497821, 4646.047560250141, 11756.35340056288, 12037.879621203676, 12039.879601204051, 12058.397080146133, 12075.0, 11172.664820055412, 11629.360385178727, 11850.466728997217, 11913.16607837443, 11969.102317326235, 8760.299176065899, 8906.376553641312, 8931.374803763674, 8981.056989016059, 8985.101489850962, 6299.338569450325, 6417.294097649348, 6452.451541619015, 6508.219013718384, 6521.836954076186, 10613.787724245627, 10894.945525272324, 10941.56233750641, 10964.725881853017, 11069.612563560559, 11162.665120046411, 11179.72050698739, 11270.098392128446, 11296.209265351346, 11297.096232301561, 8100.554469504234, 8276.917230827856, 8440.95779521123, 8446.450980686235, 8572.871406928776, 9086.22767064807, 9090.681826136053, 9150.63397464094, 9192.080791921022, 9205.723828285161, 8202.917970820215, 8242.464239824392, 8261.752147435587, 8332.541710205754, 8580.313574914117, 7984.520928744294, 8029.357651387758, 8080.111187769458, 8121.350291976746, 8461.576921153795, 7287.708491660274, 7712.38300935935, 7713.305802477804, 7726.536407815549, 7727.768166955, 5502.147167189092, 5595.804146854841, 5626.606137570331, 5688.317401911797, 5779.2775903012125, 5746.827595172152, 5749.942500574941, 5805.448482394166, 5863.912041319299, 5969.015112506561], "value": 4985.964996643483, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.107042225425, 347.89563131060675, 351.9243362677024, 354.88998410492746, 359.48593511278875, 5450.264214331064, 5480.287562616864, 5495.093309603921, 5500.697461639613, 5520.641158324706, 5369.973150134244, 5390.487903649157, 5391.78432862686, 5392.2181283713835, 5407.918881216775, 4111.691623128255, 4266.87199384019, 4297.699161058727, 4303.978480107595, 4310.913781724364, 4273.807678654468, 4295.7852107394665, 4296.613304802567, 4307.483102027745, 4308.116836048603, 4266.421424073097, 4276.486821581415, 4286.378475121106, 4289.185054839586, 4307.440032795732, 4162.292410290258, 4204.159168166364, 4216.894577635553, 4270.765107919063, 4272.530021697611, 3781.2059467511854, 3796.886093417202, 3802.7718336899875, 3803.581606023363, 3815.6184381561898, 5199.752059505729, 5264.842054738364, 5313.176457649032, 5319.414864364917, 5345.118055520873, 4685.4143232095985, 4945.0, 4946.159152944008, 4957.182064959277, 4983.476734942851, 5646.983542962265, 5658.0, 5684.943150568482, 5727.255456790632, 5743.396943320933, 4169.332906734908, 4190.91618167638, 4195.748255104703, 4210.473690788652, 4225.661947044229, 5622.803201887914, 5635.21107045014, 5749.31008279005, 5959.480332515224, 5969.37321581232, 4301.290287102655, 4327.0, 4329.653627709776, 4350.32569951658, 4356.803943822536, 4393.121375724804, 4403.713758605681, 4421.292593185075, 4443.800028998703, 4445.133199026223, 4732.952670473252, 4817.421909370828, 4865.829695960624, 4880.048390563877, 4904.141775189328, 5722.7424765885635, 5723.399043100498, 5729.341125770507, 5733.283339582552, 5735.827925162252, 1458.0231245065831, 1498.932548035341, 1515.8484151584973, 1520.0651599266594, 1524.41310095614, 950.6720181537358, 954.7279025477706, 961.2937036759807, 969.8448248280382, 975.3757595139117, 4809.422869255712, 4977.983916513817, 4985.975070124626, 5024.346834911438, 5045.117104506697, 5234.555062819627, 5244.325394049062, 5251.264822924793, 5268.736563171826, 5274.525292723673, 4944.332515110486, 4993.625478089158, 5057.432196019246, 5070.76886170084, 5084.9745751271, 2621.108823000189, 2759.530879750447, 2776.194903478009, 2780.887644941999, 2787.4703806276743, 5273.78904843802, 5278.181881808326, 5278.498542638443, 5309.778750887318, 5345.567766666158, 5210.400803907523, 5259.105951988171, 5274.7626356814035, 5300.284461597712, 5301.395051365109, 4929.584503593213, 5252.0, 5354.812581559705, 5403.51403364078, 5424.606069084055, 5055.34280543527, 5068.619853510928, 5119.083900815954, 5160.741962901915, 5201.0, 4797.592204662643, 4990.276409920469, 5078.187490001582, 5103.642745007963, 5135.92296115566, 5363.356397232357, 5773.884522309614, 5869.207656966255, 6046.516278697782, 6075.483583895419, 4369.956300436955, 4371.322445021026, 4375.38744575766, 4384.610387338972, 4385.386045953505, 5635.055905712523, 5873.882522349443, 5888.0, 5892.0, 5921.289445266596, 5722.656640601577, 5757.222774925499, 5767.163761254511, 5774.769009239583, 5775.584981679515, 5728.627639203439, 5770.798022069207, 5779.5262208136655, 5790.507806836466, 5859.121131830259, 5382.434844341445, 5599.160125981135, 5628.212050312877, 5636.633618814764, 5637.605367624227, 5732.283464566929, 5748.45389687979, 5761.135829625589, 5765.365809760839, 5773.220615216892, 5663.2071509989455, 5669.234653321749, 5674.886502270014, 5694.715264236855, 5698.2592263005545], "value": 4257.743506638828, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.8112134209132, 833.8415701016803, 859.9355048371366, 897.3942588752592, 913.1558028616853, 15255.466058687949, 16593.668126637476, 16902.15489225537, 17591.120443977783, 18171.818281817177, 17155.228014739336, 17264.0, 17337.653246935053, 17346.82653173471, 17389.13054347284, 733.2923728601899, 865.4374656473279, 901.589776651622, 901.882755241821, 902.3863772634589, 898.2589363774879, 901.5176880369004, 901.5447199164413, 904.4076130134739, 904.5748498205866, 940.8118376324728, 942.2979879989383, 942.839717248066, 943.1276069635594, 943.1982814607563, 762.5691484311374, 904.1275169461436, 925.4539821505277, 927.2257664849858, 932.1098351074708, 687.8039758668756, 688.2051230828351, 688.7382794538044, 688.7727050073464, 688.8415664397166, 14687.339069741887, 14714.55856324312, 14778.926105369512, 14782.334794934146, 14816.111033337926, 14857.554273371708, 15232.543023709306, 15250.0, 15302.234888255543, 15324.080555166725, 14411.78382324266, 14432.350544225535, 14454.277286135757, 14512.201828899406, 14805.407783688639, 4721.905561888743, 4766.928496072562, 4797.088553174885, 4801.303810947428, 4916.0, 79639.6018019912, 80567.0, 80611.99999999942, 80674.59662701708, 80717.0, 11796.29222246668, 11857.288562686266, 12257.325847078497, 12470.251784892935, 12551.372431378395, 21969.23107691223, 22006.559868802855, 22054.0, 22087.0, 22111.889440552695, 8931.642734290686, 8961.731148065568, 9088.136627020422, 9210.0, 9325.114114159143, 5297.894042119136, 5356.276902618175, 5356.517913387814, 5364.275822763877, 5520.282363292827, 3674.283514714605, 3906.609339066071, 4158.397032430281, 4164.8542301019925, 4203.180379825904, 605.6366180291877, 721.6608194148741, 724.8912663100472, 726.1649103530982, 727.0366764037672, 685.2873012067494, 740.9444291678038, 761.7562380038445, 777.3819813248368, 804.65399878053, 10552.20858435605, 10861.239713219999, 10870.891291087146, 10875.891241087487, 10974.231803773659, 734.1813877526627, 740.3780824107776, 758.8634045871686, 796.6056801883105, 802.7110240313483, 5037.471065538139, 5208.463503266546, 5297.629165958423, 5312.681239125587, 5335.519803217729, 104309.47845260878, 106998.46500767602, 108294.0, 108611.45694271478, 111980.04240987901, 96011.51994239984, 96985.0, 97623.51188244013, 100095.49952250192, 101892.0, 86104.56947715346, 86404.0, 86491.56754216188, 88261.55869220741, 89533.0, 10063.89936100659, 10109.49452527356, 10201.336913100624, 10221.897781022391, 10227.94886025565, 52375.73812130915, 54064.729676351366, 54188.72905635447, 54910.72544637251, 56248.71875640596, 66675.33324666691, 67665.32334676787, 69177.65411172912, 69528.30471695219, 70300.64849675719, 13716.177029378268, 13993.860061399255, 14252.429902803771, 14715.55853324402, 14735.336909838868, 15972.874749554, 16272.0, 16742.58143546421, 16801.243944022302, 17493.0, 11289.943550282196, 12770.685720549678, 15096.094234345974, 15112.697746045238, 15457.922710386376, 14867.107973521623, 14890.255487225812, 14969.519641512945, 15111.395544178109, 15890.920545397199, 14455.402060209266, 14652.926735366254, 15016.099034057992, 15227.086374817547, 15820.28808703634, 12420.62738117858, 12464.314462704639, 12526.248425094524, 12613.243205407705, 12758.61724148277, 11412.885871141514, 11693.239939403911, 11786.528538858693, 12063.758724825278, 12665.556705515262], "value": 8172.155099735065, "unit": "score"}], "name": "dromaeo_css", "value": 7551.113439267315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 110.0, 113.0, 110.0, 112.0, 110.0, 109.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 124.0, 179.0, 127.0, 134.0, 133.0, 159.0, 168.0, 124.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 163.0, 160.0, 162.0, 160.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 112.0, 74.0, 75.0, 75.0, 75.0, 105.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 84.0, 84.0, 85.0, 129.0, 83.0, 83.0, 118.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 49.0, 51.0, 51.0, 53.0, 55.0, 52.0, 51.0, 50.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 60.0, 60.0, 59.0, 62.0, 59.0, 59.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 75.0, 78.0, 76.0, 77.0, 83.0, 82.0, 103.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 124.0, 120.0, 117.0, 119.0, 117.0, 117.0, 124.0, 125.0, 130.0], "value": 123.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 155.0, 154.0, 162.0, 153.0, 155.0, 155.0, 162.0, 154.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 62.0, 61.0, 61.0, 63.0, 61.0, 67.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1481.5, "alertThreshold": 2.0}]} 00:43:52 INFO - Return code: 0 00:43:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:43:52 ERROR - # TBPL SUCCESS # 00:43:52 INFO - Running post-action listener: _resource_record_post_action 00:43:52 INFO - ##### 00:43:52 INFO - ##### Finished run-tests step (success) 00:43:52 INFO - ##### 00:43:52 INFO - Running post-run listener: _resource_record_post_run 00:43:52 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 28672; Write bytes: 447823872; Read time: 28; Write time: 275628 00:43:52 INFO - TinderboxPrint: CPU usage
13.1% 00:43:52 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 28 00:43:52 INFO - TinderboxPrint: I/O write bytes / time
447,823,872 / 275,628 00:43:52 INFO - TinderboxPrint: CPU idle
8,212.1 (86.9%) 00:43:52 INFO - TinderboxPrint: CPU user
1,198.9 (12.7%) 00:43:52 INFO - TinderboxPrint: Swap in / out
0 / 0 00:43:52 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 235507712; Read time: 0; Write time: 165392 00:43:52 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 212316160; Read time: 12; Write time: 110236 00:43:52 INFO - Running post-run listener: _upload_blobber_files 00:43:52 INFO - Blob upload gear active. 00:43:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:43:52 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:52 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:52 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:53 INFO - (blobuploader) - INFO - Open directory for files ... 00:43:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:43:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_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:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:43:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:57 INFO - (blobuploader) - INFO - Done attempting. 00:43:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:43:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/878f6c6c40c0edac7d02bf5b993e19c3aac464ab8a0ce4a5710bbfdbfcffb7c71c85cc5903548866f1745b3e4dfdd35e6456849cc31a4d1c8d52084861b5e3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66f9d47ea4b95c19664f2df43e41fe1cde5c06fcaa73d311685a8b7695fe038e229eebe599606ecc553e2c9b4a46eff8303f78f0e1125d22375a890a27763734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a75bc94a420f43bb7d2034882caa1f8eac5f45fff5ded4cae95fd72ff83fe4cfb0a9943b4def49455e94a7cd74621a92a8cb0544968328fdd78e1df32185dce5"} 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/878f6c6c40c0edac7d02bf5b993e19c3aac464ab8a0ce4a5710bbfdbfcffb7c71c85cc5903548866f1745b3e4dfdd35e6456849cc31a4d1c8d52084861b5e3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66f9d47ea4b95c19664f2df43e41fe1cde5c06fcaa73d311685a8b7695fe038e229eebe599606ecc553e2c9b4a46eff8303f78f0e1125d22375a890a27763734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a75bc94a420f43bb7d2034882caa1f8eac5f45fff5ded4cae95fd72ff83fe4cfb0a9943b4def49455e94a7cd74621a92a8cb0544968328fdd78e1df32185dce5"} 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=1236.474870 ========= master_lag: 0.52 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-05 00:43:58.900139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 00:43:58.904826) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/878f6c6c40c0edac7d02bf5b993e19c3aac464ab8a0ce4a5710bbfdbfcffb7c71c85cc5903548866f1745b3e4dfdd35e6456849cc31a4d1c8d52084861b5e3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66f9d47ea4b95c19664f2df43e41fe1cde5c06fcaa73d311685a8b7695fe038e229eebe599606ecc553e2c9b4a46eff8303f78f0e1125d22375a890a27763734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a75bc94a420f43bb7d2034882caa1f8eac5f45fff5ded4cae95fd72ff83fe4cfb0a9943b4def49455e94a7cd74621a92a8cb0544968328fdd78e1df32185dce5"} 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.011158 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/878f6c6c40c0edac7d02bf5b993e19c3aac464ab8a0ce4a5710bbfdbfcffb7c71c85cc5903548866f1745b3e4dfdd35e6456849cc31a4d1c8d52084861b5e3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66f9d47ea4b95c19664f2df43e41fe1cde5c06fcaa73d311685a8b7695fe038e229eebe599606ecc553e2c9b4a46eff8303f78f0e1125d22375a890a27763734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a75bc94a420f43bb7d2034882caa1f8eac5f45fff5ded4cae95fd72ff83fe4cfb0a9943b4def49455e94a7cd74621a92a8cb0544968328fdd78e1df32185dce5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 00:43:58.937023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:43:58.937370) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1470380973.374681-2031534942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 00:43:58.987039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 00:43:58.990435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 00:43:58.990782) ========= ========= Total master_lag: 0.71 =========