builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1462936792.48 results: success (0) buildid: 20160510173021 builduid: b6a075f48b8b4a7e8410db36d3376e88 revision: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:52.479663) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:52.480144) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:52.480515) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:52.501892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:52.502517) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 20:19:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.2M=0s 2016-05-10 20:19:52 (31.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073732 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:52.586840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:52.587166) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009545 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:52.634280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 20:19:52.634914) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 027b0144a1a6c2d62dfb1656e41597acfe6a22ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 027b0144a1a6c2d62dfb1656e41597acfe6a22ef --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=78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 20:19:52,854 truncating revision to first 12 chars 2016-05-10 20:19:52,855 Setting DEBUG logging. 2016-05-10 20:19:52,855 attempt 1/10 2016-05-10 20:19:52,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/027b0144a1a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 20:19:53,908 unpacking tar archive at: fx-team-027b0144a1a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.318963 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 20:19:53.967072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:53.967761) ========= script_repo_revision: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:53.968647) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:53.969292) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 20:19:53.977677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-10 20:19:53.977996) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:19:54 INFO - MultiFileLogger online at 20160510 20:19:54 in /builds/slave/test 20:19:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:19:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:19:54 INFO - {'append_to_log': False, 20:19:54 INFO - 'base_work_dir': '/builds/slave/test', 20:19:54 INFO - 'blob_upload_branch': 'Fx-Team', 20:19:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:19:54 INFO - 'branch': 'Fx-Team', 20:19:54 INFO - 'buildbot_json_path': 'buildprops.json', 20:19:54 INFO - 'config_files': ('talos/linux_config.py',), 20:19:54 INFO - 'default_actions': ('clobber', 20:19:54 INFO - 'read-buildbot-config', 20:19:54 INFO - 'download-and-extract', 20:19:54 INFO - 'populate-webroot', 20:19:54 INFO - 'create-virtualenv', 20:19:54 INFO - 'install', 20:19:54 INFO - 'run-tests'), 20:19:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:19:54 INFO - 'download_minidump_stackwalk': True, 20:19:54 INFO - 'download_symbols': 'ondemand', 20:19:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:19:54 INFO - 'tooltool.py': '/tools/tooltool.py', 20:19:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:19:54 INFO - '/tools/misc-python/virtualenv.py')}, 20:19:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:19:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:19:54 INFO - 'installer_path': 'installer.exe', 20:19:54 INFO - 'log_level': 'info', 20:19:54 INFO - 'log_name': 'talos', 20:19:54 INFO - 'log_to_console': True, 20:19:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:19:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:19:54 INFO - 'opt_config_files': (), 20:19:54 INFO - 'pip_index': False, 20:19:54 INFO - 'sps_profile': False, 20:19:54 INFO - 'sps_profile_interval': 0, 20:19:54 INFO - 'suite': 'dromaeojs-e10s', 20:19:54 INFO - 'system_bits': '32', 20:19:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:19:54 INFO - 'title': 'talos-linux64-ix-019', 20:19:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:19:54 INFO - 'use_talos_json': True, 20:19:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:19:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:19:54 INFO - 'work_dir': 'build'} 20:19:54 INFO - ##### 20:19:54 INFO - ##### Running clobber step. 20:19:54 INFO - ##### 20:19:54 INFO - Running pre-action listener: _resource_record_pre_action 20:19:54 INFO - Running main action method: clobber 20:19:54 INFO - rmtree: /builds/slave/test/build 20:19:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:19:54 INFO - Running post-action listener: _resource_record_post_action 20:19:54 INFO - ##### 20:19:54 INFO - ##### Finished clobber step (success) 20:19:54 INFO - ##### 20:19:54 INFO - ##### 20:19:54 INFO - ##### Running read-buildbot-config step. 20:19:54 INFO - ##### 20:19:54 INFO - Running pre-action listener: _resource_record_pre_action 20:19:54 INFO - Running main action method: read_buildbot_config 20:19:54 INFO - Using buildbot properties: 20:19:54 INFO - { 20:19:54 INFO - "project": "", 20:19:54 INFO - "product": "firefox", 20:19:54 INFO - "script_repo_revision": "production", 20:19:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:19:54 INFO - "repository": "", 20:19:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:19:54 INFO - "buildid": "20160510173021", 20:19:54 INFO - "pgo_build": "True", 20:19:54 INFO - "basedir": "/builds/slave/test", 20:19:54 INFO - "buildnumber": 450, 20:19:54 INFO - "slavename": "talos-linux64-ix-019", 20:19:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:19:54 INFO - "platform": "ubuntu64_hw", 20:19:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:19:54 INFO - "branch": "fx-team", 20:19:54 INFO - "repo_path": "integration/fx-team", 20:19:54 INFO - "revision": "027b0144a1a6c2d62dfb1656e41597acfe6a22ef", 20:19:54 INFO - "stage_platform": "linux64-pgo", 20:19:54 INFO - "builduid": "b6a075f48b8b4a7e8410db36d3376e88", 20:19:54 INFO - "slavebuilddir": "test" 20:19:54 INFO - } 20:19:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:19:54 INFO - Running post-action listener: _resource_record_post_action 20:19:54 INFO - ##### 20:19:54 INFO - ##### Finished read-buildbot-config step (success) 20:19:54 INFO - ##### 20:19:54 INFO - ##### 20:19:54 INFO - ##### Running download-and-extract step. 20:19:54 INFO - ##### 20:19:54 INFO - Running pre-action listener: _resource_record_pre_action 20:19:54 INFO - Running main action method: download_and_extract 20:19:54 INFO - mkdir: /builds/slave/test/build/tests 20:19:54 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')]} 20:19:54 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:20:01 INFO - Downloaded 1361 bytes. 20:20:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:20:01 INFO - Using the following test package requirements: 20:20:01 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:01 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:20:01 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:20:01 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:01 INFO - u'jsshell-linux-x86_64.zip'], 20:20:01 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:20:01 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:01 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:20:01 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:20:01 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:20:01 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:20:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:20:01 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')]} 20:20:01 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:20:03 INFO - Downloaded 23903496 bytes. 20:20:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:20:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:20:04 INFO - Return code: 0 20:20:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:20: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')]} 20:20:04 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:20:07 INFO - Downloaded 23903496 bytes. 20:20:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:20:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:20:08 INFO - Return code: 0 20:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:08 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:20:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:20:09 INFO - Downloaded 10840152 bytes. 20:20:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:20:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:20:09 INFO - Return code: 0 20:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:09 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:20:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:20:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:20:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:20:11 INFO - Downloaded 58334754 bytes. 20:20:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:20:11 INFO - mkdir: /builds/slave/test/properties 20:20:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:20:11 INFO - Writing to file /builds/slave/test/properties/build_url 20:20:11 INFO - Contents: 20:20:11 INFO - build_url:https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:20:12 INFO - Running post-action listener: _resource_record_post_action 20:20:12 INFO - Running post-action listener: set_extra_try_arguments 20:20:12 INFO - ##### 20:20:12 INFO - ##### Finished download-and-extract step (success) 20:20:12 INFO - ##### 20:20:12 INFO - ##### 20:20:12 INFO - ##### Running populate-webroot step. 20:20:12 INFO - ##### 20:20:12 INFO - Running pre-action listener: _resource_record_pre_action 20:20:12 INFO - Running main action method: populate_webroot 20:20:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:20:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:20:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:20:12 INFO - '--tppagecycles', 20:20:12 INFO - '7'], 20:20:12 INFO - 'tests': ['tsvgm']}}, 20:20:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:20:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:20:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:20:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:20:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:12 INFO - 'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:12 INFO - 'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['damp', 'tps']}, 20:20:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:12 INFO - 'tests': ['damp', 'tps']}, 20:20:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['dromaeo_dom']}, 20:20:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:20:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['a11yr', 20:20:12 INFO - 'ts_paint', 20:20:12 INFO - 'tpaint', 20:20:12 INFO - 'sessionrestore', 20:20:12 INFO - 'sessionrestore_no_auto_restore', 20:20:12 INFO - 'tabpaint']}, 20:20:12 INFO - 'other-e10s': {'tests': ['a11yr', 20:20:12 INFO - 'ts_paint', 20:20:12 INFO - 'tpaint', 20:20:12 INFO - 'sessionrestore', 20:20:12 INFO - 'sessionrestore_no_auto_restore', 20:20:12 INFO - 'tabpaint']}, 20:20:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:20:12 INFO - 'ts_paint', 20:20:12 INFO - 'tpaint', 20:20:12 INFO - 'sessionrestore', 20:20:12 INFO - 'sessionrestore_no_auto_restore', 20:20:12 INFO - 'tabpaint']}, 20:20:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:20:12 INFO - 'ts_paint', 20:20:12 INFO - 'tpaint', 20:20:12 INFO - 'sessionrestore', 20:20:12 INFO - 'sessionrestore_no_auto_restore', 20:20:12 INFO - 'tabpaint']}, 20:20:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['a11yr', 20:20:12 INFO - 'ts_paint', 20:20:12 INFO - 'tpaint', 20:20:12 INFO - 'sessionrestore', 20:20:12 INFO - 'sessionrestore_no_auto_restore', 20:20:12 INFO - 'tabpaint']}, 20:20:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['a11yr', 20:20:12 INFO - 'ts_paint', 20:20:12 INFO - 'tpaint', 20:20:12 INFO - 'sessionrestore', 20:20:12 INFO - 'sessionrestore_no_auto_restore', 20:20:12 INFO - 'tabpaint']}, 20:20:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['tsvgx', 20:20:12 INFO - 'tsvgr_opacity', 20:20:12 INFO - 'tart', 20:20:12 INFO - 'tscrollx', 20:20:12 INFO - 'cart']}, 20:20:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:20:12 INFO - 'tsvgr_opacity', 20:20:12 INFO - 'tart', 20:20:12 INFO - 'tscrollx', 20:20:12 INFO - 'cart']}, 20:20:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:12 INFO - 'talos_options': ['--disable-e10s'], 20:20:12 INFO - 'tests': ['tp5o']}, 20:20:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:12 INFO - 'tests': ['tp5o']}, 20:20:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:12 INFO - 'talos_options': ['--disable-e10s', 20:20:12 INFO - '--xperf_path', 20:20:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:12 INFO - 'tests': ['tp5n']}, 20:20:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:12 INFO - 'talos_options': ['--xperf_path', 20:20:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:12 INFO - 'tests': ['tp5n']}}, 20:20:12 INFO - 'talos.zip': {'path': '', 20:20:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:20:12 INFO - Running post-action listener: _resource_record_post_action 20:20:12 INFO - ##### 20:20:12 INFO - ##### Finished populate-webroot step (success) 20:20:12 INFO - ##### 20:20:12 INFO - ##### 20:20:12 INFO - ##### Running create-virtualenv step. 20:20:12 INFO - ##### 20:20:12 INFO - Running pre-action listener: _resource_record_pre_action 20:20:12 INFO - Running main action method: create_virtualenv 20:20:12 INFO - Creating virtualenv /builds/slave/test/build/venv 20:20:12 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 20:20:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:20:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:20:12 INFO - Using real prefix '/usr' 20:20:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:20:12 INFO - Installing distribute.............................................................................................................................................................................................done. 20:20:14 INFO - Installing pip.................done. 20:20:14 INFO - Return code: 0 20:20:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f30b3800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f638e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', '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 20:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:20:14 INFO - Using env: {'DISPLAY': ':0', 20:20:14 INFO - 'HOME': '/home/cltbld', 20:20:14 INFO - 'LANG': 'en_US.UTF-8', 20:20:14 INFO - 'LANGUAGE': 'en_US:en', 20:20:14 INFO - 'LOGNAME': 'cltbld', 20:20:14 INFO - 'MAIL': '/var/mail/cltbld', 20:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:14 INFO - 'MOZ_NO_REMOTE': '1', 20:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:14 INFO - 'NO_EM_RESTART': '1', 20:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:14 INFO - 'PWD': '/builds/slave/test', 20:20:14 INFO - 'SHELL': '/bin/bash', 20:20:14 INFO - 'SHLVL': '1', 20:20:14 INFO - 'TERM': 'linux', 20:20:14 INFO - 'TMOUT': '86400', 20:20:14 INFO - 'USER': 'cltbld', 20:20:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:14 INFO - '_': '/tools/buildbot/bin/python'} 20:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:14 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 20:20:14 INFO - Cleaning up... 20:20:14 INFO - Return code: 0 20:20:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f30b3800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f638e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', '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 20:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:20:14 INFO - Using env: {'DISPLAY': ':0', 20:20:14 INFO - 'HOME': '/home/cltbld', 20:20:14 INFO - 'LANG': 'en_US.UTF-8', 20:20:14 INFO - 'LANGUAGE': 'en_US:en', 20:20:14 INFO - 'LOGNAME': 'cltbld', 20:20:14 INFO - 'MAIL': '/var/mail/cltbld', 20:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:14 INFO - 'MOZ_NO_REMOTE': '1', 20:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:14 INFO - 'NO_EM_RESTART': '1', 20:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:14 INFO - 'PWD': '/builds/slave/test', 20:20:14 INFO - 'SHELL': '/bin/bash', 20:20:14 INFO - 'SHLVL': '1', 20:20:14 INFO - 'TERM': 'linux', 20:20:14 INFO - 'TMOUT': '86400', 20:20:14 INFO - 'USER': 'cltbld', 20:20:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:14 INFO - '_': '/tools/buildbot/bin/python'} 20:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:15 INFO - Downloading/unpacking psutil>=0.7.1 20:20:15 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 20:20:15 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 20:20:15 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 20:20:15 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 20:20:15 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 20:20:15 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 20:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:20:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:17 INFO - Installing collected packages: psutil 20:20:17 INFO - Running setup.py install for psutil 20:20:17 INFO - building 'psutil._psutil_linux' extension 20:20:17 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 20:20:17 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 20:20:17 INFO - building 'psutil._psutil_posix' extension 20:20:17 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 20:20:17 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 20:20:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:17 INFO - Successfully installed psutil 20:20:17 INFO - Cleaning up... 20:20:17 INFO - Return code: 0 20:20:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:20:17 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')]} 20:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:17 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')]} 20:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f30b3800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f638e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', '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 20:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:20:17 INFO - Using env: {'DISPLAY': ':0', 20:20:17 INFO - 'HOME': '/home/cltbld', 20:20:17 INFO - 'LANG': 'en_US.UTF-8', 20:20:17 INFO - 'LANGUAGE': 'en_US:en', 20:20:17 INFO - 'LOGNAME': 'cltbld', 20:20:17 INFO - 'MAIL': '/var/mail/cltbld', 20:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:17 INFO - 'MOZ_NO_REMOTE': '1', 20:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:17 INFO - 'NO_EM_RESTART': '1', 20:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:17 INFO - 'PWD': '/builds/slave/test', 20:20:17 INFO - 'SHELL': '/bin/bash', 20:20:17 INFO - 'SHLVL': '1', 20:20:17 INFO - 'TERM': 'linux', 20:20:17 INFO - 'TMOUT': '86400', 20:20:17 INFO - 'USER': 'cltbld', 20:20:17 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:17 INFO - '_': '/tools/buildbot/bin/python'} 20:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:20:17 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 20:20:17 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 20:20:17 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 20:20:17 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 20:20:17 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 20:20:17 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 20:20:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:20:19 INFO - Installing collected packages: mozsystemmonitor 20:20:19 INFO - Running setup.py install for mozsystemmonitor 20:20:19 INFO - Successfully installed mozsystemmonitor 20:20:19 INFO - Cleaning up... 20:20:19 INFO - Return code: 0 20:20:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:19 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 0x7f30b3800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f638e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', '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 20:20:19 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 20:20:19 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 20:20:19 INFO - Using env: {'DISPLAY': ':0', 20:20:19 INFO - 'HOME': '/home/cltbld', 20:20:19 INFO - 'LANG': 'en_US.UTF-8', 20:20:19 INFO - 'LANGUAGE': 'en_US:en', 20:20:19 INFO - 'LOGNAME': 'cltbld', 20:20:19 INFO - 'MAIL': '/var/mail/cltbld', 20:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:19 INFO - 'MOZ_NO_REMOTE': '1', 20:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:19 INFO - 'NO_EM_RESTART': '1', 20:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:19 INFO - 'PWD': '/builds/slave/test', 20:20:19 INFO - 'SHELL': '/bin/bash', 20:20:19 INFO - 'SHLVL': '1', 20:20:19 INFO - 'TERM': 'linux', 20:20:19 INFO - 'TMOUT': '86400', 20:20:19 INFO - 'USER': 'cltbld', 20:20:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:19 INFO - '_': '/tools/buildbot/bin/python'} 20:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:19 INFO - Downloading/unpacking blobuploader==1.2.4 20:20:19 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 20:20:19 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 20:20:19 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 20:20:19 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 20:20:19 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 20:20:19 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 20:20:21 INFO - Downloading blobuploader-1.2.4.tar.gz 20:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:20:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:20:21 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 20:20:21 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 20:20:21 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 20:20:21 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 20:20:21 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 20:20:21 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 20:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:20:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:20:22 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 20:20:22 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 20:20:22 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 20:20:22 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 20:20:22 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 20:20:22 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 20:20:22 INFO - Downloading docopt-0.6.1.tar.gz 20:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:20:22 INFO - Installing collected packages: blobuploader, requests, docopt 20:20:22 INFO - Running setup.py install for blobuploader 20:20:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:20:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:20:22 INFO - Running setup.py install for requests 20:20:22 INFO - Running setup.py install for docopt 20:20:23 INFO - Successfully installed blobuploader requests docopt 20:20:23 INFO - Cleaning up... 20:20:23 INFO - Return code: 0 20:20:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:23 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 0x7f30b3800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f638e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', '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 20:20:23 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 20:20:23 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 20:20:23 INFO - Using env: {'DISPLAY': ':0', 20:20:23 INFO - 'HOME': '/home/cltbld', 20:20:23 INFO - 'LANG': 'en_US.UTF-8', 20:20:23 INFO - 'LANGUAGE': 'en_US:en', 20:20:23 INFO - 'LOGNAME': 'cltbld', 20:20:23 INFO - 'MAIL': '/var/mail/cltbld', 20:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:23 INFO - 'MOZ_NO_REMOTE': '1', 20:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:23 INFO - 'NO_EM_RESTART': '1', 20:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:23 INFO - 'PWD': '/builds/slave/test', 20:20:23 INFO - 'SHELL': '/bin/bash', 20:20:23 INFO - 'SHLVL': '1', 20:20:23 INFO - 'TERM': 'linux', 20:20:23 INFO - 'TMOUT': '86400', 20:20:23 INFO - 'USER': 'cltbld', 20:20:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:23 INFO - '_': '/tools/buildbot/bin/python'} 20:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:23 INFO - Running setup.py (path:/tmp/pip-WKWdmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:23 INFO - Running setup.py (path:/tmp/pip-iLWHfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:23 INFO - Running setup.py (path:/tmp/pip-3cZyuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:23 INFO - Running setup.py (path:/tmp/pip-PIHSkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:23 INFO - Running setup.py (path:/tmp/pip-lTcA6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:23 INFO - Running setup.py (path:/tmp/pip-4vSsP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:23 INFO - Running setup.py (path:/tmp/pip-e1Sbut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:23 INFO - Running setup.py (path:/tmp/pip-FNLl6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:23 INFO - Running setup.py (path:/tmp/pip-dGQodF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:23 INFO - Running setup.py (path:/tmp/pip-y60qVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:23 INFO - Running setup.py (path:/tmp/pip-WioX1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:23 INFO - Running setup.py (path:/tmp/pip-jAXWFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:23 INFO - Running setup.py (path:/tmp/pip-Jl_d6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:24 INFO - Running setup.py (path:/tmp/pip-Dh8qZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:24 INFO - Running setup.py (path:/tmp/pip-FJ2rtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:24 INFO - Running setup.py (path:/tmp/pip-xkqu6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:24 INFO - Running setup.py (path:/tmp/pip-GXf9UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:20:24 INFO - Running setup.py install for manifestparser 20:20:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozcrash 20:20:24 INFO - Running setup.py install for mozdebug 20:20:24 INFO - Running setup.py install for mozdevice 20:20:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozfile 20:20:24 INFO - Running setup.py install for mozhttpd 20:20:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozinfo 20:20:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozInstall 20:20:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozleak 20:20:25 INFO - Running setup.py install for mozlog 20:20:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Running setup.py install for moznetwork 20:20:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Running setup.py install for mozprocess 20:20:25 INFO - Running setup.py install for mozprofile 20:20:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Running setup.py install for mozrunner 20:20:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Running setup.py install for mozscreenshot 20:20:25 INFO - Running setup.py install for moztest 20:20:25 INFO - Running setup.py install for mozversion 20:20:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:20:25 INFO - Cleaning up... 20:20:25 INFO - Return code: 0 20:20:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:25 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 0x7f30b3800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f638e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', '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 20:20:25 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 20:20:25 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 20:20:25 INFO - Using env: {'DISPLAY': ':0', 20:20:25 INFO - 'HOME': '/home/cltbld', 20:20:25 INFO - 'LANG': 'en_US.UTF-8', 20:20:25 INFO - 'LANGUAGE': 'en_US:en', 20:20:25 INFO - 'LOGNAME': 'cltbld', 20:20:25 INFO - 'MAIL': '/var/mail/cltbld', 20:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:25 INFO - 'MOZ_NO_REMOTE': '1', 20:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:25 INFO - 'NO_EM_RESTART': '1', 20:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:25 INFO - 'PWD': '/builds/slave/test', 20:20:25 INFO - 'SHELL': '/bin/bash', 20:20:25 INFO - 'SHLVL': '1', 20:20:25 INFO - 'TERM': 'linux', 20:20:25 INFO - 'TMOUT': '86400', 20:20:25 INFO - 'USER': 'cltbld', 20:20:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:25 INFO - '_': '/tools/buildbot/bin/python'} 20:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:26 INFO - Running setup.py (path:/tmp/pip-EQ5qlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:26 INFO - Running setup.py (path:/tmp/pip-3iLWii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:26 INFO - Running setup.py (path:/tmp/pip-QTczTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:26 INFO - Running setup.py (path:/tmp/pip-OUnrRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:26 INFO - Running setup.py (path:/tmp/pip-SD6IIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:26 INFO - Running setup.py (path:/tmp/pip-7tpYvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:26 INFO - Running setup.py (path:/tmp/pip-yMiNYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:26 INFO - Running setup.py (path:/tmp/pip-SHaLmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:26 INFO - Running setup.py (path:/tmp/pip-KUsLr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:26 INFO - Running setup.py (path:/tmp/pip-9wsaUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:26 INFO - Running setup.py (path:/tmp/pip-uNL9Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:26 INFO - Running setup.py (path:/tmp/pip-slapq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:26 INFO - Running setup.py (path:/tmp/pip-ZVOwSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:26 INFO - Running setup.py (path:/tmp/pip-1hjm1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:26 INFO - Running setup.py (path:/tmp/pip-68Dhb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:26 INFO - Running setup.py (path:/tmp/pip-9lVBLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:26 INFO - Running setup.py (path:/tmp/pip-ZXd2zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:27 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)) 20:20:27 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)) 20:20:27 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)) 20:20:27 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)) 20:20:27 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)) 20:20:27 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)) 20:20:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:20:27 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 20:20:27 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 20:20:27 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 20:20:27 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 20:20:27 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 20:20:27 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 20:20:28 INFO - Downloading blessings-1.6.tar.gz 20:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:20:28 INFO - Installing collected packages: blessings 20:20:28 INFO - Running setup.py install for blessings 20:20:29 INFO - Successfully installed blessings 20:20:29 INFO - Cleaning up... 20:20:29 INFO - Return code: 0 20:20:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:20:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:29 INFO - Reading from file tmpfile_stdout 20:20:29 INFO - Current package versions: 20:20:29 INFO - argparse == 1.2.1 20:20:29 INFO - blessings == 1.6 20:20:29 INFO - blobuploader == 1.2.4 20:20:29 INFO - docopt == 0.6.1 20:20:29 INFO - manifestparser == 1.1 20:20:29 INFO - mozInstall == 1.12 20:20:29 INFO - mozcrash == 0.17 20:20:29 INFO - mozdebug == 0.1 20:20:29 INFO - mozdevice == 0.48 20:20:29 INFO - mozfile == 1.2 20:20:29 INFO - mozhttpd == 0.7 20:20:29 INFO - mozinfo == 0.9 20:20:29 INFO - mozleak == 0.1 20:20:29 INFO - mozlog == 3.1 20:20:29 INFO - moznetwork == 0.27 20:20:29 INFO - mozprocess == 0.22 20:20:29 INFO - mozprofile == 0.28 20:20:29 INFO - mozrunner == 6.11 20:20:29 INFO - mozscreenshot == 0.1 20:20:29 INFO - mozsystemmonitor == 0.0 20:20:29 INFO - moztest == 0.7 20:20:29 INFO - mozversion == 1.4 20:20:29 INFO - psutil == 3.1.1 20:20:29 INFO - requests == 1.2.3 20:20:29 INFO - wsgiref == 0.1.2 20:20:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:29 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')]} 20:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:29 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')]} 20:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:29 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 0x7f30b3800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f638e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', '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 20:20:29 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 20:20:29 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 20:20:29 INFO - Using env: {'DISPLAY': ':0', 20:20:29 INFO - 'HOME': '/home/cltbld', 20:20:29 INFO - 'LANG': 'en_US.UTF-8', 20:20:29 INFO - 'LANGUAGE': 'en_US:en', 20:20:29 INFO - 'LOGNAME': 'cltbld', 20:20:29 INFO - 'MAIL': '/var/mail/cltbld', 20:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:29 INFO - 'MOZ_NO_REMOTE': '1', 20:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:29 INFO - 'NO_EM_RESTART': '1', 20:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:29 INFO - 'PWD': '/builds/slave/test', 20:20:29 INFO - 'SHELL': '/bin/bash', 20:20:29 INFO - 'SHLVL': '1', 20:20:29 INFO - 'TERM': 'linux', 20:20:29 INFO - 'TMOUT': '86400', 20:20:29 INFO - 'USER': 'cltbld', 20:20:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:29 INFO - '_': '/tools/buildbot/bin/python'} 20:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:29 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)) 20:20:29 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)) 20:20:29 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)) 20:20:29 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)) 20:20:29 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)) 20:20:29 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)) 20:20:29 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)) 20:20:29 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)) 20:20:29 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)) 20:20:29 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)) 20:20:29 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)) 20:20:29 INFO - Cleaning up... 20:20:29 INFO - Return code: 0 20:20:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:20:29 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')]} 20:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:29 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')]} 20:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:29 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 0x7f30b3800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f638e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', '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 20:20:29 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 20:20:29 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 20:20:29 INFO - Using env: {'DISPLAY': ':0', 20:20:29 INFO - 'HOME': '/home/cltbld', 20:20:29 INFO - 'LANG': 'en_US.UTF-8', 20:20:29 INFO - 'LANGUAGE': 'en_US:en', 20:20:29 INFO - 'LOGNAME': 'cltbld', 20:20:29 INFO - 'MAIL': '/var/mail/cltbld', 20:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:29 INFO - 'MOZ_NO_REMOTE': '1', 20:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:29 INFO - 'NO_EM_RESTART': '1', 20:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:29 INFO - 'PWD': '/builds/slave/test', 20:20:29 INFO - 'SHELL': '/bin/bash', 20:20:29 INFO - 'SHLVL': '1', 20:20:29 INFO - 'TERM': 'linux', 20:20:29 INFO - 'TMOUT': '86400', 20:20:29 INFO - 'USER': 'cltbld', 20:20:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:29 INFO - '_': '/tools/buildbot/bin/python'} 20:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:29 INFO - Downloading/unpacking jsonschema 20:20:29 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 20:20:29 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 20:20:29 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 20:20:29 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 20:20:29 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 20:20:29 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 20:20:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:20:31 INFO - Downloading/unpacking functools32 (from jsonschema) 20:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:31 INFO - Downloading functools32-3.2.3-2.tar.gz 20:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:20:31 INFO - warning: no files found matching '*.txt' 20:20:31 INFO - no previously-included directories found matching 'build' 20:20:31 INFO - no previously-included directories found matching 'dist' 20:20:31 INFO - no previously-included directories found matching '.git*' 20:20:31 INFO - Installing collected packages: jsonschema, functools32 20:20:31 INFO - Running setup.py install for functools32 20:20:31 INFO - warning: no files found matching '*.txt' 20:20:31 INFO - no previously-included directories found matching 'build' 20:20:31 INFO - no previously-included directories found matching 'dist' 20:20:31 INFO - no previously-included directories found matching '.git*' 20:20:31 INFO - Successfully installed jsonschema functools32 20:20:31 INFO - Cleaning up... 20:20:31 INFO - Return code: 0 20:20:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f30b3800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f638e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', '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 20:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:20:31 INFO - Using env: {'DISPLAY': ':0', 20:20:31 INFO - 'HOME': '/home/cltbld', 20:20:31 INFO - 'LANG': 'en_US.UTF-8', 20:20:31 INFO - 'LANGUAGE': 'en_US:en', 20:20:31 INFO - 'LOGNAME': 'cltbld', 20:20:31 INFO - 'MAIL': '/var/mail/cltbld', 20:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:31 INFO - 'MOZ_NO_REMOTE': '1', 20:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:31 INFO - 'NO_EM_RESTART': '1', 20:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:31 INFO - 'PWD': '/builds/slave/test', 20:20:31 INFO - 'SHELL': '/bin/bash', 20:20:31 INFO - 'SHLVL': '1', 20:20:31 INFO - 'TERM': 'linux', 20:20:31 INFO - 'TMOUT': '86400', 20:20:31 INFO - 'USER': 'cltbld', 20:20:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:31 INFO - '_': '/tools/buildbot/bin/python'} 20:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:32 INFO - Downloading/unpacking flake8 20:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:20:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:20:33 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 20:20:33 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 20:20:33 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 20:20:33 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 20:20:33 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 20:20:33 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 20:20:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:20:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:20:34 INFO - no previously-included directories found matching 'docs/_build' 20:20:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:20:34 INFO - Running setup.py install for pep8 20:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:20:34 INFO - no previously-included directories found matching 'docs/_build' 20:20:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:20:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:20:34 INFO - Cleaning up... 20:20:34 INFO - Return code: 0 20:20:34 INFO - Running post-action listener: _resource_record_post_action 20:20:34 INFO - Running post-action listener: _start_resource_monitoring 20:20:34 INFO - Starting resource monitoring. 20:20:34 INFO - ##### 20:20:34 INFO - ##### Finished create-virtualenv step (success) 20:20:34 INFO - ##### 20:20:34 INFO - ##### 20:20:34 INFO - ##### Running install step. 20:20:34 INFO - ##### 20:20:34 INFO - Running pre-action listener: _resource_record_pre_action 20:20:34 INFO - Running main action method: install 20:20:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:35 INFO - Reading from file tmpfile_stdout 20:20:35 INFO - Detecting whether we're running mozinstall >=1.0... 20:20:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:20:35 INFO - Reading from file tmpfile_stdout 20:20:35 INFO - Output received: 20:20:35 INFO - Usage: mozinstall [options] installer 20:20:35 INFO - Options: 20:20:35 INFO - -h, --help show this help message and exit 20:20:35 INFO - -d DEST, --destination=DEST 20:20:35 INFO - Directory to install application into. [default: 20:20:35 INFO - "/builds/slave/test"] 20:20:35 INFO - --app=APP Application being installed. [default: firefox] 20:20:35 INFO - mkdir: /builds/slave/test/build/application 20:20:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:20:51 INFO - Reading from file tmpfile_stdout 20:20:51 INFO - Output received: 20:20:51 INFO - /builds/slave/test/build/application/firefox/firefox 20:20:51 INFO - Running post-action listener: _resource_record_post_action 20:20:51 INFO - ##### 20:20:51 INFO - ##### Finished install step (success) 20:20:51 INFO - ##### 20:20:51 INFO - ##### 20:20:51 INFO - ##### Running run-tests step. 20:20:51 INFO - ##### 20:20:51 INFO - Running pre-action listener: _resource_record_pre_action 20:20:51 INFO - Running main action method: run_tests 20:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:20:51 INFO - Python 2.7.3 20:20:51 INFO - Return code: 0 20:20:51 INFO - grabbing minidump binary from tooltool 20:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:51 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 0x1ff2b20>, '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 0x1ff3a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:20:51 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 20:20:51 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 20:20:51 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 20:20:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:20:51 INFO - Return code: 0 20:20:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:20:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:20:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:20:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:20:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:20:52 INFO - Return code: 0 20:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:20:52 INFO - Using env: {'DISPLAY': ':0', 20:20:52 INFO - 'HOME': '/home/cltbld', 20:20:52 INFO - 'LANG': 'en_US.UTF-8', 20:20:52 INFO - 'LANGUAGE': 'en_US:en', 20:20:52 INFO - 'LOGNAME': 'cltbld', 20:20:52 INFO - 'MAIL': '/var/mail/cltbld', 20:20:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:20:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:52 INFO - 'MOZ_NO_REMOTE': '1', 20:20:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:52 INFO - 'NO_EM_RESTART': '1', 20:20:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:52 INFO - 'PWD': '/builds/slave/test', 20:20:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:20:52 INFO - 'SHELL': '/bin/bash', 20:20:52 INFO - 'SHLVL': '1', 20:20:52 INFO - 'TERM': 'linux', 20:20:52 INFO - 'TMOUT': '86400', 20:20:52 INFO - 'USER': 'cltbld', 20:20:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314', 20:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:52 INFO - '_': '/tools/buildbot/bin/python'} 20:20:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:20:52 INFO - mozversion application_buildid: 20160510173021 20:20:52 INFO - mozversion application_changeset: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef 20:20:52 INFO - mozversion application_display_name: Nightly 20:20:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:20:52 INFO - mozversion application_name: Firefox 20:20:52 INFO - mozversion application_remotingname: firefox 20:20:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:20:52 INFO - mozversion application_vendor: Mozilla 20:20:52 INFO - mozversion application_version: 49.0a1 20:20:52 INFO - mozversion platform_buildid: 20160510173021 20:20:52 INFO - mozversion platform_changeset: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef 20:20:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:20:52 INFO - mozversion platform_version: 49.0a1 20:20:52 INFO - using testdate: 1462936852 20:20:52 INFO - actual date: 1462936852 20:20:52 INFO - starting webserver on 'localhost:53361' 20:20:52 INFO - SUITE-START | Running 2 tests 20:20:52 INFO - TEST-START | dromaeo_css 20:20:52 INFO - operating with platform_type : linux_ 20:20:52 INFO - Initialising browser for dromaeo_css test... 20:20:52 INFO - TEST-INFO | started process 23365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWS7uJq/profile http://localhost:53361/getInfo.html) 20:20:56 INFO - PROCESS | 23365 | 20:20:56 INFO - PROCESS | 23365 | (process:23434): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:20:57 INFO - PROCESS | 23365 | __metrics Screen width/height:1600/1200 20:20:57 INFO - PROCESS | 23365 | colorDepth:24 20:20:57 INFO - PROCESS | 23365 | Browser inner width/height: 1024/697 20:20:57 INFO - PROCESS | 23365 | __metrics 20:20:58 ERROR - PROCESS | 23365 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:20:58 INFO - TEST-INFO | 23365: exit 0 20:20:58 INFO - Browser initialized. 20:20:58 INFO - Running cycle 1/1 for dromaeo_css test... 20:20:58 INFO - TEST-INFO | started process 23485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWS7uJq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:00 INFO - PROCESS | 23485 | 20:21:00 INFO - PROCESS | 23485 | (process:23547): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:21:10 INFO - PROCESS | 23485 | RSS: Main: 163069952 20:21:10 INFO - PROCESS | 23485 | 20:21:59 INFO - PROCESS | 23485 | 1462936919854 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] 20:24:07 INFO - PROCESS | 23485 | Cycle 1(1): loaded http://localhost:53361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53361/tests/dromaeo/cssquery-ext.html) 20:24:08 INFO - PROCESS | 23485 | RSS: Main: 164835328 20:24:08 INFO - PROCESS | 23485 | 20:27:10 INFO - PROCESS | 23485 | Cycle 1(1): loaded http://localhost:53361/tests/dromaeo/cssquery-ext.html (next: http://localhost:53361/tests/dromaeo/cssquery-jquery.html) 20:27:11 INFO - PROCESS | 23485 | RSS: Main: 165548032 20:27:11 INFO - PROCESS | 23485 | 20:30:12 INFO - PROCESS | 23485 | Cycle 1(1): loaded http://localhost:53361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53361/tests/dromaeo/cssquery-mootools.html) 20:30:13 INFO - PROCESS | 23485 | RSS: Main: 166854656 20:30:13 INFO - PROCESS | 23485 | 20:33:15 INFO - PROCESS | 23485 | Cycle 1(1): loaded http://localhost:53361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53361/tests/dromaeo/cssquery-prototype.html) 20:33:15 INFO - PROCESS | 23485 | RSS: Main: 164802560 20:33:15 INFO - PROCESS | 23485 | 20:36:18 INFO - PROCESS | 23485 | Cycle 1(1): loaded http://localhost:53361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53361/tests/dromaeo/cssquery-yui.html) 20:36:18 INFO - PROCESS | 23485 | RSS: Main: 166354944 20:36:18 INFO - PROCESS | 23485 | 20:39:21 INFO - PROCESS | 23485 | Cycle 1(1): loaded http://localhost:53361/tests/dromaeo/cssquery-yui.html (next: http://localhost:53361/tests/dromaeo/cssquery-dojo.html) 20:39:21 INFO - PROCESS | 23485 | RSS: Main: 167878656 20:39:21 INFO - PROCESS | 23485 | 20:39:21 INFO - PROCESS | 23485 | __start_tp_report 20:39:21 INFO - PROCESS | 23485 | _x_x_mozilla_page_load 20:39:21 INFO - PROCESS | 23485 | _x_x_mozilla_page_load_details 20:39:21 INFO - PROCESS | 23485 | |i|pagename|runs| 20:39:21 INFO - PROCESS | 23485 | |0;dojo.html;3155.5739975103356;3166.952495712564;3192.3934452454046;3221.259110404606;3234.77356585039;5432.891342173154;5442.537384322332;5471.343438787351;5497.972510137443;5539.9169012464745;5390.21841832934;5480.890382192354;5487.067198576242;5498.037843377413;5591.916121258174;4855.271709243606;4924.113659541281;5050.292958985727;5087.9569688214015;5122.795088196486;713.3929699897484;4855.805767769302;4906.386701662293;4961.627877909171;4973.602111831045;4940.481249468808;4995.950040499603;4998.300237966688;5007.798128449164;5023.974880125595;5003.724795136266;5004.924926126111;5031.32077169581;5035.949640503584;5076.390833100052;4946.431160416562;4958.834673851642;4958.9752051239875;4988.65079444439;4998.550130488237;5382.381026181961;5412.242286079952;5428.565714742811;5455.509004189642;5510.256115424407;5550.666959982414;5799.594028418012;5825.592208545403;5829;5852.590318677694;5895.4399332063385;5896.941030589725;5964;5996.580239383245;5999.490043346321;5512.366077901052;5534.391216966131;5543.307086614173;5546.528545073633;5551.694656793875;5850.912236316459;5961.28464584244;5965.940340596539;5986.281646202484;6016.819495415145;5712.371639119693;5746.4253574643035;5748.655080695172;5815.709214539256;5837;5904.822855314347;5912.822615321547;5918.437748413894;5919.67441790697;5942.910856337158;5814.360420353758;5836.824895253149;5862.677552734641;5899.292084949748;5901.58688891782;5861.853453663607;5878.794242201502;5881.3530511643685;5892.322382925932;5898.734556944948;4318.028443600228;4359.782010899442;4366.497852746911;4387;4411.382406463098;3798.430235464647;3904.6681032112588;3956.742811717229;3969.2458432898234;3982.880513584597;5485.122380419114;5546.195801608744;5617.494425501643;5635.436456354414;5656.8020119295625;5716.171155182476;5920.644761314335;5957.940420595739;5968.343482216953;5971.5222782177325;5508.476694713996;5564.026295398289;5565.41563135873;5566.471185237396;5570.86072848182;4818.494058123846;4865.051314993613;4881.365422495053;4883;4928.989557140778;5880.705964701748;6015.488683461867;6080.118382834465;6088.573799833969;6093.299270583851;5760.164776107525;5783.88432231353;5847.327557330791;5939.10913362999;5968.671723055274;6057.848553786191;6113.052476866093;6124;6131.816045518642;6137.048757442603;5597.916031259453;5792;5799.2750906136735;5847.093700476433;5857.355690873916;5964.612300200473;6013.729382177725;6016.368281330398;6022.36765139654;6053.9091913622215;5811.593188476766;5835.387284335084;5835.94164058371;5836.241288632451;5866.061430171152;5553.4724201200825;5723.255976723;5737.168110623853;5739.139129130664;5774.451427114417;5621.409751976147;5656.236408084856;5660.518855897295;5671.574631902707;5713.085906254979;5680.375158732453;5783.913241301468;5800.8259752207505;5809.36097029318;5823.854403639773;5466.535344495763;5506.366767821752;5539.750711217925;5605.719714014364;5641.717914104196 20:39:21 INFO - PROCESS | 23485 | |1;ext.html;577.2236342119847;596.1891827115124;609.7835268479689;614.5053232148119;640.8397900524869;37894.81052594737;38588;42049.159016819685;42051.57948420523;42313.15373692532;43919.56080439195;44106.338404923874;44197.779011104976;44328.778356108174;44575.77712111443;8773.42972706772;8901.332400069989;8920.687775927843;8958.731238062868;8977.506237156953;8686.652533898636;8774.956125219365;8846.5576721164;8847.513386763725;8896.733098007071;8913.68802091927;8942.150495702897;8947.239484643813;8968.327375446836;8975.596098175598;8862.778430539223;8867.73396798094;8894.777630559256;8904.51025193614;8907.465552066897;8760.211580957744;8764.298856091498;8776.868346974801;8824.073472285381;8852.955735221347;33979.6602033979;41409.79295103535;41535.584644153474;41567.168656627;41954.58045419537;3371.998786836196;3518.7712798668003;3537.2394935088823;3608.9819550902075;3655.780653160819;29657.110286691433;30049.849750751324;30501.389972200654;30559.388812223853;31158.37683246345;3804.486394336757;3813.809309534512;3829.6553310202216;3855.4409610606585;3869.941950870739;262415;263726;264323.9999999981;265404;265877;33967;34091.65908340885;34121.61148719566;34319;36043;36650.63349366526;36756.44865327022;36917.63082369196;37011.62988370136;37149.814250928575;13712.451501939811;13923.860761392256;13947.58157255284;13949.930250348683;13966;11349.773004539862;11360.318380897173;11371.886281137247;11392.772144557228;11420.086393088533;8384.119667434832;8437.789055273668;8448.493090414595;8457.196566326189;8543.188397102265;3320.701136897691;3347;3353.161709572607;3353.4299169141304;3359.143418428334;1031.6956497833157;1103.227740581596;1117.804384232756;1146.1003112556602;1154.9480273387717;31370.84314578458;31466.685333146834;31780;32035;32899.67100329014;1123.224974767408;1153.405995912106;1218.9024878009739;1230.4094034863315;1254.5483625894672;15612.687746245012;15653.373865045498;15816;16011.199440027953;16192.02847829134;485683;490286;490576;493387;494823;52874.73562632239;54354.72822635862;54354.72822635862;54416.72791636096;54759.178612320844;1438.3311760031636;1447.2401988955883;1454.7090581883665;1457.606446259504;1462.56854228003;29157.854210728812;29610.851945740134;30067.398652027274;30342.393152136392;30397;45455;46167;46547.53452465432;46554.767226163654;46750.298745519525;411013;412459;412986;414248;415906;27192.456150876475;27730.722692773623;27853.16440506788;27861.44277114406;28025;45358;45705.54294457146;46151.76924115358;46685.533144668116;46701.76649116733;39346.40980385354;39638.40542391924;39653;39668.40497392484;40275.1944961105;39163.804180978914;39944.20111597694;40038.39942400808;40339.79830100948;40401.191976159724;38058;40094.1981160381;40427.797861010506;41263.587364125975;41737.79131104325;34855.82572087123;35611.10972225715;35636.46545301875;35701;36595.81702091473;28005;28305;28371.574426384035;28460.43079138447;28501.287467813472 20:39:21 INFO - PROCESS | 23485 | |2;jquery.html;379.6222758355435;380.9657130858223;383.95968423315543;392.2977869613392;398.354665441984;15080;17495.912520437396;18574.907125464386;20223.089960951755;20312.492187695298;18119.275228990857;18629;19047.142878570463;19166;19229.61540769184;5083.618728595352;5547.389787123413;5809.7676092956235;5811.360750317483;5823.650580965134;5745.253117094772;5787.971060144714;5804.970975145118;5809.2738407699035;5845.590808643376;5245.68525888446;5581.804636837712;5584.4136365681425;5652.293463317085;5670.262865827457;5390;5565.888682226353;5771.50942169916;5780.335261444946;5782.785615020851;5584.050711379075;5599.972000140014;5602.355729091166;5602.607817452739;5617.550595952314;12073.818892716616;13662.590122296348;13689.452421903112;13710.24593647349;13720;2184.923527676524;2244.429800874979;2251.8177956572767;2252.977470225293;2437.146998550511;10084.69745907624;10276.845847312296;10284.280100392976;10494.108000819862;10548.997845204693;1941.6407964526609;1948.5713143108494;1999.8200161985492;2015.475976246172;2041.612093702192;74096.62951685207;75096;76614;76986.61506692486;77487.22512774856;10742.838857417146;10845.349279043283;10868.239223254455;10890.891091088988;11549.0293678447;12068.517259309705;12741.490340386466;12806.487740490276;14937.626559336104;14981.925090374478;6926.480513961473;7171.211166771651;7232.819179520554;7251.456140789356;7304.160021597584;6876.17485901685;6937.583744975318;6953.965230173918;7021.684024218923;7033.859322813618;4026.3960405939342;4087.509498860156;4108.856190033394;4138.544760076389;4142.316517774594;1967.1934506852122;1968.2028778344793;1983.5041239690077;2010.2260629657687;2029.0217038387455;970.7961328121173;1053.0943388685723;1074.5594306334365;1102.5699977008974;1112.7162573543694;18405.263789448272;18637.534061648566;18652.720209196872;18678.906605466887;19155.712664310046;1040.3237895368072;1047.3768107975743;1071.8017166824163;1072.8015317166348;1101.3997371432429;10271.897281027244;10630.20273479492;10651;10706.78586428267;10775.892241077645;480452;485581;491538;500173;505082;91316;91660;92137;93558.53220733989;93791.53104234434;1020.2450186861669;1034.5189486888632;1037.222083437422;1040.15747244732;1059.7456610413599;16202.625106635678;16457.753133702765;16723.247453864362;16725.163741813103;16936.915315423837;28440.857795711716;35746.8212658935;36370;38563.421548677354;40586.39120413255;50394.244086339466;50957.490425095275;51148.23277650764;51465;52068;7270.491065625567;7680.116786569616;7696.923030769621;7987.9600601998945;8029.197080291924;9620.71137865865;12126.878731212575;12688.365581721062;13157.473701051851;13341.733165336445;11938.58214962472;12062.45718942632;12080.335581542748;12243.265404075784;12524.123311368117;9123.361364704673;11458.255213411101;11616.593419230287;11772.882271177521;11883.287002779862;11625.128115391548;11843.940780296043;11910.285382877055;12114.575989840314;12239.75520489603;7288.453365997678;7727.768166955;7843.647035883285;8035.075966263955;8614.310855131449;11146.554137834395;11461.4269286537;11526.711832204262;11581.536738530365;11652.592159274385 20:39:21 INFO - PROCESS | 23485 | |3;mootools.html;1534.186880953095;1556.1830039229403;1742.7560141580182;1849.2972670385252;1857.4241984984656;7741.993540839697;8254.504729716205;8476.618552165151;9160.908390916089;9162.816743665131;7513.361364284029;8263.132371101037;8385.874211886827;8466.153384661531;8544.572771361423;2218.157100301883;2277.908883644652;2278.1912421090524;2302.643090321003;2309.31875096846;2240.327901629513;2254.447660323215;2283.4063143582707;2287.5081857400655;2290.3014580552926;2232.520008198237;2248.4154119928853;2252.8986195621155;2296.1045192374986;2308.4690521180137;2230.085664877409;2231.665250212465;2236.7427745809196;2238.3173132194675;2242.7869352411494;2165.4478108082494;2169.39257008038;2170.7829217078324;2173.0981642618294;2184.748753893291;8665.783355416164;8685.652573897036;8711;8711.477311361275;8723.25852302555;5160.380754309507;5303.761330740087;5326.467353264681;5329.866753331159;5344.545713614348;3320.1367644412626;3326.7338612910908;3470.9826450867586;3484.5470088888537;3495.440729483296;1101.2346419238631;1106.7454485468306;1145.3585991844593;1149.4827327702567;1151.936643484608;11811.704707382298;11936.28382297065;11984.50193725793;12116.575919842764;12207.328596927166;4681.321208424827;4693.24908014716;4768.284757286435;4818.253170758538;4834.685745426536;9643;9725.465099419458;9779;9797.363171393836;9799.608015679436;5275.419703832576;5277.604179686539;5293.523582877482;5305.575553955674;5307.363116426053;4326.783660816946;4740.502247264057;4880.072786170616;4917.606591472673;4933.333999910038;3769.3968964965475;3831.731778775459;3855.4024126260474;3897.337452633059;3992.500937382827;1121.091915548392;1124.6288724720823;1125.7241975716001;1128.6614015795392;1129.7006293332274;1023.4371095897376;1030.1295405382439;1034.2656713733334;1035.2028937718067;1047.6176195688672;5795.029689905452;5856.824295271149;5948.226730525004;6160.322364539897;6287.056941458818;466.84594083952214;476.0954187044643;477.29598841708895;481.52569718826925;485.9319695242669;4026.516817981861;4084.6323830855367;4111.62260642688;4130.421740956269;4194.182134483807;10679.252452328417;11065.72335691598;11074.501647425885;11244.212905096565;11246.156538259664;10970;11083.889161108447;11131.276467029616;11141.665750027512;11147.21969462146;7703.537787732754;8172;8219.712310069239;8340.582970851434;8422;5856.209411729362;6180.320164781961;6290.2766181889665;6303.054541818764;6323.336049714714;9768.120869121813;9926.602935882773;10043.899561004297;10143.64497242593;10254.23093267993;10153.949230253802;10182.541785619813;10196.694099177037;10200.897991019994;10436.16510679159;7011.509194356346;7531.585762783099;7595;7715.382769378324;7775.766726998199;8622.137786221328;8646;8706.825863482822;8726.214640682369;8731.91268087311;7573.2048134947245;7693.769186924401;7731.110922244014;7760.14638389788;7913.485623434458;7684.5773482459;7754.457187997012;7756.612169391395;7831.099423566363;7872.921270787218;7197.100362454693;7245.203027666847;7255.782326530212;7268.67290971897;7282.089738782653;5230.241614965885;5295.179247216687;5409.053415652324;5466.5900057495055;5473.124300111963;5376.623636345575;5474.8905021898545;5480.424555421623;5512.476314750093;5540.63985840919 20:39:21 INFO - PROCESS | 23485 | |4;prototype.html;315.5141082732592;321.2418691887146;324.06345661039586;324.42900495128595;326.4466728894524;5244.816431424901;5339.6262261641705;5433.48381903719;5442.9386269677425;5535.91696124558;5413.26920865683;5426.778974730683;5457.126859702438;5462.836114916549;5480.205370221325;4171.249175148472;4212.1575684863;4230.957690423103;4235.53409124996;4250.8087136078875;4141.535786207201;4228;4228.386883901832;4237.97881010596;4283.550227226143;4165.500139983206;4207.915841683164;4208.852690155845;4227.6617870570435;4240.936385954213;4128.566500517462;4139.586041395836;4185.869815149923;4196.685248606352;4214.852480163195;3701.7229055975913;3711.9072023199365;3739.607341229159;3745.662890339855;3775.452559378902;4950.331705219785;5268.868278293035;5285.68285902847;5333.386660534049;5355.250264962909;4760.357351757538;4798.832040878552;4806.101589871981;4813.95186048142;4818.855434336975;5321.414644389114;5676.772929082832;5684.181062060143;5749.885002299972;5762.769489220426;4043.97978010111;4057.69567282455;4065.5527891931865;4066.1664358806374;4068.9624145842918;5860.648361098348;5907.075997381281;5925.34821169671;5940.277319577317;5990.9101363479585;4012.4783778109245;4109.527404348479;4132.194222126716;4133.132042271097;4137.275976704125;4135.048938744106;4136.937945930814;4139.81370838313;4160.022394737234;4179.373094035919;4681.016986432819;4759.214729569582;4769.189237829508;4801.063792560487;4803.543663351976;5129.845784698413;5669.688167150846;5732.656040637492;5801.8549536261935;5814.534837213013;1423.978640320396;1440.1359184489431;1440.652989454863;1441.322578388156;1445.645816774897;886.2156991062827;903.6746771162376;904.3985749476525;928.5264515097349;940.3370623710268;4803.847076701636;4839.685420447659;4851.563359297609;4865.781039853215;4883.902321953541;4969;4993.925091123636;5091.287219789232;5100.928804950928;5141.845744627667;4758.595519380822;4761.6904901181315;4787.1569445763635;4833.32333473314;5016.473270306638;3109.113902537811;3141.277506173547;3147.244661281276;3159.510275907238;3196.7122958933805;6058.0004299291;6069.787557435468;6081.118237855486;6105.206323177958;6136.631802091889;5636.464535869086;6030.427109424598;6031.909521357183;6037.396260373927;6161.949834831787;6011.158437818709;6120.561668008015;6144.446999770132;6203.131561581382;6238.068107989237;5586.385497595343;5889.234399528034;5916.5034573723415;5931.673757943182;6014.218151640259;5843.678597677169;5866.354700982974;5886.970565147147;5924.318703348998;5927.436893495111;6086.878262434815;6175.764847030522;6186.412290832363;6199.0326191236745;6207;3915.804209789556;4128.710990230655;4131.772752498641;4142.130152667853;4147.834086636622;5698.886022279614;5856.330945680461;5866.6186697864505;5901.468867801918;5929.436703513159;5754.9424505754405;5756.251687280626;5824.708764561839;5844.778983986058;5866.67733274674;5707.571932105026;5773.134029895549;5838.678872662044;5840.591158619026;5849.736761845812;5591.552675786009;5613.242212301287;5683.545316374597;5691.743871525874;5747.367789543064;5707.315122185364;5766.971165144148;5809.302883653989;5851.180834683233;5852.824415267549;5474.726263686879;5609.270794796814;5647.265855438766;5676.631018983753;5695.658260504218 20:39:21 INFO - PROCESS | 23485 | |5;yui.html;830.6967956695805;842.9831403371933;843.0641987393991;852.693030509017;862.7541150772028;14525.854741452582;14753.852461475382;14809;14939.850601493981;14944.178070206135;13832.308384580781;13882.236476993787;13891.958103142255;13912.165270083802;13938.930305348458;646.266487536647;785.4776573578592;795.9164287749775;812.2405550810012;813.4184058398245;795.932345750612;798.756379304312;802.1256830055239;802.1497212954287;805.3154818404367;865.3639574912465;866.3805379153904;868.6178081644088;869.2263885142229;872.2716531696042;862.6678728689468;863.6890719341033;864.6584599083359;865.3769286113987;869.7869022089628;628.064184365297;630.3475902440952;631.1353445779312;631.182618509032;632.8386261503333;13736.93131534346;13747;13800.723985520233;13832.723345533133;13886.652833679138;13746.587602371845;13871;13898.791518127236;13909.234992075431;13944.372503237379;11219;11267.549596415174;11376.146788990858;11493.482793274323;11702.70743231426;3825.3496905526126;3826.2921359548573;3920.921581568353;3995.62041606047;3999.3601023836045;51238.48761512375;51834;51839;51877.221841672406;52100.47899520994;10758.246922715334;10776.946115269373;10990.890091098987;11220.607278745205;11385.65843024694;19582.118804653826;19627.719219556067;19773.802261977486;19794.70307945382;19885;7733.651985660546;7742.806429839299;7746.806329841686;7752.728654497066;7903.091144518339;4471.30694742309;4706.458757242961;4708.387909571734;4714.269288260325;4880.170371036932;3201.583794106751;3292.111129994888;3305.93388132236;3311.9006429807146;3316.950245746316;653.6600967496875;660.4980215036607;689.5724650716588;697.5082566790401;698.441247002396;682.0519477925588;749.6401727170988;751.9511231769917;754.2871985973203;770.7880332908383;9000.59497322622;9403.811923761623;9477.952610237042;9536.28477864163;9603.519824008772;703.2088899987514;725.2529894208973;765.0589774577301;798.1778767869104;817.1501638296105;4502.752348620857;4656.278276867091;4734.337192793012;4805.255185446262;4807.855764327076;58720.41279587235;59076.40923590795;60280;61052.38947610467;61080.69459652673;54885.451145488834;55887.720561396934;56644;57184;57507.13739293914;47652.761736191096;48025;48092.519074809505;48182;48368.27447588289;8844.425112367675;8966.462012279284;8986.236169925629;9039.186473217442;9041.095890411169;33965.49051764275;34117.488237675956;34703.30593388068;35114;35385.29229415449;41704.58295417007;44798.3280250803;46390.76804615955;46957.2956405661;47070;11244.325340479598;11282.435878205893;11402.15411420002;11502.769944601228;11683;12621.305828179538;12650.177738446971;12790.104692671424;12871.871281287442;13033.15284506504;11830.645080647595;12075.939620301842;12116;12118.151729378858;12604.243745375306;11871;12008.339541324962;12009.279443233434;12087;12127.393630318626;11791.88208117908;11812;11848;11865.11011674145;12361.134720569475;10029;10089.344192627455;10167.847482287623;10253.33353332031;10452.372857628567;10405.9479702601;10460.320079195133;10504.632337868137;10542.26204165701;10628.681139565826 20:39:21 INFO - PROCESS | 23485 | __end_tp_report 20:39:21 INFO - PROCESS | 23485 | __start_cc_report 20:39:21 INFO - PROCESS | 23485 | _x_x_mozilla_cycle_collect,296 20:39:21 INFO - PROCESS | 23485 | __end_cc_report 20:39:21 INFO - PROCESS | 23485 | __startTimestamp1462937961476__endTimestamp 20:39:21 INFO - PROCESS | 23485 | 20:39:21 INFO - PROCESS | 23485 | ------- Summary: start ------- 20:39:21 INFO - PROCESS | 23485 | Number of tests: 6 20:39:21 INFO - PROCESS | 23485 | 20:39:21 INFO - PROCESS | 23485 | [#0] dojo.html Cycles:165 Average:5420.86 Median:5656.24 stddev:736.83 (13.0%) stddev-sans-first:717.34 20:39:21 INFO - PROCESS | 23485 | Values: 3155.6 3167.0 3192.4 3221.3 3234.8 5432.9 5442.5 5471.3 5498.0 5539.9 5390.2 5480.9 5487.1 5498.0 5591.9 4855.3 4924.1 5050.3 5088.0 5122.8 713.4 4855.8 4906.4 4961.6 4973.6 4940.5 4996.0 4998.3 5007.8 5024.0 5003.7 5004.9 5031.3 5035.9 5076.4 4946.4 4958.8 4959.0 4988.7 4998.6 5382.4 5412.2 5428.6 5455.5 5510.3 5550.7 5799.6 5825.6 5829.0 5852.6 5895.4 5896.9 5964.0 5996.6 5999.5 5512.4 5534.4 5543.3 5546.5 5551.7 5850.9 5961.3 5965.9 5986.3 6016.8 5712.4 5746.4 5748.7 5815.7 5837.0 5904.8 5912.8 5918.4 5919.7 5942.9 5814.4 5836.8 5862.7 5899.3 5901.6 5861.9 5878.8 5881.4 5892.3 5898.7 4318.0 4359.8 4366.5 4387.0 4411.4 3798.4 3904.7 3956.7 3969.2 3982.9 5485.1 5546.2 5617.5 5635.4 5656.8 5716.2 5920.6 5957.9 5968.3 5971.5 5508.5 5564.0 5565.4 5566.5 5570.9 4818.5 4865.1 4881.4 4883.0 4929.0 5880.7 6015.5 6080.1 6088.6 6093.3 5760.2 5783.9 5847.3 5939.1 5968.7 6057.8 6113.1 6124.0 6131.8 6137.0 5597.9 5792.0 5799.3 5847.1 5857.4 5964.6 6013.7 6016.4 6022.4 6053.9 5811.6 5835.4 5835.9 5836.2 5866.1 5553.5 5723.3 5737.2 5739.1 5774.5 5621.4 5656.2 5660.5 5671.6 5713.1 5680.4 5783.9 5800.8 5809.4 5823.9 5466.5 5506.4 5539.8 5605.7 5641.7 20:39:21 INFO - PROCESS | 23485 | 20:39:21 INFO - PROCESS | 23485 | [#1] ext.html Cycles:180 Average:53457.73 Median:3842.55 stddev:106418.58 (2769.5%) stddev-sans-first:106643.05 20:39:21 INFO - PROCESS | 23485 | Values: 577.2 596.2 609.8 614.5 640.8 37894.8 38588.0 42049.2 42051.6 42313.2 43919.6 44106.3 44197.8 44328.8 44575.8 8773.4 8901.3 8920.7 8958.7 8977.5 8686.7 8775.0 8846.6 8847.5 8896.7 8913.7 8942.2 8947.2 8968.3 8975.6 8862.8 8867.7 8894.8 8904.5 8907.5 8760.2 8764.3 8776.9 8824.1 8853.0 33979.7 41409.8 41535.6 41567.2 41954.6 3372.0 3518.8 3537.2 3609.0 3655.8 29657.1 30049.8 30501.4 30559.4 31158.4 3804.5 3813.8 3829.7 3855.4 3869.9 262415.0 263726.0 264324.0 265404.0 265877.0 33967.0 34091.7 34121.6 34319.0 36043.0 36650.6 36756.4 36917.6 37011.6 37149.8 13712.5 13923.9 13947.6 13949.9 13966.0 11349.8 11360.3 11371.9 11392.8 11420.1 8384.1 8437.8 8448.5 8457.2 8543.2 3320.7 3347.0 3353.2 3353.4 3359.1 1031.7 1103.2 1117.8 1146.1 1154.9 31370.8 31466.7 31780.0 32035.0 32899.7 1123.2 1153.4 1218.9 1230.4 1254.5 15612.7 15653.4 15816.0 16011.2 16192.0 485683.0 490286.0 490576.0 493387.0 494823.0 52874.7 54354.7 54354.7 54416.7 54759.2 1438.3 1447.2 1454.7 1457.6 1462.6 29157.9 29610.9 30067.4 30342.4 30397.0 45455.0 46167.0 46547.5 46554.8 46750.3 411013.0 412459.0 412986.0 414248.0 415906.0 27192.5 27730.7 27853.2 27861.4 28025.0 45358.0 45705.5 46151.8 46685.5 46701.8 39346.4 39638.4 39653.0 39668.4 40275.2 39163.8 39944.2 40038.4 40339.8 40401.2 38058.0 40094.2 40427.8 41263.6 41737.8 34855.8 35611.1 35636.5 35701.0 36595.8 28005.0 28305.0 28371.6 28460.4 28501.3 20:39:21 INFO - PROCESS | 23485 | 20:39:21 INFO - PROCESS | 23485 | [#2] jquery.html Cycles:180 Average:28066.98 Median:11177.05 stddev:81150.10 (726.0%) stddev-sans-first:81351.11 20:39:21 INFO - PROCESS | 23485 | Values: 379.6 381.0 384.0 392.3 398.4 15080.0 17495.9 18574.9 20223.1 20312.5 18119.3 18629.0 19047.1 19166.0 19229.6 5083.6 5547.4 5809.8 5811.4 5823.7 5745.3 5788.0 5805.0 5809.3 5845.6 5245.7 5581.8 5584.4 5652.3 5670.3 5390.0 5565.9 5771.5 5780.3 5782.8 5584.1 5600.0 5602.4 5602.6 5617.6 12073.8 13662.6 13689.5 13710.2 13720.0 2184.9 2244.4 2251.8 2253.0 2437.1 10084.7 10276.8 10284.3 10494.1 10549.0 1941.6 1948.6 1999.8 2015.5 2041.6 74096.6 75096.0 76614.0 76986.6 77487.2 10742.8 10845.3 10868.2 10890.9 11549.0 12068.5 12741.5 12806.5 14937.6 14981.9 6926.5 7171.2 7232.8 7251.5 7304.2 6876.2 6937.6 6954.0 7021.7 7033.9 4026.4 4087.5 4108.9 4138.5 4142.3 1967.2 1968.2 1983.5 2010.2 2029.0 970.8 1053.1 1074.6 1102.6 1112.7 18405.3 18637.5 18652.7 18678.9 19155.7 1040.3 1047.4 1071.8 1072.8 1101.4 10271.9 10630.2 10651.0 10706.8 10775.9 480452.0 485581.0 491538.0 500173.0 505082.0 91316.0 91660.0 92137.0 93558.5 93791.5 1020.2 1034.5 1037.2 1040.2 1059.7 16202.6 16457.8 16723.2 16725.2 16936.9 28440.9 35746.8 36370.0 38563.4 40586.4 50394.2 50957.5 51148.2 51465.0 52068.0 7270.5 7680.1 7696.9 7988.0 8029.2 9620.7 12126.9 12688.4 13157.5 13341.7 11938.6 12062.5 12080.3 12243.3 12524.1 9123.4 11458.3 11616.6 11772.9 11883.3 11625.1 11843.9 11910.3 12114.6 12239.8 7288.5 7727.8 7843.6 8035.1 8614.3 11146.6 11461.4 11526.7 11581.5 11652.6 20:39:21 INFO - PROCESS | 23485 | 20:39:21 INFO - PROCESS | 23485 | [#3] mootools.html Cycles:180 Average:5779.86 Median:479.41 stddev:3287.80 (685.8%) stddev-sans-first:3281.54 20:39:21 INFO - PROCESS | 23485 | Values: 1534.2 1556.2 1742.8 1849.3 1857.4 7742.0 8254.5 8476.6 9160.9 9162.8 7513.4 8263.1 8385.9 8466.2 8544.6 2218.2 2277.9 2278.2 2302.6 2309.3 2240.3 2254.4 2283.4 2287.5 2290.3 2232.5 2248.4 2252.9 2296.1 2308.5 2230.1 2231.7 2236.7 2238.3 2242.8 2165.4 2169.4 2170.8 2173.1 2184.7 8665.8 8685.7 8711.0 8711.5 8723.3 5160.4 5303.8 5326.5 5329.9 5344.5 3320.1 3326.7 3471.0 3484.5 3495.4 1101.2 1106.7 1145.4 1149.5 1151.9 11811.7 11936.3 11984.5 12116.6 12207.3 4681.3 4693.2 4768.3 4818.3 4834.7 9643.0 9725.5 9779.0 9797.4 9799.6 5275.4 5277.6 5293.5 5305.6 5307.4 4326.8 4740.5 4880.1 4917.6 4933.3 3769.4 3831.7 3855.4 3897.3 3992.5 1121.1 1124.6 1125.7 1128.7 1129.7 1023.4 1030.1 1034.3 1035.2 1047.6 5795.0 5856.8 5948.2 6160.3 6287.1 466.8 476.1 477.3 481.5 485.9 4026.5 4084.6 4111.6 4130.4 4194.2 10679.3 11065.7 11074.5 11244.2 11246.2 10970.0 11083.9 11131.3 11141.7 11147.2 7703.5 8172.0 8219.7 8340.6 8422.0 5856.2 6180.3 6290.3 6303.1 6323.3 9768.1 9926.6 10043.9 10143.6 10254.2 10153.9 10182.5 10196.7 10200.9 10436.2 7011.5 7531.6 7595.0 7715.4 7775.8 8622.1 8646.0 8706.8 8726.2 8731.9 7573.2 7693.8 7731.1 7760.1 7913.5 7684.6 7754.5 7756.6 7831.1 7872.9 7197.1 7245.2 7255.8 7268.7 7282.1 5230.2 5295.2 5409.1 5466.6 5473.1 5376.6 5474.9 5480.4 5512.5 5540.6 20:39:21 INFO - PROCESS | 23485 | 20:39:21 INFO - PROCESS | 23485 | [#4] prototype.html Cycles:180 Average:4751.79 Median:5327.40 stddev:1419.67 (26.6%) stddev-sans-first:1384.05 20:39:21 INFO - PROCESS | 23485 | Values: 315.5 321.2 324.1 324.4 326.4 5244.8 5339.6 5433.5 5442.9 5535.9 5413.3 5426.8 5457.1 5462.8 5480.2 4171.2 4212.2 4231.0 4235.5 4250.8 4141.5 4228.0 4228.4 4238.0 4283.6 4165.5 4207.9 4208.9 4227.7 4240.9 4128.6 4139.6 4185.9 4196.7 4214.9 3701.7 3711.9 3739.6 3745.7 3775.5 4950.3 5268.9 5285.7 5333.4 5355.3 4760.4 4798.8 4806.1 4814.0 4818.9 5321.4 5676.8 5684.2 5749.9 5762.8 4044.0 4057.7 4065.6 4066.2 4069.0 5860.6 5907.1 5925.3 5940.3 5990.9 4012.5 4109.5 4132.2 4133.1 4137.3 4135.0 4136.9 4139.8 4160.0 4179.4 4681.0 4759.2 4769.2 4801.1 4803.5 5129.8 5669.7 5732.7 5801.9 5814.5 1424.0 1440.1 1440.7 1441.3 1445.6 886.2 903.7 904.4 928.5 940.3 4803.8 4839.7 4851.6 4865.8 4883.9 4969.0 4993.9 5091.3 5100.9 5141.8 4758.6 4761.7 4787.2 4833.3 5016.5 3109.1 3141.3 3147.2 3159.5 3196.7 6058.0 6069.8 6081.1 6105.2 6136.6 5636.5 6030.4 6031.9 6037.4 6161.9 6011.2 6120.6 6144.4 6203.1 6238.1 5586.4 5889.2 5916.5 5931.7 6014.2 5843.7 5866.4 5887.0 5924.3 5927.4 6086.9 6175.8 6186.4 6199.0 6207.0 3915.8 4128.7 4131.8 4142.1 4147.8 5698.9 5856.3 5866.6 5901.5 5929.4 5754.9 5756.3 5824.7 5844.8 5866.7 5707.6 5773.1 5838.7 5840.6 5849.7 5591.6 5613.2 5683.5 5691.7 5747.4 5707.3 5767.0 5809.3 5851.2 5852.8 5474.7 5609.3 5647.3 5676.6 5695.7 20:39:21 INFO - PROCESS | 23485 | 20:39:21 INFO - PROCESS | 23485 | [#5] yui.html Cycles:180 Average:14600.69 Median:25806.79 stddev:16760.70 (64.9%) stddev-sans-first:16775.82 20:39:21 INFO - PROCESS | 23485 | Values: 830.7 843.0 843.1 852.7 862.8 14525.9 14753.9 14809.0 14939.9 14944.2 13832.3 13882.2 13892.0 13912.2 13938.9 646.3 785.5 795.9 812.2 813.4 795.9 798.8 802.1 802.1 805.3 865.4 866.4 868.6 869.2 872.3 862.7 863.7 864.7 865.4 869.8 628.1 630.3 631.1 631.2 632.8 13736.9 13747.0 13800.7 13832.7 13886.7 13746.6 13871.0 13898.8 13909.2 13944.4 11219.0 11267.5 11376.1 11493.5 11702.7 3825.3 3826.3 3920.9 3995.6 3999.4 51238.5 51834.0 51839.0 51877.2 52100.5 10758.2 10776.9 10990.9 11220.6 11385.7 19582.1 19627.7 19773.8 19794.7 19885.0 7733.7 7742.8 7746.8 7752.7 7903.1 4471.3 4706.5 4708.4 4714.3 4880.2 3201.6 3292.1 3305.9 3311.9 3317.0 653.7 660.5 689.6 697.5 698.4 682.1 749.6 752.0 754.3 770.8 9000.6 9403.8 9478.0 9536.3 9603.5 703.2 725.3 765.1 798.2 817.2 4502.8 4656.3 4734.3 4805.3 4807.9 58720.4 59076.4 60280.0 61052.4 61080.7 54885.5 55887.7 56644.0 57184.0 57507.1 47652.8 48025.0 48092.5 48182.0 48368.3 8844.4 8966.5 8986.2 9039.2 9041.1 33965.5 34117.5 34703.3 35114.0 35385.3 41704.6 44798.3 46390.8 46957.3 47070.0 11244.3 11282.4 11402.2 11502.8 11683.0 12621.3 12650.2 12790.1 12871.9 13033.2 11830.6 12075.9 12116.0 12118.2 12604.2 11871.0 12008.3 12009.3 12087.0 12127.4 11791.9 11812.0 11848.0 11865.1 12361.1 10029.0 10089.3 10167.8 10253.3 10452.4 10405.9 10460.3 10504.6 10542.3 10628.7 20:39:21 INFO - PROCESS | 23485 | -------- Summary: end -------- 20:39:21 INFO - PROCESS | 23485 | 20:39:21 INFO - TEST-INFO | 23485: exit 0 20:39:21 INFO - TEST-OK | dromaeo_css | took 1109010ms 20:39:21 INFO - TEST-START | kraken 20:39:21 INFO - operating with platform_type : linux_ 20:39:21 INFO - Initialising browser for kraken test... 20:39:21 INFO - TEST-INFO | started process 23719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDZzda/profile http://localhost:53361/getInfo.html) 20:39:25 INFO - PROCESS | 23719 | 20:39:25 INFO - PROCESS | 23719 | (process:23784): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:39:26 INFO - PROCESS | 23719 | __metrics Screen width/height:1600/1200 20:39:26 INFO - PROCESS | 23719 | colorDepth:24 20:39:26 INFO - PROCESS | 23719 | Browser inner width/height: 1024/697 20:39:26 INFO - PROCESS | 23719 | __metrics 20:39:27 ERROR - PROCESS | 23719 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:39:27 INFO - TEST-INFO | 23719: exit 0 20:39:27 INFO - Browser initialized. 20:39:27 INFO - Running cycle 1/1 for kraken test... 20:39:27 INFO - TEST-INFO | started process 23835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDZzda/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:39:29 INFO - PROCESS | 23835 | 20:39:29 INFO - PROCESS | 23835 | (process:23898): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:39:39 INFO - PROCESS | 23835 | RSS: Main: 162623488 20:39:39 INFO - PROCESS | 23835 | 20:39:41 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53361/tests/kraken/driver.html?testName=audio-beat-detection) 20:39:42 INFO - PROCESS | 23835 | RSS: Main: 167055360 20:39:42 INFO - PROCESS | 23835 | 20:39:45 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53361/tests/kraken/driver.html?testName=audio-dft) 20:39:45 INFO - PROCESS | 23835 | RSS: Main: 167104512 20:39:45 INFO - PROCESS | 23835 | 20:39:48 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53361/tests/kraken/driver.html?testName=audio-fft) 20:39:49 INFO - PROCESS | 23835 | RSS: Main: 162156544 20:39:49 INFO - PROCESS | 23835 | 20:39:51 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53361/tests/kraken/driver.html?testName=audio-oscillator) 20:39:52 INFO - PROCESS | 23835 | RSS: Main: 162107392 20:39:52 INFO - PROCESS | 23835 | 20:39:54 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:39:54 INFO - PROCESS | 23835 | RSS: Main: 162914304 20:39:54 INFO - PROCESS | 23835 | 20:39:58 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53361/tests/kraken/driver.html?testName=imaging-darkroom) 20:39:58 INFO - PROCESS | 23835 | RSS: Main: 162779136 20:39:58 INFO - PROCESS | 23835 | 20:40:02 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53361/tests/kraken/driver.html?testName=imaging-desaturate) 20:40:02 INFO - PROCESS | 23835 | RSS: Main: 161640448 20:40:02 INFO - PROCESS | 23835 | 20:40:05 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53361/tests/kraken/driver.html?testName=json-parse-financial) 20:40:06 INFO - PROCESS | 23835 | RSS: Main: 162746368 20:40:06 INFO - PROCESS | 23835 | 20:40:07 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:40:08 INFO - PROCESS | 23835 | RSS: Main: 162856960 20:40:08 INFO - PROCESS | 23835 | 20:40:10 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53361/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:40:10 INFO - PROCESS | 23835 | RSS: Main: 162947072 20:40:10 INFO - PROCESS | 23835 | 20:40:13 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:40:13 INFO - PROCESS | 23835 | RSS: Main: 163016704 20:40:13 INFO - PROCESS | 23835 | 20:40:16 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:40:16 INFO - PROCESS | 23835 | RSS: Main: 163696640 20:40:16 INFO - PROCESS | 23835 | 20:40:19 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:40:20 INFO - PROCESS | 23835 | RSS: Main: 163090432 20:40:20 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | Cycle 1(1): loaded http://localhost:53361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53361/tests/kraken/driver.html?testName=ai-astar) 20:40:22 INFO - PROCESS | 23835 | RSS: Main: 164765696 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | __start_tp_report 20:40:22 INFO - PROCESS | 23835 | _x_x_mozilla_page_load 20:40:22 INFO - PROCESS | 23835 | _x_x_mozilla_page_load_details 20:40:22 INFO - PROCESS | 23835 | |i|pagename|runs| 20:40:22 INFO - PROCESS | 23835 | |0;ai-astar;110;116;107;114;113;114;109;114;115;112 20:40:22 INFO - PROCESS | 23835 | |1;audio-beat-detection;155;132;155;209;132;158;155;133;178;132 20:40:22 INFO - PROCESS | 23835 | |2;audio-dft;167;163;164;163;165;164;168;182;164;166 20:40:22 INFO - PROCESS | 23835 | |3;audio-fft;78;79;77;163;76;79;76;76;167;77 20:40:22 INFO - PROCESS | 23835 | |4;audio-oscillator;93;93;172;93;93;93;140;93;94;140 20:40:22 INFO - PROCESS | 23835 | |5;imaging-gaussian-blur;118;119;121;119;120;119;119;119;119;119 20:40:22 INFO - PROCESS | 23835 | |6;imaging-darkroom;148;149;148;150;149;149;149;151;148;149 20:40:22 INFO - PROCESS | 23835 | |7;imaging-desaturate;98;97;96;96;96;96;97;96;96;96 20:40:22 INFO - PROCESS | 23835 | |8;json-parse-financial;58;59;58;58;58;59;62;59;60;58 20:40:22 INFO - PROCESS | 23835 | |9;json-stringify-tinderbox;60;60;60;60;60;61;60;60;61;60 20:40:22 INFO - PROCESS | 23835 | |10;stanford-crypto-aes;82;81;82;83;83;85;83;87;136;83 20:40:22 INFO - PROCESS | 23835 | |11;stanford-crypto-ccm;139;132;133;131;142;129;139;140;150;136 20:40:22 INFO - PROCESS | 23835 | |12;stanford-crypto-pbkdf2;170;179;170;174;175;176;172;170;178;171 20:40:22 INFO - PROCESS | 23835 | |13;stanford-crypto-sha256-iterative;69;68;67;67;67;65;67;67;67;67 20:40:22 INFO - PROCESS | 23835 | __end_tp_report 20:40:22 INFO - PROCESS | 23835 | __start_cc_report 20:40:22 INFO - PROCESS | 23835 | _x_x_mozilla_cycle_collect,738 20:40:22 INFO - PROCESS | 23835 | __end_cc_report 20:40:22 INFO - PROCESS | 23835 | __startTimestamp1462938022331__endTimestamp 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | ------- Summary: start ------- 20:40:22 INFO - PROCESS | 23835 | Number of tests: 14 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:2.88 (2.5%) stddev-sans-first:2.92 20:40:22 INFO - PROCESS | 23835 | Values: 110.0 116.0 107.0 114.0 113.0 114.0 109.0 114.0 115.0 112.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:155.00 stddev:24.75 (16.0%) stddev-sans-first:26.25 20:40:22 INFO - PROCESS | 23835 | Values: 155.0 132.0 155.0 209.0 132.0 158.0 155.0 133.0 178.0 132.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#2] audio-dft Cycles:10 Average:166.60 Median:165.50 stddev:5.66 (3.4%) stddev-sans-first:6.00 20:40:22 INFO - PROCESS | 23835 | Values: 167.0 163.0 164.0 163.0 165.0 164.0 168.0 182.0 164.0 166.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:37.03 (48.1%) stddev-sans-first:38.77 20:40:22 INFO - PROCESS | 23835 | Values: 78.0 79.0 77.0 163.0 76.0 79.0 76.0 76.0 167.0 77.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:93.00 stddev:29.12 (31.3%) stddev-sans-first:30.20 20:40:22 INFO - PROCESS | 23835 | Values: 93.0 93.0 172.0 93.0 93.0 93.0 140.0 93.0 94.0 140.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#5] imaging-gaussian-blur Cycles:10 Average:119.20 Median:119.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 20:40:22 INFO - PROCESS | 23835 | Values: 118.0 119.0 121.0 119.0 120.0 119.0 119.0 119.0 119.0 119.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 20:40:22 INFO - PROCESS | 23835 | Values: 148.0 149.0 148.0 150.0 149.0 149.0 149.0 151.0 148.0 149.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.44 20:40:22 INFO - PROCESS | 23835 | Values: 98.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:1.29 (2.2%) stddev-sans-first:1.32 20:40:22 INFO - PROCESS | 23835 | Values: 58.0 59.0 58.0 58.0 58.0 59.0 62.0 59.0 60.0 58.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 20:40:22 INFO - PROCESS | 23835 | Values: 60.0 60.0 60.0 60.0 60.0 61.0 60.0 60.0 61.0 60.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:83.00 stddev:16.77 (20.2%) stddev-sans-first:17.63 20:40:22 INFO - PROCESS | 23835 | Values: 82.0 81.0 82.0 83.0 83.0 85.0 83.0 87.0 136.0 83.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:139.00 stddev:6.26 (4.5%) stddev-sans-first:6.60 20:40:22 INFO - PROCESS | 23835 | Values: 139.0 132.0 133.0 131.0 142.0 129.0 139.0 140.0 150.0 136.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.50 stddev:3.41 (2.0%) stddev-sans-first:3.37 20:40:22 INFO - PROCESS | 23835 | Values: 170.0 179.0 170.0 174.0 175.0 176.0 172.0 170.0 178.0 171.0 20:40:22 INFO - PROCESS | 23835 | 20:40:22 INFO - PROCESS | 23835 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.78 20:40:22 INFO - PROCESS | 23835 | Values: 69.0 68.0 67.0 67.0 67.0 65.0 67.0 67.0 67.0 67.0 20:40:22 INFO - PROCESS | 23835 | -------- Summary: end -------- 20:40:22 INFO - PROCESS | 23835 | 20:40:23 INFO - TEST-INFO | 23835: exit 0 20:40:23 INFO - TEST-OK | kraken | took 61121ms 20:40:23 INFO - SUITE-END | took 1170s 20:40:23 INFO - Completed test suite (00:19:30) 20:40:23 INFO - javascript benchmark 20:40:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.5739975103356, 3166.952495712564, 3192.3934452454046, 3221.259110404606, 3234.77356585039, 5432.891342173154, 5442.537384322332, 5471.343438787351, 5497.972510137443, 5539.9169012464745, 5390.21841832934, 5480.890382192354, 5487.067198576242, 5498.037843377413, 5591.916121258174, 4855.271709243606, 4924.113659541281, 5050.292958985727, 5087.9569688214015, 5122.795088196486, 713.3929699897484, 4855.805767769302, 4906.386701662293, 4961.627877909171, 4973.602111831045, 4940.481249468808, 4995.950040499603, 4998.300237966688, 5007.798128449164, 5023.974880125595, 5003.724795136266, 5004.924926126111, 5031.32077169581, 5035.949640503584, 5076.390833100052, 4946.431160416562, 4958.834673851642, 4958.9752051239875, 4988.65079444439, 4998.550130488237, 5382.381026181961, 5412.242286079952, 5428.565714742811, 5455.509004189642, 5510.256115424407, 5550.666959982414, 5799.594028418012, 5825.592208545403, 5829.0, 5852.590318677694, 5895.4399332063385, 5896.941030589725, 5964.0, 5996.580239383245, 5999.490043346321, 5512.366077901052, 5534.391216966131, 5543.307086614173, 5546.528545073633, 5551.694656793875, 5850.912236316459, 5961.28464584244, 5965.940340596539, 5986.281646202484, 6016.819495415145, 5712.371639119693, 5746.4253574643035, 5748.655080695172, 5815.709214539256, 5837.0, 5904.822855314347, 5912.822615321547, 5918.437748413894, 5919.67441790697, 5942.910856337158, 5814.360420353758, 5836.824895253149, 5862.677552734641, 5899.292084949748, 5901.58688891782, 5861.853453663607, 5878.794242201502, 5881.3530511643685, 5892.322382925932, 5898.734556944948, 4318.028443600228, 4359.782010899442, 4366.497852746911, 4387.0, 4411.382406463098, 3798.430235464647, 3904.6681032112588, 3956.742811717229, 3969.2458432898234, 3982.880513584597, 5485.122380419114, 5546.195801608744, 5617.494425501643, 5635.436456354414, 5656.8020119295625, 5716.171155182476, 5920.644761314335, 5957.940420595739, 5968.343482216953, 5971.5222782177325, 5508.476694713996, 5564.026295398289, 5565.41563135873, 5566.471185237396, 5570.86072848182, 4818.494058123846, 4865.051314993613, 4881.365422495053, 4883.0, 4928.989557140778, 5880.705964701748, 6015.488683461867, 6080.118382834465, 6088.573799833969, 6093.299270583851, 5760.164776107525, 5783.88432231353, 5847.327557330791, 5939.10913362999, 5968.671723055274, 6057.848553786191, 6113.052476866093, 6124.0, 6131.816045518642, 6137.048757442603, 5597.916031259453, 5792.0, 5799.2750906136735, 5847.093700476433, 5857.355690873916, 5964.612300200473, 6013.729382177725, 6016.368281330398, 6022.36765139654, 6053.9091913622215, 5811.593188476766, 5835.387284335084, 5835.94164058371, 5836.241288632451, 5866.061430171152, 5553.4724201200825, 5723.255976723, 5737.168110623853, 5739.139129130664, 5774.451427114417, 5621.409751976147, 5656.236408084856, 5660.518855897295, 5671.574631902707, 5713.085906254979, 5680.375158732453, 5783.913241301468, 5800.8259752207505, 5809.36097029318, 5823.854403639773, 5466.535344495763, 5506.366767821752, 5539.750711217925, 5605.719714014364, 5641.717914104196], "value": 5371.472536691531, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2236342119847, 596.1891827115124, 609.7835268479689, 614.5053232148119, 640.8397900524869, 37894.81052594737, 38588.0, 42049.159016819685, 42051.57948420523, 42313.15373692532, 43919.56080439195, 44106.338404923874, 44197.779011104976, 44328.778356108174, 44575.77712111443, 8773.42972706772, 8901.332400069989, 8920.687775927843, 8958.731238062868, 8977.506237156953, 8686.652533898636, 8774.956125219365, 8846.5576721164, 8847.513386763725, 8896.733098007071, 8913.68802091927, 8942.150495702897, 8947.239484643813, 8968.327375446836, 8975.596098175598, 8862.778430539223, 8867.73396798094, 8894.777630559256, 8904.51025193614, 8907.465552066897, 8760.211580957744, 8764.298856091498, 8776.868346974801, 8824.073472285381, 8852.955735221347, 33979.6602033979, 41409.79295103535, 41535.584644153474, 41567.168656627, 41954.58045419537, 3371.998786836196, 3518.7712798668003, 3537.2394935088823, 3608.9819550902075, 3655.780653160819, 29657.110286691433, 30049.849750751324, 30501.389972200654, 30559.388812223853, 31158.37683246345, 3804.486394336757, 3813.809309534512, 3829.6553310202216, 3855.4409610606585, 3869.941950870739, 262415.0, 263726.0, 264323.9999999981, 265404.0, 265877.0, 33967.0, 34091.65908340885, 34121.61148719566, 34319.0, 36043.0, 36650.63349366526, 36756.44865327022, 36917.63082369196, 37011.62988370136, 37149.814250928575, 13712.451501939811, 13923.860761392256, 13947.58157255284, 13949.930250348683, 13966.0, 11349.773004539862, 11360.318380897173, 11371.886281137247, 11392.772144557228, 11420.086393088533, 8384.119667434832, 8437.789055273668, 8448.493090414595, 8457.196566326189, 8543.188397102265, 3320.701136897691, 3347.0, 3353.161709572607, 3353.4299169141304, 3359.143418428334, 1031.6956497833157, 1103.227740581596, 1117.804384232756, 1146.1003112556602, 1154.9480273387717, 31370.84314578458, 31466.685333146834, 31780.0, 32035.0, 32899.67100329014, 1123.224974767408, 1153.405995912106, 1218.9024878009739, 1230.4094034863315, 1254.5483625894672, 15612.687746245012, 15653.373865045498, 15816.0, 16011.199440027953, 16192.02847829134, 485683.0, 490286.0, 490576.0, 493387.0, 494823.0, 52874.73562632239, 54354.72822635862, 54354.72822635862, 54416.72791636096, 54759.178612320844, 1438.3311760031636, 1447.2401988955883, 1454.7090581883665, 1457.606446259504, 1462.56854228003, 29157.854210728812, 29610.851945740134, 30067.398652027274, 30342.393152136392, 30397.0, 45455.0, 46167.0, 46547.53452465432, 46554.767226163654, 46750.298745519525, 411013.0, 412459.0, 412986.0, 414248.0, 415906.0, 27192.456150876475, 27730.722692773623, 27853.16440506788, 27861.44277114406, 28025.0, 45358.0, 45705.54294457146, 46151.76924115358, 46685.533144668116, 46701.76649116733, 39346.40980385354, 39638.40542391924, 39653.0, 39668.40497392484, 40275.1944961105, 39163.804180978914, 39944.20111597694, 40038.39942400808, 40339.79830100948, 40401.191976159724, 38058.0, 40094.1981160381, 40427.797861010506, 41263.587364125975, 41737.79131104325, 34855.82572087123, 35611.10972225715, 35636.46545301875, 35701.0, 36595.81702091473, 28005.0, 28305.0, 28371.574426384035, 28460.43079138447, 28501.287467813472], "value": 18086.68550115423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.6222758355435, 380.9657130858223, 383.95968423315543, 392.2977869613392, 398.354665441984, 15080.0, 17495.912520437396, 18574.907125464386, 20223.089960951755, 20312.492187695298, 18119.275228990857, 18629.0, 19047.142878570463, 19166.0, 19229.61540769184, 5083.618728595352, 5547.389787123413, 5809.7676092956235, 5811.360750317483, 5823.650580965134, 5745.253117094772, 5787.971060144714, 5804.970975145118, 5809.2738407699035, 5845.590808643376, 5245.68525888446, 5581.804636837712, 5584.4136365681425, 5652.293463317085, 5670.262865827457, 5390.0, 5565.888682226353, 5771.50942169916, 5780.335261444946, 5782.785615020851, 5584.050711379075, 5599.972000140014, 5602.355729091166, 5602.607817452739, 5617.550595952314, 12073.818892716616, 13662.590122296348, 13689.452421903112, 13710.24593647349, 13720.0, 2184.923527676524, 2244.429800874979, 2251.8177956572767, 2252.977470225293, 2437.146998550511, 10084.69745907624, 10276.845847312296, 10284.280100392976, 10494.108000819862, 10548.997845204693, 1941.6407964526609, 1948.5713143108494, 1999.8200161985492, 2015.475976246172, 2041.612093702192, 74096.62951685207, 75096.0, 76614.0, 76986.61506692486, 77487.22512774856, 10742.838857417146, 10845.349279043283, 10868.239223254455, 10890.891091088988, 11549.0293678447, 12068.517259309705, 12741.490340386466, 12806.487740490276, 14937.626559336104, 14981.925090374478, 6926.480513961473, 7171.211166771651, 7232.819179520554, 7251.456140789356, 7304.160021597584, 6876.17485901685, 6937.583744975318, 6953.965230173918, 7021.684024218923, 7033.859322813618, 4026.3960405939342, 4087.509498860156, 4108.856190033394, 4138.544760076389, 4142.316517774594, 1967.1934506852122, 1968.2028778344793, 1983.5041239690077, 2010.2260629657687, 2029.0217038387455, 970.7961328121173, 1053.0943388685723, 1074.5594306334365, 1102.5699977008974, 1112.7162573543694, 18405.263789448272, 18637.534061648566, 18652.720209196872, 18678.906605466887, 19155.712664310046, 1040.3237895368072, 1047.3768107975743, 1071.8017166824163, 1072.8015317166348, 1101.3997371432429, 10271.897281027244, 10630.20273479492, 10651.0, 10706.78586428267, 10775.892241077645, 480452.0, 485581.0, 491538.0, 500173.0, 505082.0, 91316.0, 91660.0, 92137.0, 93558.53220733989, 93791.53104234434, 1020.2450186861669, 1034.5189486888632, 1037.222083437422, 1040.15747244732, 1059.7456610413599, 16202.625106635678, 16457.753133702765, 16723.247453864362, 16725.163741813103, 16936.915315423837, 28440.857795711716, 35746.8212658935, 36370.0, 38563.421548677354, 40586.39120413255, 50394.244086339466, 50957.490425095275, 51148.23277650764, 51465.0, 52068.0, 7270.491065625567, 7680.116786569616, 7696.923030769621, 7987.9600601998945, 8029.197080291924, 9620.71137865865, 12126.878731212575, 12688.365581721062, 13157.473701051851, 13341.733165336445, 11938.58214962472, 12062.45718942632, 12080.335581542748, 12243.265404075784, 12524.123311368117, 9123.361364704673, 11458.255213411101, 11616.593419230287, 11772.882271177521, 11883.287002779862, 11625.128115391548, 11843.940780296043, 11910.285382877055, 12114.575989840314, 12239.75520489603, 7288.453365997678, 7727.768166955, 7843.647035883285, 8035.075966263955, 8614.310855131449, 11146.554137834395, 11461.4269286537, 11526.711832204262, 11581.536738530365, 11652.592159274385], "value": 8799.326559800309, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.186880953095, 1556.1830039229403, 1742.7560141580182, 1849.2972670385252, 1857.4241984984656, 7741.993540839697, 8254.504729716205, 8476.618552165151, 9160.908390916089, 9162.816743665131, 7513.361364284029, 8263.132371101037, 8385.874211886827, 8466.153384661531, 8544.572771361423, 2218.157100301883, 2277.908883644652, 2278.1912421090524, 2302.643090321003, 2309.31875096846, 2240.327901629513, 2254.447660323215, 2283.4063143582707, 2287.5081857400655, 2290.3014580552926, 2232.520008198237, 2248.4154119928853, 2252.8986195621155, 2296.1045192374986, 2308.4690521180137, 2230.085664877409, 2231.665250212465, 2236.7427745809196, 2238.3173132194675, 2242.7869352411494, 2165.4478108082494, 2169.39257008038, 2170.7829217078324, 2173.0981642618294, 2184.748753893291, 8665.783355416164, 8685.652573897036, 8711.0, 8711.477311361275, 8723.25852302555, 5160.380754309507, 5303.761330740087, 5326.467353264681, 5329.866753331159, 5344.545713614348, 3320.1367644412626, 3326.7338612910908, 3470.9826450867586, 3484.5470088888537, 3495.440729483296, 1101.2346419238631, 1106.7454485468306, 1145.3585991844593, 1149.4827327702567, 1151.936643484608, 11811.704707382298, 11936.28382297065, 11984.50193725793, 12116.575919842764, 12207.328596927166, 4681.321208424827, 4693.24908014716, 4768.284757286435, 4818.253170758538, 4834.685745426536, 9643.0, 9725.465099419458, 9779.0, 9797.363171393836, 9799.608015679436, 5275.419703832576, 5277.604179686539, 5293.523582877482, 5305.575553955674, 5307.363116426053, 4326.783660816946, 4740.502247264057, 4880.072786170616, 4917.606591472673, 4933.333999910038, 3769.3968964965475, 3831.731778775459, 3855.4024126260474, 3897.337452633059, 3992.500937382827, 1121.091915548392, 1124.6288724720823, 1125.7241975716001, 1128.6614015795392, 1129.7006293332274, 1023.4371095897376, 1030.1295405382439, 1034.2656713733334, 1035.2028937718067, 1047.6176195688672, 5795.029689905452, 5856.824295271149, 5948.226730525004, 6160.322364539897, 6287.056941458818, 466.84594083952214, 476.0954187044643, 477.29598841708895, 481.52569718826925, 485.9319695242669, 4026.516817981861, 4084.6323830855367, 4111.62260642688, 4130.421740956269, 4194.182134483807, 10679.252452328417, 11065.72335691598, 11074.501647425885, 11244.212905096565, 11246.156538259664, 10970.0, 11083.889161108447, 11131.276467029616, 11141.665750027512, 11147.21969462146, 7703.537787732754, 8172.0, 8219.712310069239, 8340.582970851434, 8422.0, 5856.209411729362, 6180.320164781961, 6290.2766181889665, 6303.054541818764, 6323.336049714714, 9768.120869121813, 9926.602935882773, 10043.899561004297, 10143.64497242593, 10254.23093267993, 10153.949230253802, 10182.541785619813, 10196.694099177037, 10200.897991019994, 10436.16510679159, 7011.509194356346, 7531.585762783099, 7595.0, 7715.382769378324, 7775.766726998199, 8622.137786221328, 8646.0, 8706.825863482822, 8726.214640682369, 8731.91268087311, 7573.2048134947245, 7693.769186924401, 7731.110922244014, 7760.14638389788, 7913.485623434458, 7684.5773482459, 7754.457187997012, 7756.612169391395, 7831.099423566363, 7872.921270787218, 7197.100362454693, 7245.203027666847, 7255.782326530212, 7268.67290971897, 7282.089738782653, 5230.241614965885, 5295.179247216687, 5409.053415652324, 5466.5900057495055, 5473.124300111963, 5376.623636345575, 5474.8905021898545, 5480.424555421623, 5512.476314750093, 5540.63985840919], "value": 4550.2794041903635, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.5141082732592, 321.2418691887146, 324.06345661039586, 324.42900495128595, 326.4466728894524, 5244.816431424901, 5339.6262261641705, 5433.48381903719, 5442.9386269677425, 5535.91696124558, 5413.26920865683, 5426.778974730683, 5457.126859702438, 5462.836114916549, 5480.205370221325, 4171.249175148472, 4212.1575684863, 4230.957690423103, 4235.53409124996, 4250.8087136078875, 4141.535786207201, 4228.0, 4228.386883901832, 4237.97881010596, 4283.550227226143, 4165.500139983206, 4207.915841683164, 4208.852690155845, 4227.6617870570435, 4240.936385954213, 4128.566500517462, 4139.586041395836, 4185.869815149923, 4196.685248606352, 4214.852480163195, 3701.7229055975913, 3711.9072023199365, 3739.607341229159, 3745.662890339855, 3775.452559378902, 4950.331705219785, 5268.868278293035, 5285.68285902847, 5333.386660534049, 5355.250264962909, 4760.357351757538, 4798.832040878552, 4806.101589871981, 4813.95186048142, 4818.855434336975, 5321.414644389114, 5676.772929082832, 5684.181062060143, 5749.885002299972, 5762.769489220426, 4043.97978010111, 4057.69567282455, 4065.5527891931865, 4066.1664358806374, 4068.9624145842918, 5860.648361098348, 5907.075997381281, 5925.34821169671, 5940.277319577317, 5990.9101363479585, 4012.4783778109245, 4109.527404348479, 4132.194222126716, 4133.132042271097, 4137.275976704125, 4135.048938744106, 4136.937945930814, 4139.81370838313, 4160.022394737234, 4179.373094035919, 4681.016986432819, 4759.214729569582, 4769.189237829508, 4801.063792560487, 4803.543663351976, 5129.845784698413, 5669.688167150846, 5732.656040637492, 5801.8549536261935, 5814.534837213013, 1423.978640320396, 1440.1359184489431, 1440.652989454863, 1441.322578388156, 1445.645816774897, 886.2156991062827, 903.6746771162376, 904.3985749476525, 928.5264515097349, 940.3370623710268, 4803.847076701636, 4839.685420447659, 4851.563359297609, 4865.781039853215, 4883.902321953541, 4969.0, 4993.925091123636, 5091.287219789232, 5100.928804950928, 5141.845744627667, 4758.595519380822, 4761.6904901181315, 4787.1569445763635, 4833.32333473314, 5016.473270306638, 3109.113902537811, 3141.277506173547, 3147.244661281276, 3159.510275907238, 3196.7122958933805, 6058.0004299291, 6069.787557435468, 6081.118237855486, 6105.206323177958, 6136.631802091889, 5636.464535869086, 6030.427109424598, 6031.909521357183, 6037.396260373927, 6161.949834831787, 6011.158437818709, 6120.561668008015, 6144.446999770132, 6203.131561581382, 6238.068107989237, 5586.385497595343, 5889.234399528034, 5916.5034573723415, 5931.673757943182, 6014.218151640259, 5843.678597677169, 5866.354700982974, 5886.970565147147, 5924.318703348998, 5927.436893495111, 6086.878262434815, 6175.764847030522, 6186.412290832363, 6199.0326191236745, 6207.0, 3915.804209789556, 4128.710990230655, 4131.772752498641, 4142.130152667853, 4147.834086636622, 5698.886022279614, 5856.330945680461, 5866.6186697864505, 5901.468867801918, 5929.436703513159, 5754.9424505754405, 5756.251687280626, 5824.708764561839, 5844.778983986058, 5866.67733274674, 5707.571932105026, 5773.134029895549, 5838.678872662044, 5840.591158619026, 5849.736761845812, 5591.552675786009, 5613.242212301287, 5683.545316374597, 5691.743871525874, 5747.367789543064, 5707.315122185364, 5766.971165144148, 5809.302883653989, 5851.180834683233, 5852.824415267549, 5474.726263686879, 5609.270794796814, 5647.265855438766, 5676.631018983753, 5695.658260504218], "value": 4293.50647734909, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.6967956695805, 842.9831403371933, 843.0641987393991, 852.693030509017, 862.7541150772028, 14525.854741452582, 14753.852461475382, 14809.0, 14939.850601493981, 14944.178070206135, 13832.308384580781, 13882.236476993787, 13891.958103142255, 13912.165270083802, 13938.930305348458, 646.266487536647, 785.4776573578592, 795.9164287749775, 812.2405550810012, 813.4184058398245, 795.932345750612, 798.756379304312, 802.1256830055239, 802.1497212954287, 805.3154818404367, 865.3639574912465, 866.3805379153904, 868.6178081644088, 869.2263885142229, 872.2716531696042, 862.6678728689468, 863.6890719341033, 864.6584599083359, 865.3769286113987, 869.7869022089628, 628.064184365297, 630.3475902440952, 631.1353445779312, 631.182618509032, 632.8386261503333, 13736.93131534346, 13747.0, 13800.723985520233, 13832.723345533133, 13886.652833679138, 13746.587602371845, 13871.0, 13898.791518127236, 13909.234992075431, 13944.372503237379, 11219.0, 11267.549596415174, 11376.146788990858, 11493.482793274323, 11702.70743231426, 3825.3496905526126, 3826.2921359548573, 3920.921581568353, 3995.62041606047, 3999.3601023836045, 51238.48761512375, 51834.0, 51839.0, 51877.221841672406, 52100.47899520994, 10758.246922715334, 10776.946115269373, 10990.890091098987, 11220.607278745205, 11385.65843024694, 19582.118804653826, 19627.719219556067, 19773.802261977486, 19794.70307945382, 19885.0, 7733.651985660546, 7742.806429839299, 7746.806329841686, 7752.728654497066, 7903.091144518339, 4471.30694742309, 4706.458757242961, 4708.387909571734, 4714.269288260325, 4880.170371036932, 3201.583794106751, 3292.111129994888, 3305.93388132236, 3311.9006429807146, 3316.950245746316, 653.6600967496875, 660.4980215036607, 689.5724650716588, 697.5082566790401, 698.441247002396, 682.0519477925588, 749.6401727170988, 751.9511231769917, 754.2871985973203, 770.7880332908383, 9000.59497322622, 9403.811923761623, 9477.952610237042, 9536.28477864163, 9603.519824008772, 703.2088899987514, 725.2529894208973, 765.0589774577301, 798.1778767869104, 817.1501638296105, 4502.752348620857, 4656.278276867091, 4734.337192793012, 4805.255185446262, 4807.855764327076, 58720.41279587235, 59076.40923590795, 60280.0, 61052.38947610467, 61080.69459652673, 54885.451145488834, 55887.720561396934, 56644.0, 57184.0, 57507.13739293914, 47652.761736191096, 48025.0, 48092.519074809505, 48182.0, 48368.27447588289, 8844.425112367675, 8966.462012279284, 8986.236169925629, 9039.186473217442, 9041.095890411169, 33965.49051764275, 34117.488237675956, 34703.30593388068, 35114.0, 35385.29229415449, 41704.58295417007, 44798.3280250803, 46390.76804615955, 46957.2956405661, 47070.0, 11244.325340479598, 11282.435878205893, 11402.15411420002, 11502.769944601228, 11683.0, 12621.305828179538, 12650.177738446971, 12790.104692671424, 12871.871281287442, 13033.15284506504, 11830.645080647595, 12075.939620301842, 12116.0, 12118.151729378858, 12604.243745375306, 11871.0, 12008.339541324962, 12009.279443233434, 12087.0, 12127.393630318626, 11791.88208117908, 11812.0, 11848.0, 11865.11011674145, 12361.134720569475, 10029.0, 10089.344192627455, 10167.847482287623, 10253.33353332031, 10452.372857628567, 10405.9479702601, 10460.320079195133, 10504.632337868137, 10542.26204165701, 10628.681139565826], "value": 6726.776163738185, "unit": "score"}], "name": "dromaeo_css", "value": 6946.507869041461, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 107.0, 114.0, 113.0, 114.0, 109.0, 114.0, 115.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 155.0, 209.0, 132.0, 158.0, 155.0, 133.0, 178.0, 132.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 164.0, 163.0, 165.0, 164.0, 168.0, 182.0, 164.0, 166.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 77.0, 163.0, 76.0, 79.0, 76.0, 76.0, 167.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 172.0, 93.0, 93.0, 93.0, 140.0, 93.0, 94.0, 140.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 121.0, 119.0, 120.0, 119.0, 119.0, 119.0, 119.0, 119.0], "value": 119.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 150.0, 149.0, 149.0, 149.0, 151.0, 148.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 62.0, 59.0, 60.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 83.0, 83.0, 85.0, 83.0, 87.0, 136.0, 83.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 133.0, 131.0, 142.0, 129.0, 139.0, 140.0, 150.0, 136.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 179.0, 170.0, 174.0, 175.0, 176.0, 172.0, 170.0, 178.0, 171.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 67.0, 67.0, 65.0, 67.0, 67.0, 67.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1587.9999999999998, "alertThreshold": 2.0}]} 20:40:23 INFO - Return code: 0 20:40:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:40:23 ERROR - # TBPL SUCCESS # 20:40:23 INFO - Running post-action listener: _resource_record_post_action 20:40:23 INFO - ##### 20:40:23 INFO - ##### Finished run-tests step (success) 20:40:23 INFO - ##### 20:40:23 INFO - Running post-run listener: _resource_record_post_run 20:40:24 INFO - Total resource usage - Wall time: 1188s; CPU: 26.0%; Read bytes: 0; Write bytes: 539992064; Read time: 0; Write time: 531924 20:40:24 INFO - install - Wall time: 17s; CPU: 26.0%; Read bytes: 0; Write bytes: 244576256; Read time: 0; Write time: 250716 20:40:24 INFO - run-tests - Wall time: 1172s; CPU: 26.0%; Read bytes: 0; Write bytes: 295415808; Read time: 0; Write time: 281208 20:40:24 INFO - Running post-run listener: _upload_blobber_files 20:40:24 INFO - Blob upload gear active. 20:40:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:40:24 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 20:40:24 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:40:24 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:40:25 INFO - (blobuploader) - INFO - Open directory for files ... 20:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:40:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:25 INFO - (blobuploader) - INFO - Done attempting. 20:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:40:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:26 INFO - (blobuploader) - INFO - Done attempting. 20:40:26 INFO - (blobuploader) - INFO - Iteration through files over. 20:40:26 INFO - Return code: 0 20:40:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:40:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:40:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79329a64e256d826b4ecf2ae7ee99a32e42cdb2efa555c4de9328547ab27708ad99a3629a7a0e97024131132d8bd007d5539b09aaba929bc8729e79fbb157c0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/debcbaccd3798a2778fc6bbb32ab62c14803e4ac28e4aaec86403df9a4bfe5abed5a763c05a58d8bf803d445e487bd3254793dbcec56030e3b7298813a344b0a"} 20:40:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:40:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:40:26 INFO - Contents: 20:40:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79329a64e256d826b4ecf2ae7ee99a32e42cdb2efa555c4de9328547ab27708ad99a3629a7a0e97024131132d8bd007d5539b09aaba929bc8729e79fbb157c0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/debcbaccd3798a2778fc6bbb32ab62c14803e4ac28e4aaec86403df9a4bfe5abed5a763c05a58d8bf803d445e487bd3254793dbcec56030e3b7298813a344b0a"} 20:40:26 INFO - Running post-run listener: copy_logs_to_upload_dir 20:40:26 INFO - Copying logs to upload dir... 20:40:26 INFO - mkdir: /builds/slave/test/build/upload/logs 20:40:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.476949 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-10 20:40:26.468091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 20:40:26.471873) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79329a64e256d826b4ecf2ae7ee99a32e42cdb2efa555c4de9328547ab27708ad99a3629a7a0e97024131132d8bd007d5539b09aaba929bc8729e79fbb157c0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/debcbaccd3798a2778fc6bbb32ab62c14803e4ac28e4aaec86403df9a4bfe5abed5a763c05a58d8bf803d445e487bd3254793dbcec56030e3b7298813a344b0a"} build_url:https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005369 build_url: 'https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79329a64e256d826b4ecf2ae7ee99a32e42cdb2efa555c4de9328547ab27708ad99a3629a7a0e97024131132d8bd007d5539b09aaba929bc8729e79fbb157c0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/debcbaccd3798a2778fc6bbb32ab62c14803e4ac28e4aaec86403df9a4bfe5abed5a763c05a58d8bf803d445e487bd3254793dbcec56030e3b7298813a344b0a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 20:40:26.485841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:40:26.486139) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462936534.8939-1997558314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002091 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:40:26.566241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 20:40:26.566578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 20:40:26.566874) ========= ========= Total master_lag: 0.16 =========