builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1461845527.81 results: success (0) buildid: 20160428023032 builduid: 67a8eaa1d4c8492389f8efa4482b7e3d revision: 53765e008b97622b5c7e26d22b2db016b0e53dc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.813687) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.814136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.814464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.914381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.914758) ========= 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=920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 05:12:07-- 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% 29.8M=0s 2016-04-28 05:12:08 (29.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189296 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.129294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.129562) ========= 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=920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.072310 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.213288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.213642) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 53765e008b97622b5c7e26d22b2db016b0e53dc1 --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 53765e008b97622b5c7e26d22b2db016b0e53dc1 --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=920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 05:12:08,299 truncating revision to first 12 chars 2016-04-28 05:12:08,299 Setting DEBUG logging. 2016-04-28 05:12:08,299 attempt 1/10 2016-04-28 05:12:08,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/53765e008b97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 05:12:08,554 unpacking tar archive at: fx-team-53765e008b97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525027 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.751609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.751924) ========= script_repo_revision: 53765e008b97622b5c7e26d22b2db016b0e53dc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.752337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.752603) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.761921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-28 05:12:08.762198) ========= /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=920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:12:09 INFO - MultiFileLogger online at 20160428 05:12:09 in /builds/slave/test 05:12:09 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 05:12:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:12:09 INFO - {'append_to_log': False, 05:12:09 INFO - 'base_work_dir': '/builds/slave/test', 05:12:09 INFO - 'blob_upload_branch': 'Fx-Team', 05:12:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:12:09 INFO - 'branch': 'Fx-Team', 05:12:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:09 INFO - 'config_files': ('talos/linux_config.py',), 05:12:09 INFO - 'default_actions': ('clobber', 05:12:09 INFO - 'read-buildbot-config', 05:12:09 INFO - 'download-and-extract', 05:12:09 INFO - 'populate-webroot', 05:12:09 INFO - 'create-virtualenv', 05:12:09 INFO - 'install', 05:12:09 INFO - 'run-tests'), 05:12:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:09 INFO - 'download_minidump_stackwalk': True, 05:12:09 INFO - 'download_symbols': 'ondemand', 05:12:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:09 INFO - 'installer_path': 'installer.exe', 05:12:09 INFO - 'log_level': 'info', 05:12:09 INFO - 'log_name': 'talos', 05:12:09 INFO - 'log_to_console': True, 05:12:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:12:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:12:09 INFO - 'opt_config_files': (), 05:12:09 INFO - 'pip_index': False, 05:12:09 INFO - 'sps_profile': False, 05:12:09 INFO - 'sps_profile_interval': 0, 05:12:09 INFO - 'suite': 'dromaeojs-e10s', 05:12:09 INFO - 'system_bits': '32', 05:12:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:09 INFO - 'title': 'talos-linux64-ix-053', 05:12:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:09 INFO - 'use_talos_json': True, 05:12:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:12:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:09 INFO - 'work_dir': 'build'} 05:12:09 INFO - ##### 05:12:09 INFO - ##### Running clobber step. 05:12:09 INFO - ##### 05:12:09 INFO - Running pre-action listener: _resource_record_pre_action 05:12:09 INFO - Running main action method: clobber 05:12:09 INFO - rmtree: /builds/slave/test/build 05:12:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:10 INFO - Running post-action listener: _resource_record_post_action 05:12:10 INFO - ##### 05:12:10 INFO - ##### Running read-buildbot-config step. 05:12:10 INFO - ##### 05:12:10 INFO - Running pre-action listener: _resource_record_pre_action 05:12:10 INFO - Running main action method: read_buildbot_config 05:12:10 INFO - Using buildbot properties: 05:12:10 INFO - { 05:12:10 INFO - "project": "", 05:12:10 INFO - "product": "firefox", 05:12:10 INFO - "script_repo_revision": "production", 05:12:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:12:10 INFO - "repository": "", 05:12:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:12:10 INFO - "buildid": "20160428023032", 05:12:10 INFO - "pgo_build": "True", 05:12:10 INFO - "basedir": "/builds/slave/test", 05:12:10 INFO - "buildnumber": 420, 05:12:10 INFO - "slavename": "talos-linux64-ix-053", 05:12:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:12:10 INFO - "platform": "ubuntu64_hw", 05:12:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:12:10 INFO - "branch": "fx-team", 05:12:10 INFO - "repo_path": "integration/fx-team", 05:12:10 INFO - "revision": "53765e008b97622b5c7e26d22b2db016b0e53dc1", 05:12:10 INFO - "stage_platform": "linux64-pgo", 05:12:10 INFO - "builduid": "67a8eaa1d4c8492389f8efa4482b7e3d", 05:12:10 INFO - "slavebuilddir": "test" 05:12:10 INFO - } 05:12:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:12:10 INFO - Running post-action listener: _resource_record_post_action 05:12:10 INFO - ##### 05:12:10 INFO - ##### Running download-and-extract step. 05:12:10 INFO - ##### 05:12:10 INFO - Running pre-action listener: _resource_record_pre_action 05:12:10 INFO - Running main action method: download_and_extract 05:12:10 INFO - mkdir: /builds/slave/test/build/tests 05:12:10 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')]} 05:12:10 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:12:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:12:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:12:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:15 INFO - Downloaded 1361 bytes. 05:12:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:12:15 INFO - Using the following test package requirements: 05:12:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:12:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:12:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:15 INFO - u'jsshell-linux-x86_64.zip'], 05:12:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:12:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:12:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:12:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:12:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:12:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:12:15 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')]} 05:12:15 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:18 INFO - Downloaded 23865705 bytes. 05:12:18 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'] 05:12:18 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 05:12:20 INFO - Return code: 0 05:12:20 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 05:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:20 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:30 INFO - Downloaded 23865705 bytes. 05:12:30 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'] 05:12:30 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 05:12:31 INFO - Return code: 0 05:12: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')]} 05:12:31 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:12:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:32 INFO - Downloaded 10840145 bytes. 05:12:32 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'] 05:12:32 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 05:12:32 INFO - Return code: 0 05:12:32 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')]} 05:12:32 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:12:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:12:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:12:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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 05:12:34 INFO - Downloaded 58384183 bytes. 05:12:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:12:34 INFO - mkdir: /builds/slave/test/properties 05:12:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:12:34 INFO - Writing to file /builds/slave/test/properties/build_url 05:12:34 INFO - Contents: 05:12:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:12:35 INFO - Running post-action listener: _resource_record_post_action 05:12:35 INFO - Running post-action listener: set_extra_try_arguments 05:12:35 INFO - ##### 05:12:35 INFO - ##### Running populate-webroot step. 05:12:35 INFO - ##### 05:12:35 INFO - Running pre-action listener: _resource_record_pre_action 05:12:35 INFO - Running main action method: populate_webroot 05:12:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:12:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:12:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:12:35 INFO - '--tppagecycles', 05:12:35 INFO - '7'], 05:12:35 INFO - 'tests': ['tsvgm']}}, 05:12:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:12:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:12:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:12:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:12:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:35 INFO - 'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:35 INFO - 'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['damp', 'tps']}, 05:12:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:35 INFO - 'tests': ['damp', 'tps']}, 05:12:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['dromaeo_dom']}, 05:12:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:12:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['a11yr', 05:12:35 INFO - 'ts_paint', 05:12:35 INFO - 'tpaint', 05:12:35 INFO - 'sessionrestore', 05:12:35 INFO - 'sessionrestore_no_auto_restore', 05:12:35 INFO - 'tabpaint']}, 05:12:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:12:35 INFO - 'ts_paint', 05:12:35 INFO - 'tpaint', 05:12:35 INFO - 'sessionrestore', 05:12:35 INFO - 'sessionrestore_no_auto_restore', 05:12:35 INFO - 'tabpaint']}, 05:12:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:12:35 INFO - 'ts_paint', 05:12:35 INFO - 'tpaint', 05:12:35 INFO - 'sessionrestore', 05:12:35 INFO - 'sessionrestore_no_auto_restore', 05:12:35 INFO - 'tabpaint']}, 05:12:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:12:35 INFO - 'ts_paint', 05:12:35 INFO - 'tpaint', 05:12:35 INFO - 'sessionrestore', 05:12:35 INFO - 'sessionrestore_no_auto_restore', 05:12:35 INFO - 'tabpaint']}, 05:12:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['a11yr', 05:12:35 INFO - 'ts_paint', 05:12:35 INFO - 'tpaint', 05:12:35 INFO - 'sessionrestore', 05:12:35 INFO - 'sessionrestore_no_auto_restore', 05:12:35 INFO - 'tabpaint']}, 05:12:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['a11yr', 05:12:35 INFO - 'ts_paint', 05:12:35 INFO - 'tpaint', 05:12:35 INFO - 'sessionrestore', 05:12:35 INFO - 'sessionrestore_no_auto_restore', 05:12:35 INFO - 'tabpaint']}, 05:12:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['tsvgx', 05:12:35 INFO - 'tsvgr_opacity', 05:12:35 INFO - 'tart', 05:12:35 INFO - 'tscrollx', 05:12:35 INFO - 'cart']}, 05:12:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:12:35 INFO - 'tsvgr_opacity', 05:12:35 INFO - 'tart', 05:12:35 INFO - 'tscrollx', 05:12:35 INFO - 'cart']}, 05:12:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:35 INFO - 'talos_options': ['--disable-e10s'], 05:12:35 INFO - 'tests': ['tp5o']}, 05:12:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:35 INFO - 'tests': ['tp5o']}, 05:12:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:35 INFO - 'talos_options': ['--disable-e10s', 05:12:35 INFO - '--xperf_path', 05:12:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:35 INFO - 'tests': ['tp5n']}, 05:12:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:35 INFO - 'talos_options': ['--xperf_path', 05:12:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:35 INFO - 'tests': ['tp5n']}}, 05:12:35 INFO - 'talos.zip': {'path': '', 05:12:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:12:35 INFO - Running post-action listener: _resource_record_post_action 05:12:35 INFO - ##### 05:12:35 INFO - ##### Running create-virtualenv step. 05:12:35 INFO - ##### 05:12:35 INFO - Running pre-action listener: _resource_record_pre_action 05:12:35 INFO - Running main action method: create_virtualenv 05:12:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:12:35 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 05:12:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:12:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:12:35 INFO - Using real prefix '/usr' 05:12:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:12:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:12:38 INFO - Installing pip.................done. 05:12:38 INFO - Return code: 0 05:12:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:38 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 0x7facda2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', '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 05:12:38 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 05:12:38 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 05:12:38 INFO - Using env: {'DISPLAY': ':0', 05:12:38 INFO - 'HOME': '/home/cltbld', 05:12:38 INFO - 'LANG': 'en_US.UTF-8', 05:12:38 INFO - 'LANGUAGE': 'en_US:en', 05:12:38 INFO - 'LOGNAME': 'cltbld', 05:12:38 INFO - 'MAIL': '/var/mail/cltbld', 05:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:38 INFO - 'MOZ_NO_REMOTE': '1', 05:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:38 INFO - 'NO_EM_RESTART': '1', 05:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:38 INFO - 'PWD': '/builds/slave/test', 05:12:38 INFO - 'SHELL': '/bin/bash', 05:12:38 INFO - 'SHLVL': '1', 05:12:38 INFO - 'TERM': 'linux', 05:12:38 INFO - 'TMOUT': '86400', 05:12:38 INFO - 'USER': 'cltbld', 05:12:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:38 INFO - '_': '/tools/buildbot/bin/python'} 05:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:38 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 05:12:38 INFO - Cleaning up... 05:12:38 INFO - Return code: 0 05:12:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:38 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 0x7facda2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', '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 05:12:38 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 05:12:38 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 05:12:38 INFO - Using env: {'DISPLAY': ':0', 05:12:38 INFO - 'HOME': '/home/cltbld', 05:12:38 INFO - 'LANG': 'en_US.UTF-8', 05:12:38 INFO - 'LANGUAGE': 'en_US:en', 05:12:38 INFO - 'LOGNAME': 'cltbld', 05:12:38 INFO - 'MAIL': '/var/mail/cltbld', 05:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:38 INFO - 'MOZ_NO_REMOTE': '1', 05:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:38 INFO - 'NO_EM_RESTART': '1', 05:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:38 INFO - 'PWD': '/builds/slave/test', 05:12:38 INFO - 'SHELL': '/bin/bash', 05:12:38 INFO - 'SHLVL': '1', 05:12:38 INFO - 'TERM': 'linux', 05:12:38 INFO - 'TMOUT': '86400', 05:12:38 INFO - 'USER': 'cltbld', 05:12:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:38 INFO - '_': '/tools/buildbot/bin/python'} 05:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:38 INFO - Downloading/unpacking psutil>=0.7.1 05:12:38 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 05:12:38 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 05:12:38 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 05:12:38 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 05:12:38 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 05:12:38 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 05:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:40 INFO - Installing collected packages: psutil 05:12:40 INFO - Running setup.py install for psutil 05:12:40 INFO - building 'psutil._psutil_linux' extension 05:12:40 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 05:12:41 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 05:12:42 INFO - building 'psutil._psutil_posix' extension 05:12:42 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 05:12:42 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 05:12:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:42 INFO - Successfully installed psutil 05:12:42 INFO - Cleaning up... 05:12:42 INFO - Return code: 0 05:12:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:12:42 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')]} 05:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:42 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')]} 05:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:42 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 0x7facda2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', '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 05:12:42 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 05:12:42 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 05:12:42 INFO - Using env: {'DISPLAY': ':0', 05:12:42 INFO - 'HOME': '/home/cltbld', 05:12:42 INFO - 'LANG': 'en_US.UTF-8', 05:12:42 INFO - 'LANGUAGE': 'en_US:en', 05:12:42 INFO - 'LOGNAME': 'cltbld', 05:12:42 INFO - 'MAIL': '/var/mail/cltbld', 05:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:42 INFO - 'MOZ_NO_REMOTE': '1', 05:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:42 INFO - 'NO_EM_RESTART': '1', 05:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:42 INFO - 'PWD': '/builds/slave/test', 05:12:42 INFO - 'SHELL': '/bin/bash', 05:12:42 INFO - 'SHLVL': '1', 05:12:42 INFO - 'TERM': 'linux', 05:12:42 INFO - 'TMOUT': '86400', 05:12:42 INFO - 'USER': 'cltbld', 05:12:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:42 INFO - '_': '/tools/buildbot/bin/python'} 05:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:12:44 INFO - Installing collected packages: mozsystemmonitor 05:12:44 INFO - Running setup.py install for mozsystemmonitor 05:12:44 INFO - Successfully installed mozsystemmonitor 05:12:44 INFO - Cleaning up... 05:12:44 INFO - Return code: 0 05:12:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7facda2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', '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 05:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:12:44 INFO - Using env: {'DISPLAY': ':0', 05:12:44 INFO - 'HOME': '/home/cltbld', 05:12:44 INFO - 'LANG': 'en_US.UTF-8', 05:12:44 INFO - 'LANGUAGE': 'en_US:en', 05:12:44 INFO - 'LOGNAME': 'cltbld', 05:12:44 INFO - 'MAIL': '/var/mail/cltbld', 05:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:44 INFO - 'MOZ_NO_REMOTE': '1', 05:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:44 INFO - 'NO_EM_RESTART': '1', 05:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:44 INFO - 'PWD': '/builds/slave/test', 05:12:44 INFO - 'SHELL': '/bin/bash', 05:12:44 INFO - 'SHLVL': '1', 05:12:44 INFO - 'TERM': 'linux', 05:12:44 INFO - 'TMOUT': '86400', 05:12:44 INFO - 'USER': 'cltbld', 05:12:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:44 INFO - '_': '/tools/buildbot/bin/python'} 05:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:12:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:12:46 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 05:12:46 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 05:12:46 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 05:12:46 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 05:12:46 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 05:12:46 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 05:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:12:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:47 INFO - Downloading docopt-0.6.1.tar.gz 05:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:12:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:12:47 INFO - Running setup.py install for blobuploader 05:12:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:12:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:12:47 INFO - Running setup.py install for requests 05:12:48 INFO - Running setup.py install for docopt 05:12:48 INFO - Successfully installed blobuploader requests docopt 05:12:48 INFO - Cleaning up... 05:12:48 INFO - Return code: 0 05:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:48 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 0x7facda2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', '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 05:12:48 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 05:12:48 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 05:12:48 INFO - Using env: {'DISPLAY': ':0', 05:12:48 INFO - 'HOME': '/home/cltbld', 05:12:48 INFO - 'LANG': 'en_US.UTF-8', 05:12:48 INFO - 'LANGUAGE': 'en_US:en', 05:12:48 INFO - 'LOGNAME': 'cltbld', 05:12:48 INFO - 'MAIL': '/var/mail/cltbld', 05:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:48 INFO - 'MOZ_NO_REMOTE': '1', 05:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:48 INFO - 'NO_EM_RESTART': '1', 05:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:48 INFO - 'PWD': '/builds/slave/test', 05:12:48 INFO - 'SHELL': '/bin/bash', 05:12:48 INFO - 'SHLVL': '1', 05:12:48 INFO - 'TERM': 'linux', 05:12:48 INFO - 'TMOUT': '86400', 05:12:48 INFO - 'USER': 'cltbld', 05:12:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:48 INFO - '_': '/tools/buildbot/bin/python'} 05:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:48 INFO - Running setup.py (path:/tmp/pip-59hBgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:48 INFO - Running setup.py (path:/tmp/pip-SZqebZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:48 INFO - Running setup.py (path:/tmp/pip-UoiVlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:48 INFO - Running setup.py (path:/tmp/pip-54TMM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:48 INFO - Running setup.py (path:/tmp/pip-TntzVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:48 INFO - Running setup.py (path:/tmp/pip-FxSfcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:48 INFO - Running setup.py (path:/tmp/pip-ocxXnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:48 INFO - Running setup.py (path:/tmp/pip-Y1L0fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:48 INFO - Running setup.py (path:/tmp/pip-fuoga0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:49 INFO - Running setup.py (path:/tmp/pip-X9ODB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:49 INFO - Running setup.py (path:/tmp/pip-ylOMlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:49 INFO - Running setup.py (path:/tmp/pip-dw3yg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:49 INFO - Running setup.py (path:/tmp/pip-WwMjs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:49 INFO - Running setup.py (path:/tmp/pip-EWAKJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:49 INFO - Running setup.py (path:/tmp/pip-6i2KnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:49 INFO - Running setup.py (path:/tmp/pip-yKcMx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:49 INFO - Running setup.py (path:/tmp/pip-15Io0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:49 INFO - Running setup.py install for manifestparser 05:12:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:12:49 INFO - Running setup.py install for mozcrash 05:12:49 INFO - Running setup.py install for mozdebug 05:12:49 INFO - Running setup.py install for mozdevice 05:12:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Running setup.py install for mozfile 05:12:50 INFO - Running setup.py install for mozhttpd 05:12:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Running setup.py install for mozinfo 05:12:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Running setup.py install for mozInstall 05:12:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Running setup.py install for mozleak 05:12:50 INFO - Running setup.py install for mozlog 05:12:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Running setup.py install for moznetwork 05:12:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Running setup.py install for mozprocess 05:12:50 INFO - Running setup.py install for mozprofile 05:12:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:12:50 INFO - Running setup.py install for mozrunner 05:12:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:12:51 INFO - Running setup.py install for mozscreenshot 05:12:51 INFO - Running setup.py install for moztest 05:12:51 INFO - Running setup.py install for mozversion 05:12:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:12:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:51 INFO - Cleaning up... 05:12:51 INFO - Return code: 0 05:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12: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')]} 05:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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')]} 05:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:51 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 0x7facda2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', '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 05:12:51 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 05:12:51 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 05:12:51 INFO - Using env: {'DISPLAY': ':0', 05:12:51 INFO - 'HOME': '/home/cltbld', 05:12:51 INFO - 'LANG': 'en_US.UTF-8', 05:12:51 INFO - 'LANGUAGE': 'en_US:en', 05:12:51 INFO - 'LOGNAME': 'cltbld', 05:12:51 INFO - 'MAIL': '/var/mail/cltbld', 05:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:51 INFO - 'MOZ_NO_REMOTE': '1', 05:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:51 INFO - 'NO_EM_RESTART': '1', 05:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:51 INFO - 'PWD': '/builds/slave/test', 05:12:51 INFO - 'SHELL': '/bin/bash', 05:12:51 INFO - 'SHLVL': '1', 05:12:51 INFO - 'TERM': 'linux', 05:12:51 INFO - 'TMOUT': '86400', 05:12:51 INFO - 'USER': 'cltbld', 05:12:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:51 INFO - '_': '/tools/buildbot/bin/python'} 05:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:51 INFO - Running setup.py (path:/tmp/pip-1neG_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:51 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)) 05:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:51 INFO - Running setup.py (path:/tmp/pip-NOe3au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:51 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)) 05:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:51 INFO - Running setup.py (path:/tmp/pip-OOrlWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:51 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)) 05:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:51 INFO - Running setup.py (path:/tmp/pip-ujaVHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:51 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)) 05:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:51 INFO - Running setup.py (path:/tmp/pip-DW4cle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:51 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)) 05:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:51 INFO - Running setup.py (path:/tmp/pip-Gx0Xkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:52 INFO - Running setup.py (path:/tmp/pip-ZiAdEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:52 INFO - Running setup.py (path:/tmp/pip-wNaEsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:52 INFO - Running setup.py (path:/tmp/pip-WI9ilb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:52 INFO - Running setup.py (path:/tmp/pip-c0z_M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:52 INFO - Running setup.py (path:/tmp/pip-N72VCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:52 INFO - Running setup.py (path:/tmp/pip-IVKkJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:52 INFO - Running setup.py (path:/tmp/pip-f98Wnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:52 INFO - Running setup.py (path:/tmp/pip-WO73c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:52 INFO - Running setup.py (path:/tmp/pip-FZ_rCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:52 INFO - Running setup.py (path:/tmp/pip-IKpyrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:52 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)) 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:52 INFO - Running setup.py (path:/tmp/pip-Ltl4m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:52 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)) 05:12:52 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)) 05:12:52 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)) 05:12:52 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)) 05:12:52 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)) 05:12:52 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)) 05:12:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:54 INFO - Downloading blessings-1.6.tar.gz 05:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:54 INFO - Installing collected packages: blessings 05:12:54 INFO - Running setup.py install for blessings 05:12:54 INFO - Successfully installed blessings 05:12:54 INFO - Cleaning up... 05:12:54 INFO - Return code: 0 05:12:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:55 INFO - Reading from file tmpfile_stdout 05:12:55 INFO - Current package versions: 05:12:55 INFO - argparse == 1.2.1 05:12:55 INFO - blessings == 1.6 05:12:55 INFO - blobuploader == 1.2.4 05:12:55 INFO - docopt == 0.6.1 05:12:55 INFO - manifestparser == 1.1 05:12:55 INFO - mozInstall == 1.12 05:12:55 INFO - mozcrash == 0.17 05:12:55 INFO - mozdebug == 0.1 05:12:55 INFO - mozdevice == 0.48 05:12:55 INFO - mozfile == 1.2 05:12:55 INFO - mozhttpd == 0.7 05:12:55 INFO - mozinfo == 0.9 05:12:55 INFO - mozleak == 0.1 05:12:55 INFO - mozlog == 3.1 05:12:55 INFO - moznetwork == 0.27 05:12:55 INFO - mozprocess == 0.22 05:12:55 INFO - mozprofile == 0.28 05:12:55 INFO - mozrunner == 6.11 05:12:55 INFO - mozscreenshot == 0.1 05:12:55 INFO - mozsystemmonitor == 0.0 05:12:55 INFO - moztest == 0.7 05:12:55 INFO - mozversion == 1.4 05:12:55 INFO - psutil == 3.1.1 05:12:55 INFO - requests == 1.2.3 05:12:55 INFO - wsgiref == 0.1.2 05:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:55 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 0x7facda2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', '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 05:12:55 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 05:12:55 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 05:12:55 INFO - Using env: {'DISPLAY': ':0', 05:12:55 INFO - 'HOME': '/home/cltbld', 05:12:55 INFO - 'LANG': 'en_US.UTF-8', 05:12:55 INFO - 'LANGUAGE': 'en_US:en', 05:12:55 INFO - 'LOGNAME': 'cltbld', 05:12:55 INFO - 'MAIL': '/var/mail/cltbld', 05:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:55 INFO - 'MOZ_NO_REMOTE': '1', 05:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:55 INFO - 'NO_EM_RESTART': '1', 05:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:55 INFO - 'PWD': '/builds/slave/test', 05:12:55 INFO - 'SHELL': '/bin/bash', 05:12:55 INFO - 'SHLVL': '1', 05:12:55 INFO - 'TERM': 'linux', 05:12:55 INFO - 'TMOUT': '86400', 05:12:55 INFO - 'USER': 'cltbld', 05:12:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:55 INFO - '_': '/tools/buildbot/bin/python'} 05:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:55 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)) 05:12:55 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)) 05:12:55 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)) 05:12:55 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)) 05:12:55 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)) 05:12:55 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)) 05:12:55 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)) 05:12:55 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)) 05:12:55 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)) 05:12:55 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)) 05:12:55 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)) 05:12:55 INFO - Cleaning up... 05:12:55 INFO - Return code: 0 05:12:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', '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 05:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:12:55 INFO - Using env: {'DISPLAY': ':0', 05:12:55 INFO - 'HOME': '/home/cltbld', 05:12:55 INFO - 'LANG': 'en_US.UTF-8', 05:12:55 INFO - 'LANGUAGE': 'en_US:en', 05:12:55 INFO - 'LOGNAME': 'cltbld', 05:12:55 INFO - 'MAIL': '/var/mail/cltbld', 05:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:55 INFO - 'MOZ_NO_REMOTE': '1', 05:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:55 INFO - 'NO_EM_RESTART': '1', 05:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:55 INFO - 'PWD': '/builds/slave/test', 05:12:55 INFO - 'SHELL': '/bin/bash', 05:12:55 INFO - 'SHLVL': '1', 05:12:55 INFO - 'TERM': 'linux', 05:12:55 INFO - 'TMOUT': '86400', 05:12:55 INFO - 'USER': 'cltbld', 05:12:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:55 INFO - '_': '/tools/buildbot/bin/python'} 05:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:55 INFO - Downloading/unpacking jsonschema 05:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:12:57 INFO - Downloading/unpacking functools32 (from jsonschema) 05:12:57 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 05:12:57 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 05:12:57 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 05:12:57 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 05:12:57 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 05:12:57 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 05:12:57 INFO - Downloading functools32-3.2.3-2.tar.gz 05:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:12:57 INFO - warning: no files found matching '*.txt' 05:12:57 INFO - no previously-included directories found matching 'build' 05:12:57 INFO - no previously-included directories found matching 'dist' 05:12:57 INFO - no previously-included directories found matching '.git*' 05:12:57 INFO - Installing collected packages: jsonschema, functools32 05:12:57 INFO - Running setup.py install for functools32 05:12:57 INFO - warning: no files found matching '*.txt' 05:12:57 INFO - no previously-included directories found matching 'build' 05:12:57 INFO - no previously-included directories found matching 'dist' 05:12:57 INFO - no previously-included directories found matching '.git*' 05:12:57 INFO - Successfully installed jsonschema functools32 05:12:57 INFO - Cleaning up... 05:12:57 INFO - Return code: 0 05:12:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:12:57 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')]} 05:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:57 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')]} 05:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:57 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 0x7facda2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', '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 05:12:57 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 05:12:57 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 05:12:57 INFO - Using env: {'DISPLAY': ':0', 05:12:57 INFO - 'HOME': '/home/cltbld', 05:12:57 INFO - 'LANG': 'en_US.UTF-8', 05:12:57 INFO - 'LANGUAGE': 'en_US:en', 05:12:57 INFO - 'LOGNAME': 'cltbld', 05:12:57 INFO - 'MAIL': '/var/mail/cltbld', 05:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:57 INFO - 'MOZ_NO_REMOTE': '1', 05:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:57 INFO - 'NO_EM_RESTART': '1', 05:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:57 INFO - 'PWD': '/builds/slave/test', 05:12:57 INFO - 'SHELL': '/bin/bash', 05:12:57 INFO - 'SHLVL': '1', 05:12:57 INFO - 'TERM': 'linux', 05:12:57 INFO - 'TMOUT': '86400', 05:12:57 INFO - 'USER': 'cltbld', 05:12:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:57 INFO - '_': '/tools/buildbot/bin/python'} 05:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:58 INFO - Downloading/unpacking flake8 05:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:12:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:13:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:13:00 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 05:13:00 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 05:13:00 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 05:13:00 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 05:13:00 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 05:13:00 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 05:13:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:13:00 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 05:13:00 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 05:13:00 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 05:13:00 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 05:13:00 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 05:13:00 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 05:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:13:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:00 INFO - no previously-included directories found matching 'docs/_build' 05:13:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:13:00 INFO - Running setup.py install for pep8 05:13:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:00 INFO - no previously-included directories found matching 'docs/_build' 05:13:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:13:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:13:00 INFO - Cleaning up... 05:13:00 INFO - Return code: 0 05:13:00 INFO - Running post-action listener: _resource_record_post_action 05:13:00 INFO - Running post-action listener: _start_resource_monitoring 05:13:00 INFO - Starting resource monitoring. 05:13:00 INFO - ##### 05:13:00 INFO - ##### Running install step. 05:13:00 INFO - ##### 05:13:00 INFO - Running pre-action listener: _resource_record_pre_action 05:13:00 INFO - Running main action method: install 05:13:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:01 INFO - Reading from file tmpfile_stdout 05:13:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:13:01 INFO - Reading from file tmpfile_stdout 05:13:01 INFO - Output received: 05:13:01 INFO - Usage: mozinstall [options] installer 05:13:01 INFO - Options: 05:13:01 INFO - -h, --help show this help message and exit 05:13:01 INFO - -d DEST, --destination=DEST 05:13:01 INFO - Directory to install application into. [default: 05:13:01 INFO - "/builds/slave/test"] 05:13:01 INFO - --app=APP Application being installed. [default: firefox] 05:13:01 INFO - mkdir: /builds/slave/test/build/application 05:13:01 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'] 05:13:01 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 05:13:17 INFO - Reading from file tmpfile_stdout 05:13:17 INFO - Output received: 05:13:17 INFO - /builds/slave/test/build/application/firefox/firefox 05:13:17 INFO - Running post-action listener: _resource_record_post_action 05:13:17 INFO - ##### 05:13:17 INFO - ##### Running run-tests step. 05:13:17 INFO - ##### 05:13:17 INFO - Running pre-action listener: _resource_record_pre_action 05:13:17 INFO - Running main action method: run_tests 05:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:13:17 INFO - Python 2.7.3 05:13:17 INFO - Return code: 0 05:13:17 INFO - grabbing minidump binary from tooltool 05:13: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')]} 05:13:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:13:17 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 05:13:17 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 05:13:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:13:17 INFO - Return code: 0 05:13:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:13:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:13:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:13:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:13:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:13:18 INFO - Return code: 0 05:13:18 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/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:13:18 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/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 05:13:18 INFO - Using env: {'DISPLAY': ':0', 05:13:18 INFO - 'HOME': '/home/cltbld', 05:13:18 INFO - 'LANG': 'en_US.UTF-8', 05:13:18 INFO - 'LANGUAGE': 'en_US:en', 05:13:18 INFO - 'LOGNAME': 'cltbld', 05:13:18 INFO - 'MAIL': '/var/mail/cltbld', 05:13:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:13:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:18 INFO - 'MOZ_NO_REMOTE': '1', 05:13:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:18 INFO - 'NO_EM_RESTART': '1', 05:13:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:18 INFO - 'PWD': '/builds/slave/test', 05:13:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:13:18 INFO - 'SHELL': '/bin/bash', 05:13:18 INFO - 'SHLVL': '1', 05:13:18 INFO - 'TERM': 'linux', 05:13:18 INFO - 'TMOUT': '86400', 05:13:18 INFO - 'USER': 'cltbld', 05:13:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851', 05:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:18 INFO - '_': '/tools/buildbot/bin/python'} 05:13:18 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/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:13:19 INFO - mozversion application_buildid: 20160428023032 05:13:19 INFO - mozversion application_changeset: 53765e008b97622b5c7e26d22b2db016b0e53dc1 05:13:19 INFO - mozversion application_display_name: Nightly 05:13:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:13:19 INFO - mozversion application_name: Firefox 05:13:19 INFO - mozversion application_remotingname: firefox 05:13:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:13:19 INFO - mozversion application_vendor: Mozilla 05:13:19 INFO - mozversion application_version: 49.0a1 05:13:19 INFO - mozversion platform_buildid: 20160428023032 05:13:19 INFO - mozversion platform_changeset: 53765e008b97622b5c7e26d22b2db016b0e53dc1 05:13:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:13:19 INFO - mozversion platform_version: 49.0a1 05:13:19 INFO - using testdate: 1461845599 05:13:19 INFO - actual date: 1461845599 05:13:19 INFO - starting webserver on 'localhost:33467' 05:13:19 INFO - SUITE-START | Running 2 tests 05:13:19 INFO - TEST-START | dromaeo_css 05:13:19 INFO - operating with platform_type : linux_ 05:13:19 INFO - Initialising browser for dromaeo_css test... 05:13:19 INFO - TEST-INFO | started process 3378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5shCuK/profile http://localhost:33467/getInfo.html) 05:13:24 INFO - PROCESS | 3378 | 05:13:24 INFO - PROCESS | 3378 | (process:3448): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:13:26 INFO - PROCESS | 3378 | __metrics Screen width/height:1600/1200 05:13:26 INFO - PROCESS | 3378 | colorDepth:24 05:13:26 INFO - PROCESS | 3378 | Browser inner width/height: 1024/697 05:13:26 INFO - PROCESS | 3378 | __metrics 05:13:27 ERROR - PROCESS | 3378 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:13:28 INFO - TEST-INFO | 3378: exit 0 05:13:28 INFO - Browser initialized. 05:13:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:13:28 INFO - TEST-INFO | started process 3499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5shCuK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:30 INFO - PROCESS | 3499 | 05:13:30 INFO - PROCESS | 3499 | (process:3562): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:13:40 INFO - PROCESS | 3499 | RSS: Main: 164765696 05:13:40 INFO - PROCESS | 3499 | 05:14:29 INFO - PROCESS | 3499 | 1461845669808 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] 05:16:36 INFO - PROCESS | 3499 | Cycle 1(1): loaded http://localhost:33467/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33467/tests/dromaeo/cssquery-ext.html) 05:16:38 INFO - PROCESS | 3499 | RSS: Main: 169869312 05:16:38 INFO - PROCESS | 3499 | 05:19:40 INFO - PROCESS | 3499 | Cycle 1(1): loaded http://localhost:33467/tests/dromaeo/cssquery-ext.html (next: http://localhost:33467/tests/dromaeo/cssquery-jquery.html) 05:19:40 INFO - PROCESS | 3499 | RSS: Main: 166752256 05:19:40 INFO - PROCESS | 3499 | 05:22:42 INFO - PROCESS | 3499 | Cycle 1(1): loaded http://localhost:33467/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33467/tests/dromaeo/cssquery-mootools.html) 05:22:43 INFO - PROCESS | 3499 | RSS: Main: 167768064 05:22:43 INFO - PROCESS | 3499 | 05:25:44 INFO - PROCESS | 3499 | Cycle 1(1): loaded http://localhost:33467/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33467/tests/dromaeo/cssquery-prototype.html) 05:25:45 INFO - PROCESS | 3499 | RSS: Main: 165785600 05:25:45 INFO - PROCESS | 3499 | 05:28:47 INFO - PROCESS | 3499 | Cycle 1(1): loaded http://localhost:33467/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33467/tests/dromaeo/cssquery-yui.html) 05:28:48 INFO - PROCESS | 3499 | RSS: Main: 167362560 05:28:48 INFO - PROCESS | 3499 | 05:31:50 INFO - PROCESS | 3499 | Cycle 1(1): loaded http://localhost:33467/tests/dromaeo/cssquery-yui.html (next: http://localhost:33467/tests/dromaeo/cssquery-dojo.html) 05:31:50 INFO - PROCESS | 3499 | RSS: Main: 169046016 05:31:50 INFO - PROCESS | 3499 | 05:31:50 INFO - PROCESS | 3499 | __start_tp_report 05:31:50 INFO - PROCESS | 3499 | _x_x_mozilla_page_load 05:31:50 INFO - PROCESS | 3499 | _x_x_mozilla_page_load_details 05:31:50 INFO - PROCESS | 3499 | |i|pagename|runs| 05:31:50 INFO - PROCESS | 3499 | |0;dojo.html;3103.9224019399526;3120.469520181569;3137.70191831776;3149.1654711501455;3173.2384227785333;5343.30537030186;5348.572114230862;5362.785488580462;5376.462353764621;5394.406615272317;5243.292155558998;5293.550048245904;5313.38896026957;5371.677699338043;5393.298871146755;4811.25425559038;4841.515848415148;4900.730459824708;4914.238293064581;4949.257611358289;614.8911925879177;4862.100511405401;4865.537773911473;4895.55939965403;4907.11671899058;4856.878578035559;4859.979404325096;4863.537963893442;4878.829240976549;4916.50834916509;4782.713037217778;4838.85483435494;4930.2851086592245;4950.3069570260195;4995.250712393134;4833.975830120827;4862.78117484714;4878.487758785312;4880.585150262232;4906.092372911023;5236.764345604457;5240.711760853152;5253.343332083489;5269.973650131725;5327.706976116312;5489.6980666063355;5609.270794796691;5660.066089095294;5668.234788303567;5669.291338582677;5557.1108622620595;5596.048671725816;5627.099664053731;5632;5680.261565996394;5248.343957005374;5252.395974462947;5254.6847189168775;5266.710330931797;5310;5726.055200891807;5745;5768.826935191951;5830.650160990354;5892.145638882424;5628.943710562924;5631.18347839561;5636.689982050944;5638.295213098363;5639.097744360883;5675.858103547444;5708.20085188074;5709.486146246858;5713.942860571424;5717.456841600041;5529.142982837667;5643.604947653625;5652.265205523256;5746.597738158289;5774.48029677331;5567.415421380778;5641.097424412074;5663.207150998864;5680.176374425768;5745.2818397700285;4274.08107256935;4307.8492252771;4315.762633055149;4317.330813723878;4358.956410435855;3802.7528210666774;3812.3519001769764;3838.481804956351;3842.7104886200905;3875.6318149775725;5402.837914862561;5421.891562168814;5448.046591846411;5451.672899626035;5462.672239665632;5666.206731057655;5704.971475142598;5725.51333136688;5728.684922329228;5732.942670573324;5340.706261155596;5374.086405311106;5446.591505637093;5474.808381706621;5505.119180931032;4861.9027619447415;4870.780814863339;4883.755812209375;4887.486813884491;4912.38595175603;5810.070388737781;5833.533317334603;5836.037053886062;5838.4453476919625;5847.064469684915;5699.5725320600295;5700.657960522382;5711;5741.052726300114;5746.683932383676;5808.854778630568;5830.62100963436;5855.238818953509;5866.120081987736;5879.676617785892;5527.115661494142;5555.944440555704;5584;5590.357108932362;5638.097904335451;5665.263515742927;5666.631668941505;5674.602777805514;5677.886442271214;5721.7425215866215;5502.9174562382395;5507.7246137693755;5511.614187007031;5515.172724091258;5521.199426083276;5436.184572314184;5511.090670039559;5514.420985796433;5569.777208911598;5586.469285417878;5276.920846187233;5449.945500545103;5451.700156491431;5502.504774570308;5505.201745746925;5481.205225242397;5486.451354864482;5510.173473978935;5512;5531.391546929754;5410.053240682943;5465.535429488379;5478.972605136949;5483.616146869681;5555.472230138131 05:31:50 INFO - PROCESS | 3499 | |1;ext.html;569.6382796923955;628.2053202698586;636.3223167326796;642.2100815996324;665.4875745675832;36282.27435451293;36925.44611830818;37092;37266;37287.25425491492;37363.43954840673;38066.23867522648;38089.23821523568;38153.42769858454;38161.80919095401;8380.539070351128;8554.657813687445;8562.315014798833;8579.013413457438;8590.742277731646;8631;8758.693445729401;8789.384743067987;8796.42823216492;8833.911660883374;8823.250023747989;8826.514541700237;8865.246454051414;8899.065598112202;8901.154390332907;8766.342524310703;8825.823483530325;8833.646654133827;8833.734987950373;8861.911380886173;8464.365172612017;8603.913960860436;8678.522681252529;8693.13068693132;8698.913010869874;29204.707952920624;39035.60964390348;39402.80298598488;39507.60492395068;39548.406773898416;3335.3329334133027;3415.829208539588;3615.7107431405425;3942.1130245694776;4090.979545102285;28060.719392806015;28450.288742781388;30463.543046854316;30533.847330763427;31184;4098.877033688994;4170.291050521389;4185.183889141618;4200.075983283673;4224.112936283384;223110;224276;225917;226226;226709;34341.31317373639;34385.48421773675;34417.13957151041;34582.654173458446;34622.13444663904;35748.642513575054;56380.15429768557;57129.714351427974;57423;57705.71147144237;15604.14177220241;15636.609084772972;15675.294611742498;15800.841991579937;15809.209539522977;11874.406279686154;11907.285562866256;11978;12022.218555793845;12033.759324813454;18438.815611843977;18563.16465759044;18634.440966771017;18654.906725466284;18673.15970781291;6917.965410172917;6920.550164239308;6926.722931082701;6994.775914214992;7283.890741638879;1000.7698229407277;1048.757774800932;1084.219362059316;1124.9775004499863;1202.537023246039;30845.691543084282;30889;30902.227444313623;31213.375732485678;31322.530162047588;1121.394446998628;1149.9022583080364;1156.8553930758655;1162.7441962768178;1256.9622911312674;16261.51215463538;16524.25640846165;16568.66862662764;16618.75071873923;17011.829881701273;371460;373416;373690;375522;376739;56033.159502607494;57576;57818;57922;57975.420245797;1357.4163109862855;1381.3300549233613;1395.1629022586367;1396.7765157574738;1530.739774238382;29988.70011299859;30048.69951300459;30121.548176777804;30564.694353056184;31426.685733142374;53750;54595.72702136464;54689;54896;54972.725136374065;314514;324245;324818;325746;326517;42821.571784283005;43541.56458435375;43827.56172438235;43858.122837543706;44447;47759.5224047769;48034;48183.27725084056;49146.26280605865;49290.507094928595;39811;41200;41614.791926041384;41961.160776784905;41992.11035503349;39187.80406097951;40625.79687101545;41146.58853411547;41213.58786412217;41809.581904180566;37368.62631373652;37904.810475947445;38073.42889856599;38236;40066.1986760269;30410.847945760128;32906.341873161924;32947.835260823544;33262.168445788084;33661.49507757435;25026.37434064163;25423.36441588975;26940.461190775684;27631.171064868086;27946.44107117887 05:31:50 INFO - PROCESS | 3499 | |2;jquery.html;389.2429225157069;392.91552316252;394.4576207714393;396.855147871027;403.76581582682047;14046.508372206974;16816.24326905289;16910.74633880493;17437.7384339235;17474;17352.392666256685;17377.826221737778;17712.734308985342;18030.819691803077;18080.728789068173;5421.484958928895;5487.890242195153;5661.2357331760095;5703.916255911364;5725.513331366838;5602.495775380215;5628.634138780986;5661.094224924013;5692.487676109149;5697.316322041361;5287.233351164079;5557;5580.888382232353;5607.775688972436;5661.150827375906;5379.865503362447;5536.557075433976;5559.054960656698;5605.663660180382;5777.364489906107;5539.778408863641;5549.334079910436;5554.944560533526;5568.49883510482;5593.328800543961;12452.626421207378;13377;21010.474738131517;21080;21090.261840835497;2104.5580428110115;2193.607059517218;2272.329662749493;2349.7180338359335;2373.2524254859663;8967.103289671046;9817.410955342702;9852.162566181883;12080.637580872588;13754.243516606582;1953.9609207815906;2038.775734669185;2042.3260324093014;2045.4681782736448;2045.509077821312;68826;71947.28052719458;72666.273337267;73108.63445682738;73334.63332683356;10159.187265018929;10305.948470257601;10391.324563903474;10531;10693.518791654395;12445.315507647167;14039.157650541;14070.296485175904;14082.71834563303;27374.863125684642;9059.411138276122;9118.635254589875;9328.580213890391;9450.905490945002;9596.520173991412;7593.620318984029;7626.313631773167;7739.071311442663;7928.365730741527;7939.444238903337;8269.338452923752;8288.50268983863;8717.433366831136;8774.385792994557;8794.60424280909;3261.157181585344;3521.1725244567506;3546.556680414948;3548.6806187443253;3603.5586015355275;934.5374039850182;989.3569180033036;1011.438651548383;1013.7921726046143;1096.9286996345213;15647.374105035899;17593.7360939586;17685.557861053578;17806.427130560005;18190.5452363692;1011.1910471622673;1014.3356101753363;1044.8850626431085;1053.5575058475458;1085.2728671789919;9953.054459826304;10285.43430111336;10379.429131397694;10391.740206494898;10625;525450;542927;549386;554471;559612;77411;79234;79791.20208797838;80285.59857200793;82066.58966705129;1053;1060.81966065769;1078.5200585739428;1086.1582273737758;1088.1675518228562;16270.593235169215;16361.918190408971;16366;16512.25694843711;16698.666026679155;36287.637123628425;37580;37864.242715146094;37993.4300985491;38808.835734928;47427;51869.7406512965;51915;51966.22050669167;52134;8103.635336409758;8120.660091084905;8366.33069354438;8382.371322150984;8536.957315213633;10916;12809;12898.61304160839;12962.740745185232;13341.66645833862;11266.549338026714;11266.83099753488;11361.318320900773;11393.088552915913;11493.367864767519;11089.556417743523;11182.888171118184;11267.211295209258;11454.370009649216;11587.884121159017;8581.699640512552;11345.659630211107;11571.826422603835;11583.362915039754;11608.30350178992;8212.46618969765;8243;8268.214519620626;8344.290735287326;8423.115572865006;8260.421770476249;8269.710560130367;8353.916460835557;8603.655853765778;8654.740357789276 05:31:50 INFO - PROCESS | 3499 | |3;mootools.html;1478.1279045363233;1503.2033022498076;1516.37828490319;1584.6355338272197;1655.6771429571238;7295.30694584015;7660.616969151541;7867.25261100196;7980.9600951995235;8023;7861.960690196555;7903.1701671324545;7966.362690984722;7979.880301795478;7981.042274927002;2194.2868567715436;2247.797698207161;2250.9437264068365;2253.7971582557566;2254.402583315423;2191.901364438596;2215.523662412581;2253.9887300563555;2263.6265016272296;2267.1498188179435;2212.933611991643;2242.1143648258926;2244.259394399852;2245.8091062259728;2271.7841805028497;2134.061013154215;2135.8077773000427;2147.860389074705;2148.0870629982196;2160.157538559963;2152.1499007891953;2206.1285792112185;2210.292706333974;2214.944626384337;2224.6218142915745;8107.756767296991;8108.06757222921;8125.3499720022255;8132.552709600969;8172;4729.905401891943;4881.902361952777;4885.755712214411;4908.263760435928;4923.556879880792;3029.182120827364;3113.9195372699614;3230.370077834823;3254.056323666134;3260.9673903261137;1057;1097.983530247047;1105.8341248812662;1123.690984979129;1125.6679279612451;10901.236913416064;10909.454527273605;10953.616623418222;10969.616063437741;11042.889571104266;4279.144171165779;4280.571942805695;4390.034192477649;4399.692021558524;4412.0734645724115;9423.764405889771;9451.810963780687;9508.144267016001;9512.191463725523;9520.23838092951;4768.499307572724;4809.927851082237;4812.879678008007;4824.107540105092;4830.130576496264;4028.9798551007057;4339.522652508222;4436.778161091933;4447.577480139382;4502.16709908668;3547.6629720176543;3623.7825730456257;3650.415933450688;3650.762700424464;3679.5216621839527;1189.5717541684987;1199.9700007499882;1213.7208442058377;1214.1561614677892;1219.2745316536823;969.3699095587783;977.8386566216494;978.7259567321162;993.7813680990171;1012.8581998520214;5503.422140675251;5639.689817060019;5719.056355701263;5774.653520788766;5788.681622510802;441.9845305414295;449.24975291263013;453.21141214287564;456.28737157598425;466.6430180911605;3930.76415415076;3948.2103579283685;3975.5030621172355;3997.060690737674;4023.2556976959354;9455.621775129055;9732.562034708455;9733.951330243304;9744.464054477072;9793.167580755715;9687.903120968842;9689.27330450219;9722.416655000723;9802.215822734164;9831.262655300881;7339.155997060407;7536.397088232929;7582.772516824394;7599.164091949881;7664.923350766421;5628.85927851807;5674.829755107354;5796.76812927495;5869.970650146893;5871;8869.423487473552;8980.775480613036;9011.819763604823;9098.818023639622;9116.270698343984;8866.512341821262;9111.681091161778;9125.954370228106;9216.308776841897;9278.164965153168;6405.103285539935;6782.355676210949;6892.138482689664;6940.548864323803;7089.964550177217;7825.530468171928;7905.407094467823;7956.323712484504;7960.283574478325;7971.561564114029;7020.192677841909;7220.494565380373;7263.782086537412;7376.188619251985;7379.631018449163;7120.857582848417;7171.856562868609;7218;7228.277172282729;7300.306470885257;6564.113844631104;6789.321067893368;6800.5239633227175;6802;6802.319768023158;4969.701817890938;5094;5123;5126.718030508208;5136.486351364833;5117.437081920912;5133.101707201299;5133.845984620468;5167.870803229949;5202.453742357149 05:31:50 INFO - PROCESS | 3499 | |4;prototype.html;306.40098607222893;314.6413089078451;322.50978512660754;322.72729543535706;323.622979229198;5371.8450533135365;5483.8080667176655;5520.116781314985;5641.323041235052;5658.321001479823;5508.283923090003;5512.5589952803775;5561.555075593953;5569.136783798518;5570.2480165177685;4306.935395969063;4323.156984388045;4328.523862375144;4328.9783551082355;4333.436653235075;4180.080382315886;4326.123128119797;4335.699290212923;4342.782860856961;4370.934435983463;4258.978705106486;4291.742495450268;4297.59172878576;4324.978375108136;4331.610155086041;4291.592298731615;4321.546237645033;4330.501992270882;4331.458567679025;4345.717528360647;3700.5644083684024;3814.5803961564206;3823.694104471663;3827.234553089393;3848.2303539291975;5350.518453339179;5397.595180361449;5404.945950540484;5405.891882162374;5409.404965453797;4883.218685010417;4902.3626928499425;4922.5724539883395;4946.851594452172;4947.134251505972;5622.184783206453;5733.741981610838;5814.215080964101;5843.444872737083;5847.707614619295;4101.323281658522;4115.8765237042935;4135.60711732385;4138.110306284133;4148.668106551499;6098.512119030467;6104.481119104881;6115.449609535163;6143.508519318444;6151.2618485781995;4115.156392939441;4231.894202644959;4238.597333253336;4258.871399079247;4313.4823821141035;4345.196138714348;4346.195953748566;4363.52001279859;4372.475302963665;4372.9125417492105;4956.603471722254;4959.727215003138;4963.975180124076;4967.90064198714;4991.675541089818;5308.522232999048;5749.425057494217;5829.8251052468495;5897.144913987448;5916.26046744157;1539.5612250508552;1539.8152221733465;1544.065840166683;1554.2073542493183;1554.8833837462237;1040.2926010312908;1057.9735506612396;1059.1526778577108;1064.3454275620593;1068.3002633275216;5964.970175149097;5975.760969561169;5996.100584912211;5996.910046349309;6020.57855950088;6322.936770632326;6349.111124442582;6359.459445947054;6373.872522549523;6375.458086062737;5828.358880523139;5933.169356290123;5986.431289027535;5993.280806303272;6021;3393.7115345195443;3405.4210784166753;3421.1105112670884;3444.50054742066;3454.5681789776277;6497.545171837926;6610.0745895574655;6654.837177917197;6671.199456065303;6675.766348177791;6517.185351831021;6525.64108974011;6528.543001989815;6554.279029306773;6562.80311590653;6016.09758536223;6315.347554027319;6571.967140164268;6627.403533681992;6739.663016849138;6052.878942421039;6058.394160583906;6061.636301821904;6098.695065246631;6099.451049405575;5942.702864856654;5954.374790647093;5961.612495187799;5964.105384192406;5991.7902873399225;5986.132010858489;6260.624362538262;6306.621602703853;6306.653134077486;6325.019621958604;4202.222588821078;4204.369344598213;4227.42929704486;4239.300515415045;4249.681273904408;5829.7085145743395;6046.486048685911;6052;6072.14799486161;6095.817125486243;5767.221425107557;5862.149988251595;5902.704864756831;5903.970480147572;5909.70451477433;5883.529317654492;5888.705564721661;5931;5932.199153114274;5952.940470595238;5606.915896261477;5756.165356023437;5793.91309130355;5814.215080964185;5839.766409343579;5858.736356863866;5870.9412905870395;5907.616004959664;5933;5998.910016349845;5623.240862483676;5646.71766411686;5781.537477001746;5788.855278618068;5802.1296805479515 05:31:50 INFO - PROCESS | 3499 | |5;yui.html;767.7197822794682;772.783620586236;816.6488409983707;851.7146755836797;876.3120950054209;13559.25424101674;13886;15622.609434764137;16587.751183732224;16629.50111496654;15398.538043858674;15434;15456;15460.072395656269;15529.53411397657;666.969986350613;814.5601375257369;817.824167803922;819.9918000819976;822.1326500541926;794;814.0394334685069;814.1248158229927;815.8776183572452;815.955122468264;851.748734123432;853.4708480741949;854.7350321400355;855.9743207703748;856.6102423397339;846.843333983212;851.2338894994492;851.2721623012328;851.2764150472111;853.5134973065356;620.2247191011236;621.3848290192722;621.4810633121349;621.8787336469345;624.2072567838819;14965;15038.398464061424;15109.39562417502;15134.243287835565;15150.16674082925;13639.181649101085;13709.725805483835;13780.724385512234;13863.306834658226;13914.652133696638;11228.66314010581;11322.547098116065;11342.092632589372;11452.312861228269;11586.131040171937;3763.717721170896;3778.471014058034;3784.280986612562;3841.7118716096124;3897.629725176132;59506;60293;60874.69562652203;60965;61239;10504.317219380868;10685.465726713634;10695.572177112985;10900.618478353219;10936.617218397478;18985.62028759417;19103.331383401513;19130;19133.904330478257;19146.617067658568;8088.393370497119;8096.311813495919;8353.95823020881;8434;8434.451760635538;4647.3029045643425;4712.010477799632;4723.220668589713;4813.807447702053;4835.419749630067;3128.530720391959;3186.8725250990165;3203.0070678089864;3219.9839000804845;3242.2866969266724;585.9765609375662;607.8176547035872;610.3164455809522;610.951123910095;618.3970628637043;702.9156501219886;730.7807657702668;752.8268498245434;757.9393648508106;761.3224230434918;9171.174594286545;9695.806083878424;9745.951270243746;9999;10028.247881408777;699.6222040098392;766.1457474915429;770.3952397368039;772.6716145638081;799.9360051196006;4167.249895018926;4345.082842735413;4643.094596553708;4653.302004699254;4724.88187795301;66492;66808.66595667088;67470;68454.31545684578;68600.6569967147;56626;59156.40843591509;59322.40677593255;60091.699541502014;60537.69731151316;54079.72960135174;54736.17895731567;55014.17478737822;55039.44960550423;55398.44601553933;8718.389712720049;9072.455652660861;9073.548232282803;9075.546222688707;9116.680916167903;34779.82610086934;34850.47724284087;35058.82470587631;35304.64695353014;35417.29165416729;47637.76181119072;48418.273725893436;48588.2711759331;49233.507664922894;49439;11464.770704585695;11572.18994670365;11612.941935290608;11647.359395233343;11751.588694395656;11976;12762.553310634083;12794.808077879026;13167.341632918124;13224.801627975396;10892.40091794959;11613.76772464563;11836.881631183922;12544.811827822408;12727.554535591209;12190.268583884996;12348.506059757869;12400.31798251105;12423.37883105823;13019.869801301866;11676.182667213214;12017.355961992529;12315.938420308199;12342.75314493687;12951.805722913976;9957.103860652576;10432.530536125741;10623.787524249627;10770.784584308427;10924.945375273073;10271;10292.382457052601;10372.636957706443;10386.272960892666;10418.062374386342 05:31:50 INFO - PROCESS | 3499 | __end_tp_report 05:31:50 INFO - PROCESS | 3499 | __start_cc_report 05:31:50 INFO - PROCESS | 3499 | _x_x_mozilla_cycle_collect,347 05:31:50 INFO - PROCESS | 3499 | __end_cc_report 05:31:50 INFO - PROCESS | 3499 | __startTimestamp1461846710948__endTimestamp 05:31:50 INFO - PROCESS | 3499 | 05:31:50 INFO - PROCESS | 3499 | ------- Summary: start ------- 05:31:50 INFO - PROCESS | 3499 | Number of tests: 6 05:31:50 INFO - PROCESS | 3499 | 05:31:50 INFO - PROCESS | 3499 | [#0] dojo.html Cycles:165 Average:5252.79 Median:5486.45 stddev:688.62 (12.6%) stddev-sans-first:669.78 05:31:50 INFO - PROCESS | 3499 | Values: 3103.9 3120.5 3137.7 3149.2 3173.2 5343.3 5348.6 5362.8 5376.5 5394.4 5243.3 5293.6 5313.4 5371.7 5393.3 4811.3 4841.5 4900.7 4914.2 4949.3 614.9 4862.1 4865.5 4895.6 4907.1 4856.9 4860.0 4863.5 4878.8 4916.5 4782.7 4838.9 4930.3 4950.3 4995.3 4834.0 4862.8 4878.5 4880.6 4906.1 5236.8 5240.7 5253.3 5270.0 5327.7 5489.7 5609.3 5660.1 5668.2 5669.3 5557.1 5596.0 5627.1 5632.0 5680.3 5248.3 5252.4 5254.7 5266.7 5310.0 5726.1 5745.0 5768.8 5830.7 5892.1 5628.9 5631.2 5636.7 5638.3 5639.1 5675.9 5708.2 5709.5 5713.9 5717.5 5529.1 5643.6 5652.3 5746.6 5774.5 5567.4 5641.1 5663.2 5680.2 5745.3 4274.1 4307.8 4315.8 4317.3 4359.0 3802.8 3812.4 3838.5 3842.7 3875.6 5402.8 5421.9 5448.0 5451.7 5462.7 5666.2 5705.0 5725.5 5728.7 5732.9 5340.7 5374.1 5446.6 5474.8 5505.1 4861.9 4870.8 4883.8 4887.5 4912.4 5810.1 5833.5 5836.0 5838.4 5847.1 5699.6 5700.7 5711.0 5741.1 5746.7 5808.9 5830.6 5855.2 5866.1 5879.7 5527.1 5555.9 5584.0 5590.4 5638.1 5665.3 5666.6 5674.6 5677.9 5721.7 5502.9 5507.7 5511.6 5515.2 5521.2 5436.2 5511.1 5514.4 5569.8 5586.5 5276.9 5449.9 5451.7 5502.5 5505.2 5481.2 5486.5 5510.2 5512.0 5531.4 5410.1 5465.5 5479.0 5483.6 5555.5 05:31:50 INFO - PROCESS | 3499 | 05:31:50 INFO - PROCESS | 3499 | [#1] ext.html Cycles:180 Average:47859.59 Median:376130.50 stddev:82290.65 (21.9%) stddev-sans-first:82444.90 05:31:50 INFO - PROCESS | 3499 | Values: 569.6 628.2 636.3 642.2 665.5 36282.3 36925.4 37092.0 37266.0 37287.3 37363.4 38066.2 38089.2 38153.4 38161.8 8380.5 8554.7 8562.3 8579.0 8590.7 8631.0 8758.7 8789.4 8796.4 8833.9 8823.3 8826.5 8865.2 8899.1 8901.2 8766.3 8825.8 8833.6 8833.7 8861.9 8464.4 8603.9 8678.5 8693.1 8698.9 29204.7 39035.6 39402.8 39507.6 39548.4 3335.3 3415.8 3615.7 3942.1 4091.0 28060.7 28450.3 30463.5 30533.8 31184.0 4098.9 4170.3 4185.2 4200.1 4224.1 223110.0 224276.0 225917.0 226226.0 226709.0 34341.3 34385.5 34417.1 34582.7 34622.1 35748.6 56380.2 57129.7 57423.0 57705.7 15604.1 15636.6 15675.3 15800.8 15809.2 11874.4 11907.3 11978.0 12022.2 12033.8 18438.8 18563.2 18634.4 18654.9 18673.2 6918.0 6920.6 6926.7 6994.8 7283.9 1000.8 1048.8 1084.2 1125.0 1202.5 30845.7 30889.0 30902.2 31213.4 31322.5 1121.4 1149.9 1156.9 1162.7 1257.0 16261.5 16524.3 16568.7 16618.8 17011.8 371460.0 373416.0 373690.0 375522.0 376739.0 56033.2 57576.0 57818.0 57922.0 57975.4 1357.4 1381.3 1395.2 1396.8 1530.7 29988.7 30048.7 30121.5 30564.7 31426.7 53750.0 54595.7 54689.0 54896.0 54972.7 314514.0 324245.0 324818.0 325746.0 326517.0 42821.6 43541.6 43827.6 43858.1 44447.0 47759.5 48034.0 48183.3 49146.3 49290.5 39811.0 41200.0 41614.8 41961.2 41992.1 39187.8 40625.8 41146.6 41213.6 41809.6 37368.6 37904.8 38073.4 38236.0 40066.2 30410.8 32906.3 32947.8 33262.2 33661.5 25026.4 25423.4 26940.5 27631.2 27946.4 05:31:50 INFO - PROCESS | 3499 | 05:31:50 INFO - PROCESS | 3499 | [#2] jquery.html Cycles:180 Average:29357.98 Median:37928.84 stddev:89456.85 (235.9%) stddev-sans-first:89681.35 05:31:50 INFO - PROCESS | 3499 | Values: 389.2 392.9 394.5 396.9 403.8 14046.5 16816.2 16910.7 17437.7 17474.0 17352.4 17377.8 17712.7 18030.8 18080.7 5421.5 5487.9 5661.2 5703.9 5725.5 5602.5 5628.6 5661.1 5692.5 5697.3 5287.2 5557.0 5580.9 5607.8 5661.2 5379.9 5536.6 5559.1 5605.7 5777.4 5539.8 5549.3 5554.9 5568.5 5593.3 12452.6 13377.0 21010.5 21080.0 21090.3 2104.6 2193.6 2272.3 2349.7 2373.3 8967.1 9817.4 9852.2 12080.6 13754.2 1954.0 2038.8 2042.3 2045.5 2045.5 68826.0 71947.3 72666.3 73108.6 73334.6 10159.2 10305.9 10391.3 10531.0 10693.5 12445.3 14039.2 14070.3 14082.7 27374.9 9059.4 9118.6 9328.6 9450.9 9596.5 7593.6 7626.3 7739.1 7928.4 7939.4 8269.3 8288.5 8717.4 8774.4 8794.6 3261.2 3521.2 3546.6 3548.7 3603.6 934.5 989.4 1011.4 1013.8 1096.9 15647.4 17593.7 17685.6 17806.4 18190.5 1011.2 1014.3 1044.9 1053.6 1085.3 9953.1 10285.4 10379.4 10391.7 10625.0 525450.0 542927.0 549386.0 554471.0 559612.0 77411.0 79234.0 79791.2 80285.6 82066.6 1053.0 1060.8 1078.5 1086.2 1088.2 16270.6 16361.9 16366.0 16512.3 16698.7 36287.6 37580.0 37864.2 37993.4 38808.8 47427.0 51869.7 51915.0 51966.2 52134.0 8103.6 8120.7 8366.3 8382.4 8537.0 10916.0 12809.0 12898.6 12962.7 13341.7 11266.5 11266.8 11361.3 11393.1 11493.4 11089.6 11182.9 11267.2 11454.4 11587.9 8581.7 11345.7 11571.8 11583.4 11608.3 8212.5 8243.0 8268.2 8344.3 8423.1 8260.4 8269.7 8353.9 8603.7 8654.7 05:31:50 INFO - PROCESS | 3499 | 05:31:50 INFO - PROCESS | 3499 | [#3] mootools.html Cycles:180 Average:5349.13 Median:5129.91 stddev:2951.59 (57.5%) stddev-sans-first:2945.53 05:31:50 INFO - PROCESS | 3499 | Values: 1478.1 1503.2 1516.4 1584.6 1655.7 7295.3 7660.6 7867.3 7981.0 8023.0 7862.0 7903.2 7966.4 7979.9 7981.0 2194.3 2247.8 2250.9 2253.8 2254.4 2191.9 2215.5 2254.0 2263.6 2267.1 2212.9 2242.1 2244.3 2245.8 2271.8 2134.1 2135.8 2147.9 2148.1 2160.2 2152.1 2206.1 2210.3 2214.9 2224.6 8107.8 8108.1 8125.3 8132.6 8172.0 4729.9 4881.9 4885.8 4908.3 4923.6 3029.2 3113.9 3230.4 3254.1 3261.0 1057.0 1098.0 1105.8 1123.7 1125.7 10901.2 10909.5 10953.6 10969.6 11042.9 4279.1 4280.6 4390.0 4399.7 4412.1 9423.8 9451.8 9508.1 9512.2 9520.2 4768.5 4809.9 4812.9 4824.1 4830.1 4029.0 4339.5 4436.8 4447.6 4502.2 3547.7 3623.8 3650.4 3650.8 3679.5 1189.6 1200.0 1213.7 1214.2 1219.3 969.4 977.8 978.7 993.8 1012.9 5503.4 5639.7 5719.1 5774.7 5788.7 442.0 449.2 453.2 456.3 466.6 3930.8 3948.2 3975.5 3997.1 4023.3 9455.6 9732.6 9734.0 9744.5 9793.2 9687.9 9689.3 9722.4 9802.2 9831.3 7339.2 7536.4 7582.8 7599.2 7664.9 5628.9 5674.8 5796.8 5870.0 5871.0 8869.4 8980.8 9011.8 9098.8 9116.3 8866.5 9111.7 9126.0 9216.3 9278.2 6405.1 6782.4 6892.1 6940.5 7090.0 7825.5 7905.4 7956.3 7960.3 7971.6 7020.2 7220.5 7263.8 7376.2 7379.6 7120.9 7171.9 7218.0 7228.3 7300.3 6564.1 6789.3 6800.5 6802.0 6802.3 4969.7 5094.0 5123.0 5126.7 5136.5 5117.4 5133.1 5133.8 5167.9 5202.5 05:31:50 INFO - PROCESS | 3499 | 05:31:50 INFO - PROCESS | 3499 | [#4] prototype.html Cycles:180 Average:4993.01 Median:5622.71 stddev:1494.22 (26.6%) stddev-sans-first:1456.42 05:31:50 INFO - PROCESS | 3499 | Values: 306.4 314.6 322.5 322.7 323.6 5371.8 5483.8 5520.1 5641.3 5658.3 5508.3 5512.6 5561.6 5569.1 5570.2 4306.9 4323.2 4328.5 4329.0 4333.4 4180.1 4326.1 4335.7 4342.8 4370.9 4259.0 4291.7 4297.6 4325.0 4331.6 4291.6 4321.5 4330.5 4331.5 4345.7 3700.6 3814.6 3823.7 3827.2 3848.2 5350.5 5397.6 5404.9 5405.9 5409.4 4883.2 4902.4 4922.6 4946.9 4947.1 5622.2 5733.7 5814.2 5843.4 5847.7 4101.3 4115.9 4135.6 4138.1 4148.7 6098.5 6104.5 6115.4 6143.5 6151.3 4115.2 4231.9 4238.6 4258.9 4313.5 4345.2 4346.2 4363.5 4372.5 4372.9 4956.6 4959.7 4964.0 4967.9 4991.7 5308.5 5749.4 5829.8 5897.1 5916.3 1539.6 1539.8 1544.1 1554.2 1554.9 1040.3 1058.0 1059.2 1064.3 1068.3 5965.0 5975.8 5996.1 5996.9 6020.6 6322.9 6349.1 6359.5 6373.9 6375.5 5828.4 5933.2 5986.4 5993.3 6021.0 3393.7 3405.4 3421.1 3444.5 3454.6 6497.5 6610.1 6654.8 6671.2 6675.8 6517.2 6525.6 6528.5 6554.3 6562.8 6016.1 6315.3 6572.0 6627.4 6739.7 6052.9 6058.4 6061.6 6098.7 6099.5 5942.7 5954.4 5961.6 5964.1 5991.8 5986.1 6260.6 6306.6 6306.7 6325.0 4202.2 4204.4 4227.4 4239.3 4249.7 5829.7 6046.5 6052.0 6072.1 6095.8 5767.2 5862.1 5902.7 5904.0 5909.7 5883.5 5888.7 5931.0 5932.2 5952.9 5606.9 5756.2 5793.9 5814.2 5839.8 5858.7 5870.9 5907.6 5933.0 5998.9 5623.2 5646.7 5781.5 5788.9 5802.1 05:31:50 INFO - PROCESS | 3499 | 05:31:50 INFO - PROCESS | 3499 | [#5] yui.html Cycles:180 Average:15521.45 Median:4717.62 stddev:18652.23 (395.4%) stddev-sans-first:18671.65 05:31:50 INFO - PROCESS | 3499 | Values: 767.7 772.8 816.6 851.7 876.3 13559.3 13886.0 15622.6 16587.8 16629.5 15398.5 15434.0 15456.0 15460.1 15529.5 667.0 814.6 817.8 820.0 822.1 794.0 814.0 814.1 815.9 816.0 851.7 853.5 854.7 856.0 856.6 846.8 851.2 851.3 851.3 853.5 620.2 621.4 621.5 621.9 624.2 14965.0 15038.4 15109.4 15134.2 15150.2 13639.2 13709.7 13780.7 13863.3 13914.7 11228.7 11322.5 11342.1 11452.3 11586.1 3763.7 3778.5 3784.3 3841.7 3897.6 59506.0 60293.0 60874.7 60965.0 61239.0 10504.3 10685.5 10695.6 10900.6 10936.6 18985.6 19103.3 19130.0 19133.9 19146.6 8088.4 8096.3 8354.0 8434.0 8434.5 4647.3 4712.0 4723.2 4813.8 4835.4 3128.5 3186.9 3203.0 3220.0 3242.3 586.0 607.8 610.3 611.0 618.4 702.9 730.8 752.8 757.9 761.3 9171.2 9695.8 9746.0 9999.0 10028.2 699.6 766.1 770.4 772.7 799.9 4167.2 4345.1 4643.1 4653.3 4724.9 66492.0 66808.7 67470.0 68454.3 68600.7 56626.0 59156.4 59322.4 60091.7 60537.7 54079.7 54736.2 55014.2 55039.4 55398.4 8718.4 9072.5 9073.5 9075.5 9116.7 34779.8 34850.5 35058.8 35304.6 35417.3 47637.8 48418.3 48588.3 49233.5 49439.0 11464.8 11572.2 11612.9 11647.4 11751.6 11976.0 12762.6 12794.8 13167.3 13224.8 10892.4 11613.8 11836.9 12544.8 12727.6 12190.3 12348.5 12400.3 12423.4 13019.9 11676.2 12017.4 12315.9 12342.8 12951.8 9957.1 10432.5 10623.8 10770.8 10924.9 10271.0 10292.4 10372.6 10386.3 10418.1 05:31:50 INFO - PROCESS | 3499 | -------- Summary: end -------- 05:31:50 INFO - PROCESS | 3499 | 05:31:51 INFO - TEST-INFO | 3499: exit 0 05:31:51 INFO - TEST-OK | dromaeo_css | took 1112508ms 05:31:51 INFO - TEST-START | kraken 05:31:51 INFO - operating with platform_type : linux_ 05:31:51 INFO - Initialising browser for kraken test... 05:31:51 INFO - TEST-INFO | started process 3740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv34u1H/profile http://localhost:33467/getInfo.html) 05:31:55 INFO - PROCESS | 3740 | 05:31:55 INFO - PROCESS | 3740 | (process:3807): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:31:56 INFO - PROCESS | 3740 | __metrics Screen width/height:1600/1200 05:31:56 INFO - PROCESS | 3740 | colorDepth:24 05:31:56 INFO - PROCESS | 3740 | Browser inner width/height: 1024/697 05:31:56 INFO - PROCESS | 3740 | __metrics 05:31:57 ERROR - PROCESS | 3740 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:31:57 INFO - TEST-INFO | 3740: exit 0 05:31:57 INFO - Browser initialized. 05:31:57 INFO - Running cycle 1/1 for kraken test... 05:31:57 INFO - TEST-INFO | started process 3858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv34u1H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:59 INFO - PROCESS | 3858 | 05:31:59 INFO - PROCESS | 3858 | (process:3918): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:32:09 INFO - PROCESS | 3858 | RSS: Main: 164687872 05:32:09 INFO - PROCESS | 3858 | 05:32:12 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33467/tests/kraken/driver.html?testName=audio-beat-detection) 05:32:13 INFO - PROCESS | 3858 | RSS: Main: 169017344 05:32:13 INFO - PROCESS | 3858 | 05:32:15 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33467/tests/kraken/driver.html?testName=audio-dft) 05:32:16 INFO - PROCESS | 3858 | RSS: Main: 172974080 05:32:16 INFO - PROCESS | 3858 | 05:32:19 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33467/tests/kraken/driver.html?testName=audio-fft) 05:32:19 INFO - PROCESS | 3858 | RSS: Main: 163840000 05:32:19 INFO - PROCESS | 3858 | 05:32:21 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33467/tests/kraken/driver.html?testName=audio-oscillator) 05:32:22 INFO - PROCESS | 3858 | RSS: Main: 164503552 05:32:22 INFO - PROCESS | 3858 | 05:32:24 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33467/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:32:25 INFO - PROCESS | 3858 | RSS: Main: 165072896 05:32:25 INFO - PROCESS | 3858 | 05:32:28 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33467/tests/kraken/driver.html?testName=imaging-darkroom) 05:32:29 INFO - PROCESS | 3858 | RSS: Main: 165453824 05:32:29 INFO - PROCESS | 3858 | 05:32:32 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33467/tests/kraken/driver.html?testName=imaging-desaturate) 05:32:33 INFO - PROCESS | 3858 | RSS: Main: 165040128 05:32:33 INFO - PROCESS | 3858 | 05:32:35 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33467/tests/kraken/driver.html?testName=json-parse-financial) 05:32:36 INFO - PROCESS | 3858 | RSS: Main: 167690240 05:32:36 INFO - PROCESS | 3858 | 05:32:38 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33467/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:32:38 INFO - PROCESS | 3858 | RSS: Main: 167473152 05:32:38 INFO - PROCESS | 3858 | 05:32:40 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33467/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:32:41 INFO - PROCESS | 3858 | RSS: Main: 167636992 05:32:41 INFO - PROCESS | 3858 | 05:32:43 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33467/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:32:43 INFO - PROCESS | 3858 | RSS: Main: 168329216 05:32:43 INFO - PROCESS | 3858 | 05:32:46 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:32:47 INFO - PROCESS | 3858 | RSS: Main: 168808448 05:32:47 INFO - PROCESS | 3858 | 05:32:50 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:32:50 INFO - PROCESS | 3858 | RSS: Main: 168566784 05:32:50 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | Cycle 1(1): loaded http://localhost:33467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33467/tests/kraken/driver.html?testName=ai-astar) 05:32:52 INFO - PROCESS | 3858 | RSS: Main: 170102784 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | __start_tp_report 05:32:52 INFO - PROCESS | 3858 | _x_x_mozilla_page_load 05:32:52 INFO - PROCESS | 3858 | _x_x_mozilla_page_load_details 05:32:52 INFO - PROCESS | 3858 | |i|pagename|runs| 05:32:52 INFO - PROCESS | 3858 | |0;ai-astar;113;106;110;110;114;124;111;110;113;111 05:32:52 INFO - PROCESS | 3858 | |1;audio-beat-detection;153;134;154;183;136;156;156;139;196;132 05:32:52 INFO - PROCESS | 3858 | |2;audio-dft;162;161;162;162;161;163;168;162;163;164 05:32:52 INFO - PROCESS | 3858 | |3;audio-fft;77;75;73;149;76;76;73;76;160;74 05:32:52 INFO - PROCESS | 3858 | |4;audio-oscillator;92;93;154;93;93;94;148;94;93;147 05:32:52 INFO - PROCESS | 3858 | |5;imaging-gaussian-blur;121;118;118;117;117;117;117;118;118;117 05:32:52 INFO - PROCESS | 3858 | |6;imaging-darkroom;148;146;146;146;147;147;145;146;149;151 05:32:52 INFO - PROCESS | 3858 | |7;imaging-desaturate;95;96;96;95;95;95;95;95;95;95 05:32:52 INFO - PROCESS | 3858 | |8;json-parse-financial;58;58;59;58;57;65;58;77;56;54 05:32:52 INFO - PROCESS | 3858 | |9;json-stringify-tinderbox;60;69;61;61;62;62;61;60;61;64 05:32:52 INFO - PROCESS | 3858 | |10;stanford-crypto-aes;77;76;75;78;86;77;78;77;80;78 05:32:52 INFO - PROCESS | 3858 | |11;stanford-crypto-ccm;130;128;134;124;128;130;128;128;168;130 05:32:52 INFO - PROCESS | 3858 | |12;stanford-crypto-pbkdf2;192;196;195;193;198;197;193;193;195;201 05:32:52 INFO - PROCESS | 3858 | |13;stanford-crypto-sha256-iterative;71;69;68;72;71;72;68;68;69;75 05:32:52 INFO - PROCESS | 3858 | __end_tp_report 05:32:52 INFO - PROCESS | 3858 | __start_cc_report 05:32:52 INFO - PROCESS | 3858 | _x_x_mozilla_cycle_collect,845 05:32:52 INFO - PROCESS | 3858 | __end_cc_report 05:32:52 INFO - PROCESS | 3858 | __startTimestamp1461846772857__endTimestamp 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | ------- Summary: start ------- 05:32:52 INFO - PROCESS | 3858 | Number of tests: 14 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.71 (4.2%) stddev-sans-first:4.99 05:32:52 INFO - PROCESS | 3858 | Values: 113.0 106.0 110.0 110.0 114.0 124.0 111.0 110.0 113.0 111.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:155.00 stddev:21.21 (13.7%) stddev-sans-first:22.49 05:32:52 INFO - PROCESS | 3858 | Values: 153.0 134.0 154.0 183.0 136.0 156.0 156.0 139.0 196.0 132.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.04 (1.3%) stddev-sans-first:2.15 05:32:52 INFO - PROCESS | 3858 | Values: 162.0 161.0 162.0 162.0 161.0 163.0 168.0 162.0 163.0 164.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#3] audio-fft Cycles:10 Average:90.90 Median:75.50 stddev:33.65 (44.6%) stddev-sans-first:35.31 05:32:52 INFO - PROCESS | 3858 | Values: 77.0 75.0 73.0 149.0 76.0 76.0 73.0 76.0 160.0 74.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:27.37 (29.4%) stddev-sans-first:28.23 05:32:52 INFO - PROCESS | 3858 | Values: 92.0 93.0 154.0 93.0 93.0 94.0 148.0 94.0 93.0 147.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:0.53 05:32:52 INFO - PROCESS | 3858 | Values: 121.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.79 (1.2%) stddev-sans-first:1.87 05:32:52 INFO - PROCESS | 3858 | Values: 148.0 146.0 146.0 146.0 147.0 147.0 145.0 146.0 149.0 151.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:32:52 INFO - PROCESS | 3858 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:58.00 stddev:6.60 (11.4%) stddev-sans-first:6.96 05:32:52 INFO - PROCESS | 3858 | Values: 58.0 58.0 59.0 58.0 57.0 65.0 58.0 77.0 56.0 54.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:61.50 stddev:2.69 (4.4%) stddev-sans-first:2.74 05:32:52 INFO - PROCESS | 3858 | Values: 60.0 69.0 61.0 61.0 62.0 62.0 61.0 60.0 61.0 64.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:3.05 (3.9%) stddev-sans-first:3.20 05:32:52 INFO - PROCESS | 3858 | Values: 77.0 76.0 75.0 78.0 86.0 77.0 78.0 77.0 80.0 78.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:130.00 stddev:12.62 (9.7%) stddev-sans-first:13.35 05:32:52 INFO - PROCESS | 3858 | Values: 130.0 128.0 134.0 124.0 128.0 130.0 128.0 128.0 168.0 130.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.30 Median:195.50 stddev:2.79 (1.4%) stddev-sans-first:2.69 05:32:52 INFO - PROCESS | 3858 | Values: 192.0 196.0 195.0 193.0 198.0 197.0 193.0 193.0 195.0 201.0 05:32:52 INFO - PROCESS | 3858 | 05:32:52 INFO - PROCESS | 3858 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:71.00 stddev:2.31 (3.3%) stddev-sans-first:2.44 05:32:52 INFO - PROCESS | 3858 | Values: 71.0 69.0 68.0 72.0 71.0 72.0 68.0 68.0 69.0 75.0 05:32:52 INFO - PROCESS | 3858 | -------- Summary: end -------- 05:32:52 INFO - PROCESS | 3858 | 05:32:53 INFO - TEST-INFO | 3858: exit 0 05:32:53 INFO - TEST-OK | kraken | took 62109ms 05:32:53 INFO - SUITE-END | took 1174s 05:32:54 INFO - Completed test suite (00:19:34) 05:32:54 INFO - javascript benchmark 05:32:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.9224019399526, 3120.469520181569, 3137.70191831776, 3149.1654711501455, 3173.2384227785333, 5343.30537030186, 5348.572114230862, 5362.785488580462, 5376.462353764621, 5394.406615272317, 5243.292155558998, 5293.550048245904, 5313.38896026957, 5371.677699338043, 5393.298871146755, 4811.25425559038, 4841.515848415148, 4900.730459824708, 4914.238293064581, 4949.257611358289, 614.8911925879177, 4862.100511405401, 4865.537773911473, 4895.55939965403, 4907.11671899058, 4856.878578035559, 4859.979404325096, 4863.537963893442, 4878.829240976549, 4916.50834916509, 4782.713037217778, 4838.85483435494, 4930.2851086592245, 4950.3069570260195, 4995.250712393134, 4833.975830120827, 4862.78117484714, 4878.487758785312, 4880.585150262232, 4906.092372911023, 5236.764345604457, 5240.711760853152, 5253.343332083489, 5269.973650131725, 5327.706976116312, 5489.6980666063355, 5609.270794796691, 5660.066089095294, 5668.234788303567, 5669.291338582677, 5557.1108622620595, 5596.048671725816, 5627.099664053731, 5632.0, 5680.261565996394, 5248.343957005374, 5252.395974462947, 5254.6847189168775, 5266.710330931797, 5310.0, 5726.055200891807, 5745.0, 5768.826935191951, 5830.650160990354, 5892.145638882424, 5628.943710562924, 5631.18347839561, 5636.689982050944, 5638.295213098363, 5639.097744360883, 5675.858103547444, 5708.20085188074, 5709.486146246858, 5713.942860571424, 5717.456841600041, 5529.142982837667, 5643.604947653625, 5652.265205523256, 5746.597738158289, 5774.48029677331, 5567.415421380778, 5641.097424412074, 5663.207150998864, 5680.176374425768, 5745.2818397700285, 4274.08107256935, 4307.8492252771, 4315.762633055149, 4317.330813723878, 4358.956410435855, 3802.7528210666774, 3812.3519001769764, 3838.481804956351, 3842.7104886200905, 3875.6318149775725, 5402.837914862561, 5421.891562168814, 5448.046591846411, 5451.672899626035, 5462.672239665632, 5666.206731057655, 5704.971475142598, 5725.51333136688, 5728.684922329228, 5732.942670573324, 5340.706261155596, 5374.086405311106, 5446.591505637093, 5474.808381706621, 5505.119180931032, 4861.9027619447415, 4870.780814863339, 4883.755812209375, 4887.486813884491, 4912.38595175603, 5810.070388737781, 5833.533317334603, 5836.037053886062, 5838.4453476919625, 5847.064469684915, 5699.5725320600295, 5700.657960522382, 5711.0, 5741.052726300114, 5746.683932383676, 5808.854778630568, 5830.62100963436, 5855.238818953509, 5866.120081987736, 5879.676617785892, 5527.115661494142, 5555.944440555704, 5584.0, 5590.357108932362, 5638.097904335451, 5665.263515742927, 5666.631668941505, 5674.602777805514, 5677.886442271214, 5721.7425215866215, 5502.9174562382395, 5507.7246137693755, 5511.614187007031, 5515.172724091258, 5521.199426083276, 5436.184572314184, 5511.090670039559, 5514.420985796433, 5569.777208911598, 5586.469285417878, 5276.920846187233, 5449.945500545103, 5451.700156491431, 5502.504774570308, 5505.201745746925, 5481.205225242397, 5486.451354864482, 5510.173473978935, 5512.0, 5531.391546929754, 5410.053240682943, 5465.535429488379, 5478.972605136949, 5483.616146869681, 5555.472230138131], "value": 5209.544712808635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.6382796923955, 628.2053202698586, 636.3223167326796, 642.2100815996324, 665.4875745675832, 36282.27435451293, 36925.44611830818, 37092.0, 37266.0, 37287.25425491492, 37363.43954840673, 38066.23867522648, 38089.23821523568, 38153.42769858454, 38161.80919095401, 8380.539070351128, 8554.657813687445, 8562.315014798833, 8579.013413457438, 8590.742277731646, 8631.0, 8758.693445729401, 8789.384743067987, 8796.42823216492, 8833.911660883374, 8823.250023747989, 8826.514541700237, 8865.246454051414, 8899.065598112202, 8901.154390332907, 8766.342524310703, 8825.823483530325, 8833.646654133827, 8833.734987950373, 8861.911380886173, 8464.365172612017, 8603.913960860436, 8678.522681252529, 8693.13068693132, 8698.913010869874, 29204.707952920624, 39035.60964390348, 39402.80298598488, 39507.60492395068, 39548.406773898416, 3335.3329334133027, 3415.829208539588, 3615.7107431405425, 3942.1130245694776, 4090.979545102285, 28060.719392806015, 28450.288742781388, 30463.543046854316, 30533.847330763427, 31184.0, 4098.877033688994, 4170.291050521389, 4185.183889141618, 4200.075983283673, 4224.112936283384, 223110.0, 224276.0, 225917.0, 226226.0, 226709.0, 34341.31317373639, 34385.48421773675, 34417.13957151041, 34582.654173458446, 34622.13444663904, 35748.642513575054, 56380.15429768557, 57129.714351427974, 57423.0, 57705.71147144237, 15604.14177220241, 15636.609084772972, 15675.294611742498, 15800.841991579937, 15809.209539522977, 11874.406279686154, 11907.285562866256, 11978.0, 12022.218555793845, 12033.759324813454, 18438.815611843977, 18563.16465759044, 18634.440966771017, 18654.906725466284, 18673.15970781291, 6917.965410172917, 6920.550164239308, 6926.722931082701, 6994.775914214992, 7283.890741638879, 1000.7698229407277, 1048.757774800932, 1084.219362059316, 1124.9775004499863, 1202.537023246039, 30845.691543084282, 30889.0, 30902.227444313623, 31213.375732485678, 31322.530162047588, 1121.394446998628, 1149.9022583080364, 1156.8553930758655, 1162.7441962768178, 1256.9622911312674, 16261.51215463538, 16524.25640846165, 16568.66862662764, 16618.75071873923, 17011.829881701273, 371460.0, 373416.0, 373690.0, 375522.0, 376739.0, 56033.159502607494, 57576.0, 57818.0, 57922.0, 57975.420245797, 1357.4163109862855, 1381.3300549233613, 1395.1629022586367, 1396.7765157574738, 1530.739774238382, 29988.70011299859, 30048.69951300459, 30121.548176777804, 30564.694353056184, 31426.685733142374, 53750.0, 54595.72702136464, 54689.0, 54896.0, 54972.725136374065, 314514.0, 324245.0, 324818.0, 325746.0, 326517.0, 42821.571784283005, 43541.56458435375, 43827.56172438235, 43858.122837543706, 44447.0, 47759.5224047769, 48034.0, 48183.27725084056, 49146.26280605865, 49290.507094928595, 39811.0, 41200.0, 41614.791926041384, 41961.160776784905, 41992.11035503349, 39187.80406097951, 40625.79687101545, 41146.58853411547, 41213.58786412217, 41809.581904180566, 37368.62631373652, 37904.810475947445, 38073.42889856599, 38236.0, 40066.1986760269, 30410.847945760128, 32906.341873161924, 32947.835260823544, 33262.168445788084, 33661.49507757435, 25026.37434064163, 25423.36441588975, 26940.461190775684, 27631.171064868086, 27946.44107117887], "value": 18944.851088798117, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.2429225157069, 392.91552316252, 394.4576207714393, 396.855147871027, 403.76581582682047, 14046.508372206974, 16816.24326905289, 16910.74633880493, 17437.7384339235, 17474.0, 17352.392666256685, 17377.826221737778, 17712.734308985342, 18030.819691803077, 18080.728789068173, 5421.484958928895, 5487.890242195153, 5661.2357331760095, 5703.916255911364, 5725.513331366838, 5602.495775380215, 5628.634138780986, 5661.094224924013, 5692.487676109149, 5697.316322041361, 5287.233351164079, 5557.0, 5580.888382232353, 5607.775688972436, 5661.150827375906, 5379.865503362447, 5536.557075433976, 5559.054960656698, 5605.663660180382, 5777.364489906107, 5539.778408863641, 5549.334079910436, 5554.944560533526, 5568.49883510482, 5593.328800543961, 12452.626421207378, 13377.0, 21010.474738131517, 21080.0, 21090.261840835497, 2104.5580428110115, 2193.607059517218, 2272.329662749493, 2349.7180338359335, 2373.2524254859663, 8967.103289671046, 9817.410955342702, 9852.162566181883, 12080.637580872588, 13754.243516606582, 1953.9609207815906, 2038.775734669185, 2042.3260324093014, 2045.4681782736448, 2045.509077821312, 68826.0, 71947.28052719458, 72666.273337267, 73108.63445682738, 73334.63332683356, 10159.187265018929, 10305.948470257601, 10391.324563903474, 10531.0, 10693.518791654395, 12445.315507647167, 14039.157650541, 14070.296485175904, 14082.71834563303, 27374.863125684642, 9059.411138276122, 9118.635254589875, 9328.580213890391, 9450.905490945002, 9596.520173991412, 7593.620318984029, 7626.313631773167, 7739.071311442663, 7928.365730741527, 7939.444238903337, 8269.338452923752, 8288.50268983863, 8717.433366831136, 8774.385792994557, 8794.60424280909, 3261.157181585344, 3521.1725244567506, 3546.556680414948, 3548.6806187443253, 3603.5586015355275, 934.5374039850182, 989.3569180033036, 1011.438651548383, 1013.7921726046143, 1096.9286996345213, 15647.374105035899, 17593.7360939586, 17685.557861053578, 17806.427130560005, 18190.5452363692, 1011.1910471622673, 1014.3356101753363, 1044.8850626431085, 1053.5575058475458, 1085.2728671789919, 9953.054459826304, 10285.43430111336, 10379.429131397694, 10391.740206494898, 10625.0, 525450.0, 542927.0, 549386.0, 554471.0, 559612.0, 77411.0, 79234.0, 79791.20208797838, 80285.59857200793, 82066.58966705129, 1053.0, 1060.81966065769, 1078.5200585739428, 1086.1582273737758, 1088.1675518228562, 16270.593235169215, 16361.918190408971, 16366.0, 16512.25694843711, 16698.666026679155, 36287.637123628425, 37580.0, 37864.242715146094, 37993.4300985491, 38808.835734928, 47427.0, 51869.7406512965, 51915.0, 51966.22050669167, 52134.0, 8103.635336409758, 8120.660091084905, 8366.33069354438, 8382.371322150984, 8536.957315213633, 10916.0, 12809.0, 12898.61304160839, 12962.740745185232, 13341.66645833862, 11266.549338026714, 11266.83099753488, 11361.318320900773, 11393.088552915913, 11493.367864767519, 11089.556417743523, 11182.888171118184, 11267.211295209258, 11454.370009649216, 11587.884121159017, 8581.699640512552, 11345.659630211107, 11571.826422603835, 11583.362915039754, 11608.30350178992, 8212.46618969765, 8243.0, 8268.214519620626, 8344.290735287326, 8423.115572865006, 8260.421770476249, 8269.710560130367, 8353.916460835557, 8603.655853765778, 8654.740357789276], "value": 9162.77052571557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.1279045363233, 1503.2033022498076, 1516.37828490319, 1584.6355338272197, 1655.6771429571238, 7295.30694584015, 7660.616969151541, 7867.25261100196, 7980.9600951995235, 8023.0, 7861.960690196555, 7903.1701671324545, 7966.362690984722, 7979.880301795478, 7981.042274927002, 2194.2868567715436, 2247.797698207161, 2250.9437264068365, 2253.7971582557566, 2254.402583315423, 2191.901364438596, 2215.523662412581, 2253.9887300563555, 2263.6265016272296, 2267.1498188179435, 2212.933611991643, 2242.1143648258926, 2244.259394399852, 2245.8091062259728, 2271.7841805028497, 2134.061013154215, 2135.8077773000427, 2147.860389074705, 2148.0870629982196, 2160.157538559963, 2152.1499007891953, 2206.1285792112185, 2210.292706333974, 2214.944626384337, 2224.6218142915745, 8107.756767296991, 8108.06757222921, 8125.3499720022255, 8132.552709600969, 8172.0, 4729.905401891943, 4881.902361952777, 4885.755712214411, 4908.263760435928, 4923.556879880792, 3029.182120827364, 3113.9195372699614, 3230.370077834823, 3254.056323666134, 3260.9673903261137, 1057.0, 1097.983530247047, 1105.8341248812662, 1123.690984979129, 1125.6679279612451, 10901.236913416064, 10909.454527273605, 10953.616623418222, 10969.616063437741, 11042.889571104266, 4279.144171165779, 4280.571942805695, 4390.034192477649, 4399.692021558524, 4412.0734645724115, 9423.764405889771, 9451.810963780687, 9508.144267016001, 9512.191463725523, 9520.23838092951, 4768.499307572724, 4809.927851082237, 4812.879678008007, 4824.107540105092, 4830.130576496264, 4028.9798551007057, 4339.522652508222, 4436.778161091933, 4447.577480139382, 4502.16709908668, 3547.6629720176543, 3623.7825730456257, 3650.415933450688, 3650.762700424464, 3679.5216621839527, 1189.5717541684987, 1199.9700007499882, 1213.7208442058377, 1214.1561614677892, 1219.2745316536823, 969.3699095587783, 977.8386566216494, 978.7259567321162, 993.7813680990171, 1012.8581998520214, 5503.422140675251, 5639.689817060019, 5719.056355701263, 5774.653520788766, 5788.681622510802, 441.9845305414295, 449.24975291263013, 453.21141214287564, 456.28737157598425, 466.6430180911605, 3930.76415415076, 3948.2103579283685, 3975.5030621172355, 3997.060690737674, 4023.2556976959354, 9455.621775129055, 9732.562034708455, 9733.951330243304, 9744.464054477072, 9793.167580755715, 9687.903120968842, 9689.27330450219, 9722.416655000723, 9802.215822734164, 9831.262655300881, 7339.155997060407, 7536.397088232929, 7582.772516824394, 7599.164091949881, 7664.923350766421, 5628.85927851807, 5674.829755107354, 5796.76812927495, 5869.970650146893, 5871.0, 8869.423487473552, 8980.775480613036, 9011.819763604823, 9098.818023639622, 9116.270698343984, 8866.512341821262, 9111.681091161778, 9125.954370228106, 9216.308776841897, 9278.164965153168, 6405.103285539935, 6782.355676210949, 6892.138482689664, 6940.548864323803, 7089.964550177217, 7825.530468171928, 7905.407094467823, 7956.323712484504, 7960.283574478325, 7971.561564114029, 7020.192677841909, 7220.494565380373, 7263.782086537412, 7376.188619251985, 7379.631018449163, 7120.857582848417, 7171.856562868609, 7218.0, 7228.277172282729, 7300.306470885257, 6564.113844631104, 6789.321067893368, 6800.5239633227175, 6802.0, 6802.319768023158, 4969.701817890938, 5094.0, 5123.0, 5126.718030508208, 5136.486351364833, 5117.437081920912, 5133.101707201299, 5133.845984620468, 5167.870803229949, 5202.453742357149], "value": 4270.860130837782, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.40098607222893, 314.6413089078451, 322.50978512660754, 322.72729543535706, 323.622979229198, 5371.8450533135365, 5483.8080667176655, 5520.116781314985, 5641.323041235052, 5658.321001479823, 5508.283923090003, 5512.5589952803775, 5561.555075593953, 5569.136783798518, 5570.2480165177685, 4306.935395969063, 4323.156984388045, 4328.523862375144, 4328.9783551082355, 4333.436653235075, 4180.080382315886, 4326.123128119797, 4335.699290212923, 4342.782860856961, 4370.934435983463, 4258.978705106486, 4291.742495450268, 4297.59172878576, 4324.978375108136, 4331.610155086041, 4291.592298731615, 4321.546237645033, 4330.501992270882, 4331.458567679025, 4345.717528360647, 3700.5644083684024, 3814.5803961564206, 3823.694104471663, 3827.234553089393, 3848.2303539291975, 5350.518453339179, 5397.595180361449, 5404.945950540484, 5405.891882162374, 5409.404965453797, 4883.218685010417, 4902.3626928499425, 4922.5724539883395, 4946.851594452172, 4947.134251505972, 5622.184783206453, 5733.741981610838, 5814.215080964101, 5843.444872737083, 5847.707614619295, 4101.323281658522, 4115.8765237042935, 4135.60711732385, 4138.110306284133, 4148.668106551499, 6098.512119030467, 6104.481119104881, 6115.449609535163, 6143.508519318444, 6151.2618485781995, 4115.156392939441, 4231.894202644959, 4238.597333253336, 4258.871399079247, 4313.4823821141035, 4345.196138714348, 4346.195953748566, 4363.52001279859, 4372.475302963665, 4372.9125417492105, 4956.603471722254, 4959.727215003138, 4963.975180124076, 4967.90064198714, 4991.675541089818, 5308.522232999048, 5749.425057494217, 5829.8251052468495, 5897.144913987448, 5916.26046744157, 1539.5612250508552, 1539.8152221733465, 1544.065840166683, 1554.2073542493183, 1554.8833837462237, 1040.2926010312908, 1057.9735506612396, 1059.1526778577108, 1064.3454275620593, 1068.3002633275216, 5964.970175149097, 5975.760969561169, 5996.100584912211, 5996.910046349309, 6020.57855950088, 6322.936770632326, 6349.111124442582, 6359.459445947054, 6373.872522549523, 6375.458086062737, 5828.358880523139, 5933.169356290123, 5986.431289027535, 5993.280806303272, 6021.0, 3393.7115345195443, 3405.4210784166753, 3421.1105112670884, 3444.50054742066, 3454.5681789776277, 6497.545171837926, 6610.0745895574655, 6654.837177917197, 6671.199456065303, 6675.766348177791, 6517.185351831021, 6525.64108974011, 6528.543001989815, 6554.279029306773, 6562.80311590653, 6016.09758536223, 6315.347554027319, 6571.967140164268, 6627.403533681992, 6739.663016849138, 6052.878942421039, 6058.394160583906, 6061.636301821904, 6098.695065246631, 6099.451049405575, 5942.702864856654, 5954.374790647093, 5961.612495187799, 5964.105384192406, 5991.7902873399225, 5986.132010858489, 6260.624362538262, 6306.621602703853, 6306.653134077486, 6325.019621958604, 4202.222588821078, 4204.369344598213, 4227.42929704486, 4239.300515415045, 4249.681273904408, 5829.7085145743395, 6046.486048685911, 6052.0, 6072.14799486161, 6095.817125486243, 5767.221425107557, 5862.149988251595, 5902.704864756831, 5903.970480147572, 5909.70451477433, 5883.529317654492, 5888.705564721661, 5931.0, 5932.199153114274, 5952.940470595238, 5606.915896261477, 5756.165356023437, 5793.91309130355, 5814.215080964185, 5839.766409343579, 5858.736356863866, 5870.9412905870395, 5907.616004959664, 5933.0, 5998.910016349845, 5623.240862483676, 5646.71766411686, 5781.537477001746, 5788.855278618068, 5802.1296805479515], "value": 4512.860697680822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.7197822794682, 772.783620586236, 816.6488409983707, 851.7146755836797, 876.3120950054209, 13559.25424101674, 13886.0, 15622.609434764137, 16587.751183732224, 16629.50111496654, 15398.538043858674, 15434.0, 15456.0, 15460.072395656269, 15529.53411397657, 666.969986350613, 814.5601375257369, 817.824167803922, 819.9918000819976, 822.1326500541926, 794.0, 814.0394334685069, 814.1248158229927, 815.8776183572452, 815.955122468264, 851.748734123432, 853.4708480741949, 854.7350321400355, 855.9743207703748, 856.6102423397339, 846.843333983212, 851.2338894994492, 851.2721623012328, 851.2764150472111, 853.5134973065356, 620.2247191011236, 621.3848290192722, 621.4810633121349, 621.8787336469345, 624.2072567838819, 14965.0, 15038.398464061424, 15109.39562417502, 15134.243287835565, 15150.16674082925, 13639.181649101085, 13709.725805483835, 13780.724385512234, 13863.306834658226, 13914.652133696638, 11228.66314010581, 11322.547098116065, 11342.092632589372, 11452.312861228269, 11586.131040171937, 3763.717721170896, 3778.471014058034, 3784.280986612562, 3841.7118716096124, 3897.629725176132, 59506.0, 60293.0, 60874.69562652203, 60965.0, 61239.0, 10504.317219380868, 10685.465726713634, 10695.572177112985, 10900.618478353219, 10936.617218397478, 18985.62028759417, 19103.331383401513, 19130.0, 19133.904330478257, 19146.617067658568, 8088.393370497119, 8096.311813495919, 8353.95823020881, 8434.0, 8434.451760635538, 4647.3029045643425, 4712.010477799632, 4723.220668589713, 4813.807447702053, 4835.419749630067, 3128.530720391959, 3186.8725250990165, 3203.0070678089864, 3219.9839000804845, 3242.2866969266724, 585.9765609375662, 607.8176547035872, 610.3164455809522, 610.951123910095, 618.3970628637043, 702.9156501219886, 730.7807657702668, 752.8268498245434, 757.9393648508106, 761.3224230434918, 9171.174594286545, 9695.806083878424, 9745.951270243746, 9999.0, 10028.247881408777, 699.6222040098392, 766.1457474915429, 770.3952397368039, 772.6716145638081, 799.9360051196006, 4167.249895018926, 4345.082842735413, 4643.094596553708, 4653.302004699254, 4724.88187795301, 66492.0, 66808.66595667088, 67470.0, 68454.31545684578, 68600.6569967147, 56626.0, 59156.40843591509, 59322.40677593255, 60091.699541502014, 60537.69731151316, 54079.72960135174, 54736.17895731567, 55014.17478737822, 55039.44960550423, 55398.44601553933, 8718.389712720049, 9072.455652660861, 9073.548232282803, 9075.546222688707, 9116.680916167903, 34779.82610086934, 34850.47724284087, 35058.82470587631, 35304.64695353014, 35417.29165416729, 47637.76181119072, 48418.273725893436, 48588.2711759331, 49233.507664922894, 49439.0, 11464.770704585695, 11572.18994670365, 11612.941935290608, 11647.359395233343, 11751.588694395656, 11976.0, 12762.553310634083, 12794.808077879026, 13167.341632918124, 13224.801627975396, 10892.40091794959, 11613.76772464563, 11836.881631183922, 12544.811827822408, 12727.554535591209, 12190.268583884996, 12348.506059757869, 12400.31798251105, 12423.37883105823, 13019.869801301866, 11676.182667213214, 12017.355961992529, 12315.938420308199, 12342.75314493687, 12951.805722913976, 9957.103860652576, 10432.530536125741, 10623.787524249627, 10770.784584308427, 10924.945375273073, 10271.0, 10292.382457052601, 10372.636957706443, 10386.272960892666, 10418.062374386342], "value": 6844.9987772700815, "unit": "score"}], "name": "dromaeo_css", "value": 7016.443224959109, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 110.0, 110.0, 114.0, 124.0, 111.0, 110.0, 113.0, 111.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 134.0, 154.0, 183.0, 136.0, 156.0, 156.0, 139.0, 196.0, 132.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 161.0, 163.0, 168.0, 162.0, 163.0, 164.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 73.0, 149.0, 76.0, 76.0, 73.0, 76.0, 160.0, 74.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 154.0, 93.0, 93.0, 94.0, 148.0, 94.0, 93.0, 147.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0, 149.0, 151.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 58.0, 57.0, 65.0, 58.0, 77.0, 56.0, 54.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 69.0, 61.0, 61.0, 62.0, 62.0, 61.0, 60.0, 61.0, 64.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 78.0, 86.0, 77.0, 78.0, 77.0, 80.0, 78.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 128.0, 134.0, 124.0, 128.0, 130.0, 128.0, 128.0, 168.0, 130.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 196.0, 195.0, 193.0, 198.0, 197.0, 193.0, 193.0, 195.0, 201.0], "value": 195.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 68.0, 72.0, 71.0, 72.0, 68.0, 68.0, 69.0, 75.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1588.6999999999998, "alertThreshold": 2.0}]} 05:32:54 INFO - Return code: 0 05:32:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:32:54 ERROR - # TBPL SUCCESS # 05:32:54 INFO - Running post-action listener: _resource_record_post_action 05:32:54 INFO - Running post-run listener: _resource_record_post_run 05:32:55 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7835648; Write bytes: 359464960; Read time: 1316; Write time: 284492 05:32:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 74461184; Read time: 0; Write time: 44328 05:32:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6098944; Write bytes: 285003776; Read time: 1272; Write time: 240164 05:32:55 INFO - Running post-run listener: _upload_blobber_files 05:32:55 INFO - Blob upload gear active. 05:32:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:32:55 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 05:32:55 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'] 05:32:55 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 05:32:55 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:32:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:32:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:56 INFO - (blobuploader) - INFO - Done attempting. 05:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:32:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:57 INFO - (blobuploader) - INFO - Done attempting. 05:32:57 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:57 INFO - Return code: 0 05:32:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8a00ed856f22ecba6f660e85125cbdcce03742a32fffb2b4e350e1d4937324a7f864fe20387a7fd4b152eea8c4dd61bf18af9948fd8fb40fe24e691465b74c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72936b9217ff910ccd5f9099571e423150ad41bb8e737df41a2a1ea65ec3375fb49b259c77fbd64fd32c4626ad080cf65aec0e133cd7e76aff28973540d1999a"} 05:32:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:57 INFO - Contents: 05:32:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8a00ed856f22ecba6f660e85125cbdcce03742a32fffb2b4e350e1d4937324a7f864fe20387a7fd4b152eea8c4dd61bf18af9948fd8fb40fe24e691465b74c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72936b9217ff910ccd5f9099571e423150ad41bb8e737df41a2a1ea65ec3375fb49b259c77fbd64fd32c4626ad080cf65aec0e133cd7e76aff28973540d1999a"} 05:32:57 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:57 INFO - Copying logs to upload dir... 05:32:57 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.367404 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-28 05:32:57.137281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:32:57.140401) ========= 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=920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851 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/c8a00ed856f22ecba6f660e85125cbdcce03742a32fffb2b4e350e1d4937324a7f864fe20387a7fd4b152eea8c4dd61bf18af9948fd8fb40fe24e691465b74c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72936b9217ff910ccd5f9099571e423150ad41bb8e737df41a2a1ea65ec3375fb49b259c77fbd64fd32c4626ad080cf65aec0e133cd7e76aff28973540d1999a"} build_url:https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/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/c8a00ed856f22ecba6f660e85125cbdcce03742a32fffb2b4e350e1d4937324a7f864fe20387a7fd4b152eea8c4dd61bf18af9948fd8fb40fe24e691465b74c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72936b9217ff910ccd5f9099571e423150ad41bb8e737df41a2a1ea65ec3375fb49b259c77fbd64fd32c4626ad080cf65aec0e133cd7e76aff28973540d1999a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:32:57.164245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:32:57.164549) ========= 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=920470bf432669ad7e3a5387000001ca-1461844015.443405-762608851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:32:57.247164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:32:57.247489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:32:57.247779) ========= ========= Total master_lag: 0.15 =========