builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1461346095.53 results: success (0) buildid: 20160422094408 builduid: da5f317903874936a4869d73f4e3343a revision: e086812341563534fb85964abda7effdcca09e1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:15.528664) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:15.529114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:15.529389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:15.633871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:15.634171) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 10:28:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-04-22 10:28:15 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180787 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:15.829858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:15.830169) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014966 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:15.879750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 10:28:15.880110) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e086812341563534fb85964abda7effdcca09e1c --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 e086812341563534fb85964abda7effdcca09e1c --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=a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 10:28:15,832 truncating revision to first 12 chars 2016-04-22 10:28:15,832 Setting DEBUG logging. 2016-04-22 10:28:15,832 attempt 1/10 2016-04-22 10:28:15,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e08681234156?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 10:28:17,157 unpacking tar archive at: fx-team-e08681234156/testing/mozharness/ program finished with exit code 0 elapsedTime=1.620280 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 10:28:17.513030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:17.513333) ========= script_repo_revision: e086812341563534fb85964abda7effdcca09e1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:17.513730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:17.514013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 10:28:17.521046) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-04-22 10:28:17.521315) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:28:17 INFO - MultiFileLogger online at 20160422 10:28:17 in /builds/slave/test 10:28:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:28:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:28:17 INFO - {'append_to_log': False, 10:28:17 INFO - 'base_work_dir': '/builds/slave/test', 10:28:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:28:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:28:17 INFO - 'branch': 'Fx-Team-Non-PGO', 10:28:17 INFO - 'buildbot_json_path': 'buildprops.json', 10:28:17 INFO - 'config_files': ('talos/linux_config.py',), 10:28:17 INFO - 'default_actions': ('clobber', 10:28:17 INFO - 'read-buildbot-config', 10:28:17 INFO - 'download-and-extract', 10:28:17 INFO - 'populate-webroot', 10:28:17 INFO - 'create-virtualenv', 10:28:17 INFO - 'install', 10:28:17 INFO - 'run-tests'), 10:28:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:28:17 INFO - 'download_minidump_stackwalk': True, 10:28:17 INFO - 'download_symbols': 'ondemand', 10:28:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:28:17 INFO - 'tooltool.py': '/tools/tooltool.py', 10:28:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:28:17 INFO - '/tools/misc-python/virtualenv.py')}, 10:28:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:28:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:28:17 INFO - 'installer_path': 'installer.exe', 10:28:17 INFO - 'log_level': 'info', 10:28:17 INFO - 'log_name': 'talos', 10:28:17 INFO - 'log_to_console': True, 10:28:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:28:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:28:17 INFO - 'opt_config_files': (), 10:28:17 INFO - 'pip_index': False, 10:28:17 INFO - 'sps_profile': False, 10:28:17 INFO - 'sps_profile_interval': 0, 10:28:17 INFO - 'suite': 'dromaeojs-e10s', 10:28:17 INFO - 'system_bits': '32', 10:28:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:28:17 INFO - 'title': 'talos-linux64-ix-062', 10:28:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:28:17 INFO - 'use_talos_json': True, 10:28:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:28:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:28:17 INFO - 'work_dir': 'build'} 10:28:17 INFO - ##### 10:28:17 INFO - ##### Running clobber step. 10:28:17 INFO - ##### 10:28:17 INFO - Running pre-action listener: _resource_record_pre_action 10:28:17 INFO - Running main action method: clobber 10:28:17 INFO - rmtree: /builds/slave/test/build 10:28:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:28:18 INFO - Running post-action listener: _resource_record_post_action 10:28:18 INFO - ##### 10:28:18 INFO - ##### Running read-buildbot-config step. 10:28:18 INFO - ##### 10:28:18 INFO - Running pre-action listener: _resource_record_pre_action 10:28:18 INFO - Running main action method: read_buildbot_config 10:28:18 INFO - Using buildbot properties: 10:28:18 INFO - { 10:28:18 INFO - "project": "", 10:28:18 INFO - "product": "firefox", 10:28:18 INFO - "script_repo_revision": "production", 10:28:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:28:18 INFO - "repository": "", 10:28:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:28:18 INFO - "buildid": "20160422094408", 10:28:18 INFO - "pgo_build": "False", 10:28:18 INFO - "basedir": "/builds/slave/test", 10:28:18 INFO - "buildnumber": 1192, 10:28:18 INFO - "slavename": "talos-linux64-ix-062", 10:28:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:28:18 INFO - "platform": "ubuntu64_hw", 10:28:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:28:18 INFO - "branch": "fx-team", 10:28:18 INFO - "repo_path": "integration/fx-team", 10:28:18 INFO - "revision": "e086812341563534fb85964abda7effdcca09e1c", 10:28:18 INFO - "stage_platform": "linux64", 10:28:18 INFO - "builduid": "da5f317903874936a4869d73f4e3343a", 10:28:18 INFO - "slavebuilddir": "test" 10:28:18 INFO - } 10:28:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:28:18 INFO - Running post-action listener: _resource_record_post_action 10:28:18 INFO - ##### 10:28:18 INFO - ##### Running download-and-extract step. 10:28:18 INFO - ##### 10:28:18 INFO - Running pre-action listener: _resource_record_pre_action 10:28:18 INFO - Running main action method: download_and_extract 10:28:18 INFO - mkdir: /builds/slave/test/build/tests 10:28:18 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')]} 10:28:18 INFO - https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:28:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:28:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:28:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:28:19 INFO - Downloaded 1361 bytes. 10:28:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:28:19 INFO - Using the following test package requirements: 10:28:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:28:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:28:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:28:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:19 INFO - u'jsshell-linux-x86_64.zip'], 10:28:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:28:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:28:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:28:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:28:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:28:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:28:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:19 INFO - https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:28:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:28:20 INFO - Downloaded 22285608 bytes. 10:28:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:28:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:28:22 INFO - Return code: 0 10:28:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:22 INFO - https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:28:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:28:24 INFO - Downloaded 22285608 bytes. 10:28:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:28:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:28:25 INFO - Return code: 0 10:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:25 INFO - https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:28:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:28:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:28:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:28:27 INFO - Downloaded 10840145 bytes. 10:28:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:28:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:28:27 INFO - Return code: 0 10:28:27 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')]} 10:28:27 INFO - https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:29:00 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 10:29:00 INFO - retry: attempt #1 caught exception: The read operation timed out 10:29:00 INFO - retry: Failed, sleeping 30 seconds before retrying 10:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 10:29:31 INFO - Downloaded 54742401 bytes. 10:29:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:29:31 INFO - mkdir: /builds/slave/test/properties 10:29:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:29:31 INFO - Writing to file /builds/slave/test/properties/build_url 10:29:31 INFO - Contents: 10:29:31 INFO - build_url:https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:29:32 INFO - Running post-action listener: _resource_record_post_action 10:29:32 INFO - Running post-action listener: set_extra_try_arguments 10:29:32 INFO - ##### 10:29:32 INFO - ##### Running populate-webroot step. 10:29:32 INFO - ##### 10:29:32 INFO - Running pre-action listener: _resource_record_pre_action 10:29:32 INFO - Running main action method: populate_webroot 10:29:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:29:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:29:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:29:32 INFO - '--tppagecycles', 10:29:32 INFO - '7'], 10:29:32 INFO - 'tests': ['tsvgm']}}, 10:29:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:29:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:29:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:29:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:29:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:32 INFO - 'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:32 INFO - 'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['damp', 'tps']}, 10:29:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:32 INFO - 'tests': ['damp', 'tps']}, 10:29:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['dromaeo_dom']}, 10:29:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:29:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['a11yr', 10:29:32 INFO - 'ts_paint', 10:29:32 INFO - 'tpaint', 10:29:32 INFO - 'sessionrestore', 10:29:32 INFO - 'sessionrestore_no_auto_restore', 10:29:32 INFO - 'tabpaint']}, 10:29:32 INFO - 'other-e10s': {'tests': ['a11yr', 10:29:32 INFO - 'ts_paint', 10:29:32 INFO - 'tpaint', 10:29:32 INFO - 'sessionrestore', 10:29:32 INFO - 'sessionrestore_no_auto_restore', 10:29:32 INFO - 'tabpaint']}, 10:29:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:29:32 INFO - 'ts_paint', 10:29:32 INFO - 'tpaint', 10:29:32 INFO - 'sessionrestore', 10:29:32 INFO - 'sessionrestore_no_auto_restore', 10:29:32 INFO - 'tabpaint']}, 10:29:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:29:32 INFO - 'ts_paint', 10:29:32 INFO - 'tpaint', 10:29:32 INFO - 'sessionrestore', 10:29:32 INFO - 'sessionrestore_no_auto_restore', 10:29:32 INFO - 'tabpaint']}, 10:29:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['a11yr', 10:29:32 INFO - 'ts_paint', 10:29:32 INFO - 'tpaint', 10:29:32 INFO - 'sessionrestore', 10:29:32 INFO - 'sessionrestore_no_auto_restore', 10:29:32 INFO - 'tabpaint']}, 10:29:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['a11yr', 10:29:32 INFO - 'ts_paint', 10:29:32 INFO - 'tpaint', 10:29:32 INFO - 'sessionrestore', 10:29:32 INFO - 'sessionrestore_no_auto_restore', 10:29:32 INFO - 'tabpaint']}, 10:29:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['tsvgx', 10:29:32 INFO - 'tsvgr_opacity', 10:29:32 INFO - 'tart', 10:29:32 INFO - 'tscrollx', 10:29:32 INFO - 'cart']}, 10:29:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:29:32 INFO - 'tsvgr_opacity', 10:29:32 INFO - 'tart', 10:29:32 INFO - 'tscrollx', 10:29:32 INFO - 'cart']}, 10:29:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:32 INFO - 'talos_options': ['--disable-e10s'], 10:29:32 INFO - 'tests': ['tp5o']}, 10:29:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:32 INFO - 'tests': ['tp5o']}, 10:29:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:32 INFO - 'talos_options': ['--disable-e10s', 10:29:32 INFO - '--xperf_path', 10:29:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:32 INFO - 'tests': ['tp5n']}, 10:29:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:32 INFO - 'talos_options': ['--xperf_path', 10:29:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:32 INFO - 'tests': ['tp5n']}}, 10:29:32 INFO - 'talos.zip': {'path': '', 10:29:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:29:32 INFO - Running post-action listener: _resource_record_post_action 10:29:32 INFO - ##### 10:29:32 INFO - ##### Running create-virtualenv step. 10:29:32 INFO - ##### 10:29:32 INFO - Running pre-action listener: _resource_record_pre_action 10:29:32 INFO - Running main action method: create_virtualenv 10:29:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:29:32 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 10:29:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:29:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:29:32 INFO - Using real prefix '/usr' 10:29:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:29:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:29:35 INFO - Installing pip.................done. 10:29:35 INFO - Return code: 0 10:29:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:29:35 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')]} 10:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:35 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')]} 10:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:35 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 0x7f6b6bec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', '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 10:29:35 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 10:29:35 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 10:29:35 INFO - Using env: {'DISPLAY': ':0', 10:29:35 INFO - 'HOME': '/home/cltbld', 10:29:35 INFO - 'LANG': 'en_US.UTF-8', 10:29:35 INFO - 'LANGUAGE': 'en_US:en', 10:29:35 INFO - 'LOGNAME': 'cltbld', 10:29:35 INFO - 'MAIL': '/var/mail/cltbld', 10:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:35 INFO - 'MOZ_NO_REMOTE': '1', 10:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:35 INFO - 'NO_EM_RESTART': '1', 10:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:35 INFO - 'PWD': '/builds/slave/test', 10:29:35 INFO - 'SHELL': '/bin/bash', 10:29:35 INFO - 'SHLVL': '1', 10:29:35 INFO - 'TERM': 'linux', 10:29:35 INFO - 'TMOUT': '86400', 10:29:35 INFO - 'USER': 'cltbld', 10:29:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:35 INFO - '_': '/tools/buildbot/bin/python'} 10:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:35 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 10:29:35 INFO - Cleaning up... 10:29:35 INFO - Return code: 0 10:29:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:29:35 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')]} 10:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:35 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')]} 10:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:35 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 0x7f6b6bec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', '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 10:29:35 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 10:29:35 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 10:29:35 INFO - Using env: {'DISPLAY': ':0', 10:29:35 INFO - 'HOME': '/home/cltbld', 10:29:35 INFO - 'LANG': 'en_US.UTF-8', 10:29:35 INFO - 'LANGUAGE': 'en_US:en', 10:29:35 INFO - 'LOGNAME': 'cltbld', 10:29:35 INFO - 'MAIL': '/var/mail/cltbld', 10:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:35 INFO - 'MOZ_NO_REMOTE': '1', 10:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:35 INFO - 'NO_EM_RESTART': '1', 10:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:35 INFO - 'PWD': '/builds/slave/test', 10:29:35 INFO - 'SHELL': '/bin/bash', 10:29:35 INFO - 'SHLVL': '1', 10:29:35 INFO - 'TERM': 'linux', 10:29:35 INFO - 'TMOUT': '86400', 10:29:35 INFO - 'USER': 'cltbld', 10:29:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:35 INFO - '_': '/tools/buildbot/bin/python'} 10:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:35 INFO - Downloading/unpacking psutil>=0.7.1 10:29:35 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 10:29:35 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 10:29:35 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 10:29:35 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 10:29:35 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 10:29:35 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 10:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:37 INFO - Installing collected packages: psutil 10:29:37 INFO - Running setup.py install for psutil 10:29:37 INFO - building 'psutil._psutil_linux' extension 10:29:37 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 10:29:39 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 10:29:39 INFO - building 'psutil._psutil_posix' extension 10:29:39 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 10:29:39 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 10:29:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:39 INFO - Successfully installed psutil 10:29:39 INFO - Cleaning up... 10:29:39 INFO - Return code: 0 10:29:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:39 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 0x7f6b6bec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', '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 10:29:39 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 10:29:39 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 10:29:39 INFO - Using env: {'DISPLAY': ':0', 10:29:39 INFO - 'HOME': '/home/cltbld', 10:29:39 INFO - 'LANG': 'en_US.UTF-8', 10:29:39 INFO - 'LANGUAGE': 'en_US:en', 10:29:39 INFO - 'LOGNAME': 'cltbld', 10:29:39 INFO - 'MAIL': '/var/mail/cltbld', 10:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:39 INFO - 'MOZ_NO_REMOTE': '1', 10:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:39 INFO - 'NO_EM_RESTART': '1', 10:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:39 INFO - 'PWD': '/builds/slave/test', 10:29:39 INFO - 'SHELL': '/bin/bash', 10:29:39 INFO - 'SHLVL': '1', 10:29:39 INFO - 'TERM': 'linux', 10:29:39 INFO - 'TMOUT': '86400', 10:29:39 INFO - 'USER': 'cltbld', 10:29:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:39 INFO - '_': '/tools/buildbot/bin/python'} 10:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:29:39 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 10:29:39 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 10:29:39 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 10:29:39 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 10:29:39 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 10:29:39 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 10:29:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:29:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:29:41 INFO - Installing collected packages: mozsystemmonitor 10:29:41 INFO - Running setup.py install for mozsystemmonitor 10:29:41 INFO - Successfully installed mozsystemmonitor 10:29:41 INFO - Cleaning up... 10:29:41 INFO - Return code: 0 10:29:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:29:41 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')]} 10:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:41 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')]} 10:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:41 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 0x7f6b6bec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', '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 10:29:41 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 10:29:41 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 10:29:41 INFO - Using env: {'DISPLAY': ':0', 10:29:41 INFO - 'HOME': '/home/cltbld', 10:29:41 INFO - 'LANG': 'en_US.UTF-8', 10:29:41 INFO - 'LANGUAGE': 'en_US:en', 10:29:41 INFO - 'LOGNAME': 'cltbld', 10:29:41 INFO - 'MAIL': '/var/mail/cltbld', 10:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:41 INFO - 'MOZ_NO_REMOTE': '1', 10:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:41 INFO - 'NO_EM_RESTART': '1', 10:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:41 INFO - 'PWD': '/builds/slave/test', 10:29:41 INFO - 'SHELL': '/bin/bash', 10:29:41 INFO - 'SHLVL': '1', 10:29:41 INFO - 'TERM': 'linux', 10:29:41 INFO - 'TMOUT': '86400', 10:29:41 INFO - 'USER': 'cltbld', 10:29:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:41 INFO - '_': '/tools/buildbot/bin/python'} 10:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:29:41 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 10:29:41 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 10:29:41 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 10:29:41 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 10:29:41 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 10:29:41 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 10:29:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:29:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:29:43 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 10:29:43 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 10:29:43 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 10:29:43 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 10:29:43 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 10:29:43 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 10:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:29:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:44 INFO - Downloading docopt-0.6.1.tar.gz 10:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:29:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:29:44 INFO - Running setup.py install for blobuploader 10:29:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:29:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:29:44 INFO - Running setup.py install for requests 10:29:44 INFO - Running setup.py install for docopt 10:29:45 INFO - Successfully installed blobuploader requests docopt 10:29:45 INFO - Cleaning up... 10:29:45 INFO - Return code: 0 10:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:45 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 0x7f6b6bec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', '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 10:29:45 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 10:29:45 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 10:29:45 INFO - Using env: {'DISPLAY': ':0', 10:29:45 INFO - 'HOME': '/home/cltbld', 10:29:45 INFO - 'LANG': 'en_US.UTF-8', 10:29:45 INFO - 'LANGUAGE': 'en_US:en', 10:29:45 INFO - 'LOGNAME': 'cltbld', 10:29:45 INFO - 'MAIL': '/var/mail/cltbld', 10:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:45 INFO - 'MOZ_NO_REMOTE': '1', 10:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:45 INFO - 'NO_EM_RESTART': '1', 10:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:45 INFO - 'PWD': '/builds/slave/test', 10:29:45 INFO - 'SHELL': '/bin/bash', 10:29:45 INFO - 'SHLVL': '1', 10:29:45 INFO - 'TERM': 'linux', 10:29:45 INFO - 'TMOUT': '86400', 10:29:45 INFO - 'USER': 'cltbld', 10:29:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:45 INFO - '_': '/tools/buildbot/bin/python'} 10:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:45 INFO - Running setup.py (path:/tmp/pip-z41JCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:45 INFO - Running setup.py (path:/tmp/pip-zPXc00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:45 INFO - Running setup.py (path:/tmp/pip-lUmUz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:45 INFO - Running setup.py (path:/tmp/pip-WxdQCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:45 INFO - Running setup.py (path:/tmp/pip-W8lYJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:45 INFO - Running setup.py (path:/tmp/pip-URA4LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:45 INFO - Running setup.py (path:/tmp/pip-kekE72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:45 INFO - Running setup.py (path:/tmp/pip-GAjsCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:45 INFO - Running setup.py (path:/tmp/pip-oJ_nUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:45 INFO - Running setup.py (path:/tmp/pip-xERWgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:46 INFO - Running setup.py (path:/tmp/pip-5WsFOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:46 INFO - Running setup.py (path:/tmp/pip-UnkvCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:46 INFO - Running setup.py (path:/tmp/pip-zA12I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:46 INFO - Running setup.py (path:/tmp/pip-utSbQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:46 INFO - Running setup.py (path:/tmp/pip-jFeeCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:46 INFO - Running setup.py (path:/tmp/pip-u56UkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:46 INFO - Running setup.py (path:/tmp/pip-nLQhsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:29:46 INFO - Running setup.py install for manifestparser 10:29:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:29:46 INFO - Running setup.py install for mozcrash 10:29:46 INFO - Running setup.py install for mozdebug 10:29:46 INFO - Running setup.py install for mozdevice 10:29:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:29:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:29:46 INFO - Running setup.py install for mozfile 10:29:47 INFO - Running setup.py install for mozhttpd 10:29:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozinfo 10:29:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozInstall 10:29:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozleak 10:29:47 INFO - Running setup.py install for mozlog 10:29:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for moznetwork 10:29:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozprocess 10:29:47 INFO - Running setup.py install for mozprofile 10:29:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozrunner 10:29:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Running setup.py install for mozscreenshot 10:29:48 INFO - Running setup.py install for moztest 10:29:48 INFO - Running setup.py install for mozversion 10:29:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:29:48 INFO - Cleaning up... 10:29:48 INFO - Return code: 0 10:29:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29: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')]} 10:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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')]} 10:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:48 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 0x7f6b6bec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', '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 10:29:48 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 10:29:48 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 10:29:48 INFO - Using env: {'DISPLAY': ':0', 10:29:48 INFO - 'HOME': '/home/cltbld', 10:29:48 INFO - 'LANG': 'en_US.UTF-8', 10:29:48 INFO - 'LANGUAGE': 'en_US:en', 10:29:48 INFO - 'LOGNAME': 'cltbld', 10:29:48 INFO - 'MAIL': '/var/mail/cltbld', 10:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:48 INFO - 'MOZ_NO_REMOTE': '1', 10:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:48 INFO - 'NO_EM_RESTART': '1', 10:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:48 INFO - 'PWD': '/builds/slave/test', 10:29:48 INFO - 'SHELL': '/bin/bash', 10:29:48 INFO - 'SHLVL': '1', 10:29:48 INFO - 'TERM': 'linux', 10:29:48 INFO - 'TMOUT': '86400', 10:29:48 INFO - 'USER': 'cltbld', 10:29:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:48 INFO - '_': '/tools/buildbot/bin/python'} 10:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:48 INFO - Running setup.py (path:/tmp/pip-bAt4cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:48 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)) 10:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:48 INFO - Running setup.py (path:/tmp/pip-iig1Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:48 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)) 10:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:48 INFO - Running setup.py (path:/tmp/pip-s9F85X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:48 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)) 10:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:48 INFO - Running setup.py (path:/tmp/pip-I1mQ2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:48 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)) 10:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:48 INFO - Running setup.py (path:/tmp/pip-w5XNBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:48 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)) 10:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:48 INFO - Running setup.py (path:/tmp/pip-32E2At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:49 INFO - Running setup.py (path:/tmp/pip-Y7Xq_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:49 INFO - Running setup.py (path:/tmp/pip-ikqEX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:49 INFO - Running setup.py (path:/tmp/pip-d60BH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:49 INFO - Running setup.py (path:/tmp/pip-J1PYL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:49 INFO - Running setup.py (path:/tmp/pip-M2wgG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:49 INFO - Running setup.py (path:/tmp/pip-jqdd89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:49 INFO - Running setup.py (path:/tmp/pip-3zwAjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:49 INFO - Running setup.py (path:/tmp/pip-rRx9wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:49 INFO - Running setup.py (path:/tmp/pip-8R9gaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:49 INFO - Running setup.py (path:/tmp/pip-W6vAsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:49 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)) 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:49 INFO - Running setup.py (path:/tmp/pip-_VhacZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:49 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)) 10:29:49 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)) 10:29:49 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)) 10:29:49 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)) 10:29:49 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)) 10:29:49 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)) 10:29:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:51 INFO - Downloading blessings-1.6.tar.gz 10:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:29:51 INFO - Installing collected packages: blessings 10:29:51 INFO - Running setup.py install for blessings 10:29:51 INFO - Successfully installed blessings 10:29:51 INFO - Cleaning up... 10:29:51 INFO - Return code: 0 10:29:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:52 INFO - Reading from file tmpfile_stdout 10:29:52 INFO - Current package versions: 10:29:52 INFO - argparse == 1.2.1 10:29:52 INFO - blessings == 1.6 10:29:52 INFO - blobuploader == 1.2.4 10:29:52 INFO - docopt == 0.6.1 10:29:52 INFO - manifestparser == 1.1 10:29:52 INFO - mozInstall == 1.12 10:29:52 INFO - mozcrash == 0.17 10:29:52 INFO - mozdebug == 0.1 10:29:52 INFO - mozdevice == 0.48 10:29:52 INFO - mozfile == 1.2 10:29:52 INFO - mozhttpd == 0.7 10:29:52 INFO - mozinfo == 0.9 10:29:52 INFO - mozleak == 0.1 10:29:52 INFO - mozlog == 3.1 10:29:52 INFO - moznetwork == 0.27 10:29:52 INFO - mozprocess == 0.22 10:29:52 INFO - mozprofile == 0.28 10:29:52 INFO - mozrunner == 6.11 10:29:52 INFO - mozscreenshot == 0.1 10:29:52 INFO - mozsystemmonitor == 0.0 10:29:52 INFO - moztest == 0.7 10:29:52 INFO - mozversion == 1.4 10:29:52 INFO - psutil == 3.1.1 10:29:52 INFO - requests == 1.2.3 10:29:52 INFO - wsgiref == 0.1.2 10:29:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:52 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')]} 10:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:52 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')]} 10:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:52 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 0x7f6b6bec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', '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 10:29:52 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 10:29:52 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 10:29:52 INFO - Using env: {'DISPLAY': ':0', 10:29:52 INFO - 'HOME': '/home/cltbld', 10:29:52 INFO - 'LANG': 'en_US.UTF-8', 10:29:52 INFO - 'LANGUAGE': 'en_US:en', 10:29:52 INFO - 'LOGNAME': 'cltbld', 10:29:52 INFO - 'MAIL': '/var/mail/cltbld', 10:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:52 INFO - 'MOZ_NO_REMOTE': '1', 10:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:52 INFO - 'NO_EM_RESTART': '1', 10:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:52 INFO - 'PWD': '/builds/slave/test', 10:29:52 INFO - 'SHELL': '/bin/bash', 10:29:52 INFO - 'SHLVL': '1', 10:29:52 INFO - 'TERM': 'linux', 10:29:52 INFO - 'TMOUT': '86400', 10:29:52 INFO - 'USER': 'cltbld', 10:29:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:52 INFO - '_': '/tools/buildbot/bin/python'} 10:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:52 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)) 10:29:52 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)) 10:29:52 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)) 10:29:52 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)) 10:29:52 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)) 10:29:52 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)) 10:29:52 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)) 10:29:52 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)) 10:29:52 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)) 10:29:52 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)) 10:29:52 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)) 10:29:52 INFO - Cleaning up... 10:29:52 INFO - Return code: 0 10:29:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:29:52 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')]} 10:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:52 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')]} 10:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:52 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 0x7f6b6bec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', '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 10:29:52 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 10:29:52 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 10:29:52 INFO - Using env: {'DISPLAY': ':0', 10:29:52 INFO - 'HOME': '/home/cltbld', 10:29:52 INFO - 'LANG': 'en_US.UTF-8', 10:29:52 INFO - 'LANGUAGE': 'en_US:en', 10:29:52 INFO - 'LOGNAME': 'cltbld', 10:29:52 INFO - 'MAIL': '/var/mail/cltbld', 10:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:52 INFO - 'MOZ_NO_REMOTE': '1', 10:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:52 INFO - 'NO_EM_RESTART': '1', 10:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:52 INFO - 'PWD': '/builds/slave/test', 10:29:52 INFO - 'SHELL': '/bin/bash', 10:29:52 INFO - 'SHLVL': '1', 10:29:52 INFO - 'TERM': 'linux', 10:29:52 INFO - 'TMOUT': '86400', 10:29:52 INFO - 'USER': 'cltbld', 10:29:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:52 INFO - '_': '/tools/buildbot/bin/python'} 10:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:52 INFO - Downloading/unpacking jsonschema 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:29:54 INFO - Downloading/unpacking functools32 (from jsonschema) 10:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:54 INFO - Downloading functools32-3.2.3-2.tar.gz 10:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:29:54 INFO - warning: no files found matching '*.txt' 10:29:54 INFO - no previously-included directories found matching 'build' 10:29:54 INFO - no previously-included directories found matching 'dist' 10:29:54 INFO - no previously-included directories found matching '.git*' 10:29:54 INFO - Installing collected packages: jsonschema, functools32 10:29:54 INFO - Running setup.py install for functools32 10:29:54 INFO - warning: no files found matching '*.txt' 10:29:54 INFO - no previously-included directories found matching 'build' 10:29:54 INFO - no previously-included directories found matching 'dist' 10:29:54 INFO - no previously-included directories found matching '.git*' 10:29:54 INFO - Successfully installed jsonschema functools32 10:29:54 INFO - Cleaning up... 10:29:55 INFO - Return code: 0 10:29:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:29: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')]} 10:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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')]} 10:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6b6bec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', '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 10:29: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', 'flake8'] in /builds/slave/test/build 10:29: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 flake8 10:29:55 INFO - Using env: {'DISPLAY': ':0', 10:29:55 INFO - 'HOME': '/home/cltbld', 10:29:55 INFO - 'LANG': 'en_US.UTF-8', 10:29:55 INFO - 'LANGUAGE': 'en_US:en', 10:29:55 INFO - 'LOGNAME': 'cltbld', 10:29:55 INFO - 'MAIL': '/var/mail/cltbld', 10:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:55 INFO - 'MOZ_NO_REMOTE': '1', 10:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:55 INFO - 'NO_EM_RESTART': '1', 10:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:55 INFO - 'PWD': '/builds/slave/test', 10:29:55 INFO - 'SHELL': '/bin/bash', 10:29:55 INFO - 'SHLVL': '1', 10:29:55 INFO - 'TERM': 'linux', 10:29:55 INFO - 'TMOUT': '86400', 10:29:55 INFO - 'USER': 'cltbld', 10:29:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:55 INFO - '_': '/tools/buildbot/bin/python'} 10:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:55 INFO - Downloading/unpacking flake8 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:29:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:29:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:29:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:29:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:29:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:29:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:29:57 INFO - no previously-included directories found matching 'docs/_build' 10:29:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:29:57 INFO - Running setup.py install for pep8 10:29:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:29:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:29:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:29:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:29:57 INFO - no previously-included directories found matching 'docs/_build' 10:29:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:29:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:29:57 INFO - Cleaning up... 10:29:58 INFO - Return code: 0 10:29:58 INFO - Running post-action listener: _resource_record_post_action 10:29:58 INFO - Running post-action listener: _start_resource_monitoring 10:29:58 INFO - Starting resource monitoring. 10:29:58 INFO - ##### 10:29:58 INFO - ##### Running install step. 10:29:58 INFO - ##### 10:29:58 INFO - Running pre-action listener: _resource_record_pre_action 10:29:58 INFO - Running main action method: install 10:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:58 INFO - Reading from file tmpfile_stdout 10:29:58 INFO - Detecting whether we're running mozinstall >=1.0... 10:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:29:58 INFO - Reading from file tmpfile_stdout 10:29:58 INFO - Output received: 10:29:58 INFO - Usage: mozinstall [options] installer 10:29:58 INFO - Options: 10:29:58 INFO - -h, --help show this help message and exit 10:29:58 INFO - -d DEST, --destination=DEST 10:29:58 INFO - Directory to install application into. [default: 10:29:58 INFO - "/builds/slave/test"] 10:29:58 INFO - --app=APP Application being installed. [default: firefox] 10:29:58 INFO - mkdir: /builds/slave/test/build/application 10:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:30:14 INFO - Reading from file tmpfile_stdout 10:30:14 INFO - Output received: 10:30:14 INFO - /builds/slave/test/build/application/firefox/firefox 10:30:14 INFO - Running post-action listener: _resource_record_post_action 10:30:14 INFO - ##### 10:30:14 INFO - ##### Running run-tests step. 10:30:14 INFO - ##### 10:30:14 INFO - Running pre-action listener: _resource_record_pre_action 10:30:14 INFO - Running main action method: run_tests 10:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:30:14 INFO - Python 2.7.3 10:30:14 INFO - Return code: 0 10:30:14 INFO - grabbing minidump binary from tooltool 10:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:14 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 0x13a1410>, '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 0x13a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:30:14 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 10:30:14 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 10:30:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:30:14 INFO - Return code: 0 10:30:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:30:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:30:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:30:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:30:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:30:15 INFO - Return code: 0 10:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 10:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 10:30:15 INFO - Using env: {'DISPLAY': ':0', 10:30:15 INFO - 'HOME': '/home/cltbld', 10:30:15 INFO - 'LANG': 'en_US.UTF-8', 10:30:15 INFO - 'LANGUAGE': 'en_US:en', 10:30:15 INFO - 'LOGNAME': 'cltbld', 10:30:15 INFO - 'MAIL': '/var/mail/cltbld', 10:30:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:30:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:15 INFO - 'MOZ_NO_REMOTE': '1', 10:30:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:15 INFO - 'NO_EM_RESTART': '1', 10:30:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:15 INFO - 'PWD': '/builds/slave/test', 10:30:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:30:15 INFO - 'SHELL': '/bin/bash', 10:30:15 INFO - 'SHLVL': '1', 10:30:15 INFO - 'TERM': 'linux', 10:30:15 INFO - 'TMOUT': '86400', 10:30:15 INFO - 'USER': 'cltbld', 10:30:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192', 10:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:15 INFO - '_': '/tools/buildbot/bin/python'} 10:30:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 10:30:15 INFO - mozversion application_buildid: 20160422094408 10:30:15 INFO - mozversion application_changeset: e086812341563534fb85964abda7effdcca09e1c 10:30:15 INFO - mozversion application_display_name: Nightly 10:30:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:30:15 INFO - mozversion application_name: Firefox 10:30:15 INFO - mozversion application_remotingname: firefox 10:30:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:30:15 INFO - mozversion application_vendor: Mozilla 10:30:15 INFO - mozversion application_version: 48.0a1 10:30:15 INFO - mozversion platform_buildid: 20160422094408 10:30:15 INFO - mozversion platform_changeset: e086812341563534fb85964abda7effdcca09e1c 10:30:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:30:15 INFO - mozversion platform_version: 48.0a1 10:30:15 INFO - using testdate: 1461346215 10:30:15 INFO - actual date: 1461346215 10:30:15 INFO - starting webserver on 'localhost:57366' 10:30:15 INFO - SUITE-START | Running 2 tests 10:30:15 INFO - TEST-START | dromaeo_css 10:30:15 INFO - operating with platform_type : linux_ 10:30:15 INFO - Initialising browser for dromaeo_css test... 10:30:15 INFO - TEST-INFO | started process 3278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKzPpSB/profile http://localhost:57366/getInfo.html) 10:30:20 INFO - PROCESS | 3278 | 10:30:20 INFO - PROCESS | 3278 | (process:3346): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:30:23 INFO - PROCESS | 3278 | __metrics Screen width/height:1600/1200 10:30:23 INFO - PROCESS | 3278 | colorDepth:24 10:30:23 INFO - PROCESS | 3278 | Browser inner width/height: 1024/697 10:30:23 INFO - PROCESS | 3278 | __metrics 10:30:24 ERROR - PROCESS | 3278 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:30:25 INFO - TEST-INFO | 3278: exit 0 10:30:25 INFO - Browser initialized. 10:30:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:30:25 INFO - TEST-INFO | started process 3398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKzPpSB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:27 INFO - PROCESS | 3398 | 10:30:27 INFO - PROCESS | 3398 | (process:3456): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:30:37 INFO - PROCESS | 3398 | RSS: Main: 166199296 10:30:37 INFO - PROCESS | 3398 | 10:31:26 INFO - PROCESS | 3398 | 1461346286759 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] 10:33:38 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:57366/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57366/tests/dromaeo/cssquery-ext.html) 10:33:39 INFO - PROCESS | 3398 | RSS: Main: 170536960 10:33:39 INFO - PROCESS | 3398 | 10:36:41 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:57366/tests/dromaeo/cssquery-ext.html (next: http://localhost:57366/tests/dromaeo/cssquery-jquery.html) 10:36:42 INFO - PROCESS | 3398 | RSS: Main: 166883328 10:36:42 INFO - PROCESS | 3398 | 10:39:44 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:57366/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57366/tests/dromaeo/cssquery-mootools.html) 10:39:44 INFO - PROCESS | 3398 | RSS: Main: 167669760 10:39:44 INFO - PROCESS | 3398 | 10:42:46 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:57366/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57366/tests/dromaeo/cssquery-prototype.html) 10:42:47 INFO - PROCESS | 3398 | RSS: Main: 165482496 10:42:47 INFO - PROCESS | 3398 | 10:45:49 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:57366/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57366/tests/dromaeo/cssquery-yui.html) 10:45:50 INFO - PROCESS | 3398 | RSS: Main: 166674432 10:45:50 INFO - PROCESS | 3398 | 10:48:53 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:57366/tests/dromaeo/cssquery-yui.html (next: http://localhost:57366/tests/dromaeo/cssquery-dojo.html) 10:48:53 INFO - PROCESS | 3398 | RSS: Main: 168820736 10:48:53 INFO - PROCESS | 3398 | 10:48:53 INFO - PROCESS | 3398 | __start_tp_report 10:48:53 INFO - PROCESS | 3398 | _x_x_mozilla_page_load 10:48:53 INFO - PROCESS | 3398 | _x_x_mozilla_page_load_details 10:48:53 INFO - PROCESS | 3398 | |i|pagename|runs| 10:48:53 INFO - PROCESS | 3398 | |0;dojo.html;2639.577667573188;2687.803927252373;2694.7978901582387;2719.1434698070107;2721.238053345063;4810.230363141898;4813.109574728674;4846.39420072491;4862.124817532843;4876.049170411771;4643.233866412046;4742.193827049401;4778.426588809348;4848.903021939559;4890.095332363515;4380.561943805626;4468.642508599304;4470.798814053375;4488.483824360208;4488.685791994561;545.8245597524965;4374.5188029316905;4428.535003824601;4450.910981780363;4510.030343476152;4435.068635586531;4436.800343984529;4441;4444;4484.775761211927;4285.828566857322;4522.3668686383935;4538.614217791492;4538.954610453886;4565.680402371835;4313.935290970638;4317.050248945227;4326.5673432656795;4354.869353919387;4361.236783562864;4608.746518941457;4629.513901040376;4650.883727906796;4674.766261686936;4697.7181369117625;5071.315372424712;5079.5428411443145;5112.769925353368;5148.974255128738;5246.501582349671;5189.506996835295;5226.033183860998;5235.712035838027;5240.266362709223;5254.737263136828;4870.732109733999;4883.780229889663;4885.462599114059;4899.265110233422;4920.040592084545;5198.246254293182;5328.254044433782;5339.839804805862;5417;5431.2396264522995;5022.698638081653;5044.218146187347;5047.646664733506;5060.949390506122;5085.898282034413;5118.795248190105;5120.078385890575;5138.794448222104;5141.948580514222;5142.5628821549835;5032.974835125801;5034.244863270539;5079.161938280143;5119.411267704261;5142.820001299937;4943.505649435027;5082.263071854634;5093.312402825645;5147.202183661464;5160.948390516121;4381.627561657295;4443.555644435531;4455;4455.1757924784015;4482.843100491467;3702.33357995558;3755.2301778135416;3756.6431189037;3788.4885540451687;3818.9236215275537;4404.8458303959205;4429.069895321954;4446.911061778811;4482.574155455227;4493.146302202571;4979.103761322925;5179.974100129475;5216.739163041832;5242.711650859239;5245.186996015624;4357.520672725997;4395.956040439619;4405.515393306734;4433.202023635777;4435.556444355603;4613.907721845544;4619.514950930104;4628.236341003764;4662.673612847068;4704.435467743824;4780.163471392423;4846.491118432514;4884.267359896044;4891.095147397743;4895.045466134141;5029.84910452687;5113.463086375877;5119.5648369887485;5165.715885626327;5167.870803229799;4754.381930349033;4756.16767065769;4769.14155452022;4832.589229915356;4844.297576851266;4981.551660350586;5001.699898006132;5072.492750724898;5107.719075450737;5179.922301165561;5120.257562653469;5144.382674079135;5158.97420512895;5159.277701121771;5169;4920.966597014667;4933.180982661775;4965.081459929925;4971.304017437489;5012.248162775612;4825.831095911626;4947.975260123676;4968.55283024515;4981.651284410056;4994.001199760135;4799.208130658402;4909.828156014522;4926.827561035347;4935.876603084952;5047.864230548097;5070.2394640802695;5080.872978175427;5090.41460232078;5115.1559992600805;5146.536811686966;4860.149473842134;4921.926171107365;4989.950100499093;5019.52314530119;5063.5695965843315 10:48:53 INFO - PROCESS | 3398 | |1;ext.html;573.4007961680044;604.625132417901;608.917796097527;617.7374615788289;636.6212103798239;34857.30285394291;36278.81860590696;36296.818515907384;36321.818390908076;36525;35278.82360588193;36079.819600902025;36103.458448123296;36161.09597260063;36203.09492262688;7411.33298003181;7534.359579435754;7598.962005189994;7599.468037237396;7607.961960190191;7566.281203285706;7758.534487930714;7788.610569471503;7812.726554570591;7823.452358334919;7811.726589569366;7834.921650783504;7844.254795794419;7894.6052697365185;7923.564203968779;7702.345300649452;7734.303912647889;7735.342495887856;7782.766517004499;7825.7260995865445;7695.6152192390155;7788.532688038736;7796.064472263365;7800;7800.960995194988;29547;33512.83243583791;33872.66127338744;34057.829710851285;34199.829000854836;3036.3471853551373;3048.481758101128;3129.5618613394145;3147.213196700825;3156.7474602031784;24271.393215169584;24535.509289814105;24816.255512334657;25198.748012519824;25752;3239.2549713566013;3389.813560254185;3430.125318043908;3454.0501362125365;3514.9121271968406;156554;156679.21660391625;158180.20909895492;158259.20870395575;158705;32089.51865722016;32389.35221295608;32441.837790810896;33289.001329959654;34640.82679586586;31619.20951976173;32006.35987280288;32154.19614509609;32213.194670133435;32314.35371292561;12221.633350999484;12423.62729118128;12498.562550310695;12508.437120329607;12531.93734031324;9519.714408567754;9618.615255389706;9628.807423851484;9643;9675.9032409675;8106.959465202636;8138.064122625856;8231.753047408587;8259.95870020658;8293.95853020731;3194.8242846643657;3230.2893363460003;3243.6107667079627;3255.4791233402543;3284.178955261185;875.094277422877;887.0863011098579;996.9651062212788;998.201438848918;1053.5153829238636;27649.308767280978;28284.43431131366;28937;29080.85459572731;29288.121356359345;1023.7798873242289;1028.7736697926443;1043.8695163104612;1069.8127827630133;1132.0999805154756;14843.628909277139;15079.472218472301;15511.45709900148;15544.689106217813;15648.374065037271;367069;367434;368577;369652;370405;49992.750036249585;50422.74788626033;50743.492565074615;51083;51186.48813511892;1210.8123240897676;1214.8663646998823;1216.7262365967763;1219.359836086062;1274.8215249865027;26969.460610788068;27295.551299481223;27745.07472152807;28305.858470707513;28591.85704071466;43482.34776478292;43535.346969794846;43753.343699845165;43840.780796095816;44271.77864110659;302891;305000;305648;306400;308893;25849;26046.479070418107;26117.216483505526;26132.477350453264;26135.215943520965;42625;43092;43989.78005110082;44036.559634403246;45450;32087.77261617284;36065.63934360623;36840.26319473542;36935.44596831103;37139.81430092832;35317.470237945934;35323.470147947286;35375.82312088423;35477.1130721734;35643.64356356507;35590.28819423649;36188.09529761777;36272.45591316185;37437.251254975294;37799.24401512009;27765.72234277712;29404.264893377836;29538.852305738335;29551.556726648687;29715;23315.53368932578;23430.76569234286;23912.521749565258;24066.39834004164;24229.273121806375 10:48:53 INFO - PROCESS | 3398 | |2;jquery.html;378.5155001597954;379.66505988172725;387.2004311097583;394.84798352634226;405.9959400405995;15153.924230378847;16528;16832.495025149234;16955.830441695594;16986.915065424688;14953.551393458187;15168.620784480367;15237.61905952349;15261.618459538517;15312.310946007428;5036.244563315514;5136.280920671109;5200.531952124308;5204.635675502697;5205.609579281569;3645.4531820227044;5683.119116536944;5974;6015.759369625232;6027.035674292114;5042.899142017176;5957.225560677128;5963.4334738199805;5969.462748352647;5988.580799344048;5260.289860868772;5281.471852814726;5303.098473259536;5332.706701131437;5348.358197016363;4934.830068592034;5407.783688652449;5421.864453388657;5442.265294185314;5454.10007348787;19484.610307793766;19774.40676779699;20361.287354942655;20365.8981705092;20474.18103275882;1916.1090093106773;1920.5870737791442;1997.3209108902897;2091.3307741522717;2103.4531021934254;9186.081391860827;9436.292278079172;9720.95139524305;10833.512491937881;13567.796483052762;1782;1889.2537447708216;1898.8480921526245;1904.9238030478764;1913.655542002439;67940.6602966987;68994;69267;70461.2953870465;71390.64304678443;9946.403215807075;10095.798084038279;10115.14021308197;10244.334118282288;10274.22943279257;14113.223772692396;14226.502072427415;14297.714045719027;14298.28508574567;14377.712445751236;6803.625800580917;6902.585844849325;6917.9308206918295;7031.29687031303;7048.471364647672;6336.271328797156;6362.872742545216;6365.713542890581;6470.12653291809;6579.111819904348;4372.278574035312;4458.417261872054;4460.598546130864;4491.977540112279;4544.727316361029;1702.778638776951;1754.385964912296;1857.0900258873055;1862.9534261643296;1906.104131058428;874.8294082653821;880.7181701855345;931.8462453695064;943.2831048403126;954.9570269337758;16013.279402426919;16444.588885277964;16649.41727039572;16669.749953750703;16811;859.3383095016802;881.7002219245487;883.2845395229756;915.8305713442901;921.9354645174908;8985.820283594423;9198.862017069749;9291.953540232256;9440.007936114253;9580.0898914603;377886;383685;388211;392231;396630;76509.61745191239;77171;77214;77551.61224193955;78423.21576784273;924.7410724997012;930.930180236485;948.3977674176947;954.613381580461;954.9522523873778;14732.158480189977;14767;14797.778033329294;14861.256937153315;14965.027273227206;32391.676083238865;33562.664373355954;34436.139096522784;34524.30951381008;34964.650353497156;42428.787856060524;44397.33403999007;46384.30423543717;47905.04189916112;48388;4613.884652883705;4749.3113498541825;7075.363217310467;7365.373943214672;7856.803579910548;8206.425550211428;11146.164037697043;11319.717007074889;11399.259048161843;11941.343226122299;9864.668269783488;10079.848802268118;10149.949250253701;10194.694159175237;10600.250958591745;10040.347377420445;10135.189184865341;10180.243132473912;10263.7434064149;10335.328203666737;10175.338602990782;10357.326773759682;10487.737806554593;10682.946585267024;10689.625863094754;7728.26581474759;7735.729249476241;7838.608069596611;7949.602519873867;7958.461975849392;9402.717918462457;10254.897451025394;10282.280240383401;10407.167426605702;10412.167026638002 10:48:53 INFO - PROCESS | 3398 | |3;mootools.html;1451.9637009074775;1482.3181336585171;1636.3045705575134;1771.2472199315305;1801.531601783536;7030.296970302968;7710.537367757932;7720.189380115091;7941.761747147588;7965.6415461304305;7595.12656044555;7747.535147891131;7764.456488045839;7798.181190974937;7838.882416763753;2195.5169862630237;2209.6464565669494;2222.3333000099988;2229.944251393712;2234.318532847481;2144.5710857828417;2150.494633761065;2193.024104273599;2220.156340590573;2226.7773222677683;2146.5384942237415;2190.518086021073;2192.177933275022;2192.9232476863313;2209.812165965895;2135.1032566322183;2152.0315857863948;2157.924472643466;2159.7840215978354;2164.7077644517944;2127.478767701923;2164.1343462614923;2168.1002384010776;2170.175333373308;2186.464316242515;7911.406644501685;7919.96040019802;7952.1650226726515;7983.640736166828;8006.55963921984;4560.749158796265;4634.513376095529;4699.624030077585;4712.175369310391;4713.740744259065;3051.862666180027;3058.648255450629;3124.172094394987;3166.3667266546554;3186.601674790651;995.6813819577739;1007.4861820471539;1015.137133436573;1025.8510468275504;1027.209049032241;11021.724456888562;11043.061339786127;11079.612213572485;11112.055475284691;11133.276337038067;4245.681573881971;4252.87241382759;4456.509783923766;4460.442444694413;4479.216137175981;9330.860037099448;9371.859422108673;9380.577873995686;9396.201322887631;9396.67111651089;4830.3237546743485;4838.443578988391;4853.4418541867435;4853.4418541867435;4862.95137048632;3768.1521657627363;4281.207976524353;4354.782260886943;4365.476142862877;4406.515283318897;3640.399334109842;3738.6074462181623;3769.849206031783;3803.581606023335;3826.7321287510163;1218.4090716002731;1267.0687045021903;1267.1636719765095;1272.5291642092484;1283.8587755346905;715.9284071592904;869.5217630303434;887.7780554861284;895.6686026170229;921.6635927886273;5394.352677678704;5631.521320687705;5700.743466544015;5806.303243610793;5927.288725352985;922.7739203895088;930.9534523273944;955.9761005974906;972.042538099971;1028.4240825137947;3769.566499852497;3843.1929294847837;3883.1845312484693;3971.8014099295497;3984.5019372578427;9421.481818499911;9659.951700241454;9802.803943921082;9806.90193098074;9824.607015719434;9546.284028697875;9650.613975441043;9667.613295468243;9876.851847222297;9980.800383992424;7094.751683691046;7397.334239918433;7420.332170104716;7477;7523.134839493418;5640.294963129609;5647.407022262768;5696.401877802771;5709.086546152762;5833.562482813721;8753.562321884008;8782.604782784661;8834.823303533765;8873.556322183995;8930.330225233003;9044.231240344381;9118.179363857285;9151.63393464254;9172.082791720775;9273.53632318395;6373.3945275198785;6836.658167091526;6878.931210688029;6985.5808651481075;7129.893051604334;7589.1272503662785;7684.5389276641345;7694.884576731241;7695.807604809925;7703.460757746904;6729.528932974645;6819.181698196248;6856.5200435969;6946.548474349152;7011.404030657452;6780.830479238059;6804.4216241620015;6817;6923.653817309014;7021.929780702332;6136.447719705248;6504.934950650622;6534.379233972765;6565.606063636197;6631.436327911989;4756.334113224082;4828.637852161031;4831.4685384608365;4859.1010663027455;4951.5048495150195;4663.347131401674;4761.262004389325;4795.832145874878;4921;5123.846284611468 10:48:53 INFO - PROCESS | 3398 | |4;prototype.html;311.4642814359303;320.61686284889555;327.7509093089252;328.43837038663884;329.5682655721006;5249.8950020999555;5323.361196656407;5394.1639045947895;5427.538659213967;5506;5383.757730902119;5396.784128634859;5406.91889621656;5425.945740542594;5429.131338985763;4222.662187025031;4231.830726770925;4249.787510624472;4250.153610982066;4255.553166917475;4168.97915510422;4236.978815105936;4256.659467242629;4274.487061552618;4276.828926842923;4208.473940757405;4214.936775948363;4216.114615930658;4218.409422680812;4241.34259189826;4182.519010313792;4182.895427614303;4197.244495990721;4202.453681021448;4223.556526564713;3723.1809002019513;3723.757955732896;3725.739198256123;3735.655164140907;3736.4021756518828;4917.311576379309;5169.53474187325;5172.689638621695;5192.662476939025;5196.68819870809;4774.450938142123;4798.592119669832;4799.208130658437;4814.614830813562;4825.493323201048;5401.513863752242;5691.886162276731;5764.279465066867;5773.2494775679315;5778.7399567019165;3959.891485184117;3978.5822488638855;3983.7609743415487;3993.820278087493;3995.680345572347;5945.791897283574;6006.279246490405;6014.669193194372;6024.3975602439405;6027.8794424111275;3988.4615576897327;4067.389891516237;4087.7547347159266;4099;4110.424540564323;4132.442120313719;4142.855000075043;4148.066684995852;4163.271427500236;4165.10450253197;4727.314539391838;4745.525447455227;4746.691465054761;4765.451973023147;4804.567588917014;5163;5732.627379220337;5737.08206686928;5740.799072032459;5762.135679648086;1422.118286662276;1437.9352929118215;1444.415011920153;1447.3776276201334;1447.5006122887587;950.1733491862125;953.3755390219279;973.2019743810008;976.3507267667064;988.3871999360299;4945.653804233741;4947.455779864212;4962.826301079445;4963.255511673206;4964.60283177345;5904.261967254093;5908.911366329508;5921.348651648315;5926.170336152942;5952.9107063394085;4778.37881075458;4891.119598472309;4912.45962944083;4941.802327906844;4967.5777558907175;3150.4486714824816;3156.463401221798;3164.493681011073;3166.4458719724416;3183.793053451518;5464.9180262296095;5496.203050557727;5501;5505.724713764296;5540.806071787549;5861.794837180763;6012.6392416455155;6058.242719660043;6071.817845464643;6081.908771368433;5386.703731294817;5467.808626698046;5483.177523371526;5523.585731070106;5525.392206857323;5539.556835453073;5809.651420914759;5875.20684707559;5880.26496687914;5881.941180588139;5858.736356863866;5861.9413805861395;5869.275233436953;5880.088586269135;5899.970500147643;5563.7774489019985;5570.749316280696;5583.106702927512;5598.916016259678;5604.243427137448;4014.159398075851;4056.4320995061307;4095.1367127957305;4118.732282401635;4134.793260336911;5556.749946252347;5724.284464441945;5913.556483263858;5914;5967.940320596738;5707.68607726579;5729.3124825019595;5737.225474560881;5737.225474560881;5741.3397459291045;5648.971755141198;5709.600327977002;5721;5726.685032323096;5728.684922329146;5475.172066141206;5498.367687715964;5606.85982850432;5613.635113717595;5629.155626655871;5679.74441150141;5690.557212886144;5730.169125476866;5747.7413516391025;5788.565857560784;5493.917591236214;5607.8878422432135;5608.495235428831;5611.352620796515;5617.831465056055 10:48:53 INFO - PROCESS | 3398 | |5;yui.html;757.6931342806164;764.1327093748594;769.119502815616;782.4757412533602;797.2346547314579;11277.605283815057;11607.709807254823;11622.651320460389;11644.883551164487;11653.592124275652;12004.399780011008;12105.878941210607;12138.211016283936;12145.757084858298;12154.513819447211;640.266894405905;797.3143096936644;803.8512875118092;810.1412502747078;811.5577010529246;785.1402714028159;807.64059993303;812.7399232245684;813.5810057820228;814.7189219719187;857.0401150711181;860.5396113079472;864.7449002544264;867.397158974513;869.7955980344614;859.0936561927195;862.5126803356115;863.3093525179862;864.1876635962176;866.0386970462781;625.6402568523072;626.3548544998658;626.7774939896362;627.4384425938805;627.937206279373;11264.887351126466;11391.202615816896;11404.429778511041;11437.885621143849;11481;12156.939215303955;12243.571474998333;12502.3748812559;12515.56195533161;12564.81152782709;9764.51177441125;9902.257330700226;9947.10476057151;9967.501624918725;10269.486525673761;3369.22507823202;3371.3594417060926;3378.527006219131;3386.5597472328686;3499.5450591423205;46575.53424465746;46743.53256467426;46932;48083.75958120257;48155.518444815454;10296.330738501973;10342.930496974064;10395.792084158275;10415.1667866572;10475.580976760844;16408.83591164073;18243.72634410485;18386.81613183878;18431.631367372847;18502.537436563925;7010.859782804316;7062.258462861326;7092.6099064551945;7199.460040496983;7318.938753880658;3786.638447408325;3843.1737176507186;3845.250176215611;3866.3813789794062;3868.8259028343227;2876;2948.189247956829;2958.2160727407254;2965.8813647453862;2972.048944337791;521.5202014146994;527.1697077103577;535.253321616343;539.7116227196658;541.9430959749249;501.8268697299426;563.5519761789305;608.5983251054283;624.2976651267325;626.8683576448906;7718.729844455417;8104.6222142235965;8105.351571874236;8207.466514676527;8264.793380165424;547.7836254679379;618.1593033474471;622.4957784194817;639.6705696566272;664.8105289992426;3745.4943582615997;3758.342290099222;3812.218495208476;3859.1702783901596;3867.555231148454;50016.24975625369;50236.74881625642;50375.24437133446;50466.24300635493;50884.236736448984;44770.32844507335;44927.550724492336;46352;46438.5356146441;46722;41700.1659966799;41958.16083678309;42551;42635.786821066315;43297.56702432936;7498.58757768328;7564.357029652321;7611.581363025087;7628.732994345171;7643.388528917784;29320.413591728473;29450;29586.112416626675;29751.404971900007;30017.5497367544;37330.81334593309;37374.252514950094;37393;38300.233995320494;38352.6164738349;9541.188998935168;9607.711768646952;9692.17616502577;9739.853902191615;9742.659006934724;10353.792924141626;10402.895971040192;10413.36398224478;10435.530401131815;10449.634262800766;9525.809483810146;9742.220622350053;9786.706398808046;9949.303548751517;9996.400215987063;9779.559919803769;9922.40465572068;9924.255680824112;10069.446180460145;10110.545025473724;9637.132658060807;9852.458114803754;10061.547230374797;10151.796964060824;10265.281430299807;8710.608022639124;8766;8770.824583508167;8774.56127193625;9282.72151835446;8653.653853845775;8744.650213991368;8825.38222324431;8882.777930551789;8898.799620566999 10:48:53 INFO - PROCESS | 3398 | __end_tp_report 10:48:53 INFO - PROCESS | 3398 | __start_cc_report 10:48:53 INFO - PROCESS | 3398 | _x_x_mozilla_cycle_collect,382 10:48:53 INFO - PROCESS | 3398 | __end_cc_report 10:48:53 INFO - PROCESS | 3398 | __startTimestamp1461347333347__endTimestamp 10:48:53 INFO - PROCESS | 3398 | 10:48:53 INFO - PROCESS | 3398 | ------- Summary: start ------- 10:48:53 INFO - PROCESS | 3398 | Number of tests: 6 10:48:53 INFO - PROCESS | 3398 | 10:48:53 INFO - PROCESS | 3398 | [#0] dojo.html Cycles:165 Average:4729.75 Median:4890.10 stddev:597.76 (12.2%) stddev-sans-first:576.67 10:48:53 INFO - PROCESS | 3398 | Values: 2639.6 2687.8 2694.8 2719.1 2721.2 4810.2 4813.1 4846.4 4862.1 4876.0 4643.2 4742.2 4778.4 4848.9 4890.1 4380.6 4468.6 4470.8 4488.5 4488.7 545.8 4374.5 4428.5 4450.9 4510.0 4435.1 4436.8 4441.0 4444.0 4484.8 4285.8 4522.4 4538.6 4539.0 4565.7 4313.9 4317.1 4326.6 4354.9 4361.2 4608.7 4629.5 4650.9 4674.8 4697.7 5071.3 5079.5 5112.8 5149.0 5246.5 5189.5 5226.0 5235.7 5240.3 5254.7 4870.7 4883.8 4885.5 4899.3 4920.0 5198.2 5328.3 5339.8 5417.0 5431.2 5022.7 5044.2 5047.6 5060.9 5085.9 5118.8 5120.1 5138.8 5141.9 5142.6 5033.0 5034.2 5079.2 5119.4 5142.8 4943.5 5082.3 5093.3 5147.2 5160.9 4381.6 4443.6 4455.0 4455.2 4482.8 3702.3 3755.2 3756.6 3788.5 3818.9 4404.8 4429.1 4446.9 4482.6 4493.1 4979.1 5180.0 5216.7 5242.7 5245.2 4357.5 4396.0 4405.5 4433.2 4435.6 4613.9 4619.5 4628.2 4662.7 4704.4 4780.2 4846.5 4884.3 4891.1 4895.0 5029.8 5113.5 5119.6 5165.7 5167.9 4754.4 4756.2 4769.1 4832.6 4844.3 4981.6 5001.7 5072.5 5107.7 5179.9 5120.3 5144.4 5159.0 5159.3 5169.0 4921.0 4933.2 4965.1 4971.3 5012.2 4825.8 4948.0 4968.6 4981.7 4994.0 4799.2 4909.8 4926.8 4935.9 5047.9 5070.2 5080.9 5090.4 5115.2 5146.5 4860.1 4921.9 4990.0 5019.5 5063.6 10:48:53 INFO - PROCESS | 3398 | 10:48:53 INFO - PROCESS | 3398 | [#1] ext.html Cycles:180 Average:41850.97 Median:34749.06 stddev:77041.78 (221.7%) stddev-sans-first:77195.56 10:48:53 INFO - PROCESS | 3398 | Values: 573.4 604.6 608.9 617.7 636.6 34857.3 36278.8 36296.8 36321.8 36525.0 35278.8 36079.8 36103.5 36161.1 36203.1 7411.3 7534.4 7599.0 7599.5 7608.0 7566.3 7758.5 7788.6 7812.7 7823.5 7811.7 7834.9 7844.3 7894.6 7923.6 7702.3 7734.3 7735.3 7782.8 7825.7 7695.6 7788.5 7796.1 7800.0 7801.0 29547.0 33512.8 33872.7 34057.8 34199.8 3036.3 3048.5 3129.6 3147.2 3156.7 24271.4 24535.5 24816.3 25198.7 25752.0 3239.3 3389.8 3430.1 3454.1 3514.9 156554.0 156679.2 158180.2 158259.2 158705.0 32089.5 32389.4 32441.8 33289.0 34640.8 31619.2 32006.4 32154.2 32213.2 32314.4 12221.6 12423.6 12498.6 12508.4 12531.9 9519.7 9618.6 9628.8 9643.0 9675.9 8107.0 8138.1 8231.8 8260.0 8294.0 3194.8 3230.3 3243.6 3255.5 3284.2 875.1 887.1 997.0 998.2 1053.5 27649.3 28284.4 28937.0 29080.9 29288.1 1023.8 1028.8 1043.9 1069.8 1132.1 14843.6 15079.5 15511.5 15544.7 15648.4 367069.0 367434.0 368577.0 369652.0 370405.0 49992.8 50422.7 50743.5 51083.0 51186.5 1210.8 1214.9 1216.7 1219.4 1274.8 26969.5 27295.6 27745.1 28305.9 28591.9 43482.3 43535.3 43753.3 43840.8 44271.8 302891.0 305000.0 305648.0 306400.0 308893.0 25849.0 26046.5 26117.2 26132.5 26135.2 42625.0 43092.0 43989.8 44036.6 45450.0 32087.8 36065.6 36840.3 36935.4 37139.8 35317.5 35323.5 35375.8 35477.1 35643.6 35590.3 36188.1 36272.5 37437.3 37799.2 27765.7 29404.3 29538.9 29551.6 29715.0 23315.5 23430.8 23912.5 24066.4 24229.3 10:48:53 INFO - PROCESS | 3398 | 10:48:53 INFO - PROCESS | 3398 | [#2] jquery.html Cycles:180 Average:23934.52 Median:24384.81 stddev:64008.00 (262.5%) stddev-sans-first:64163.12 10:48:53 INFO - PROCESS | 3398 | Values: 378.5 379.7 387.2 394.8 406.0 15153.9 16528.0 16832.5 16955.8 16986.9 14953.6 15168.6 15237.6 15261.6 15312.3 5036.2 5136.3 5200.5 5204.6 5205.6 3645.5 5683.1 5974.0 6015.8 6027.0 5042.9 5957.2 5963.4 5969.5 5988.6 5260.3 5281.5 5303.1 5332.7 5348.4 4934.8 5407.8 5421.9 5442.3 5454.1 19484.6 19774.4 20361.3 20365.9 20474.2 1916.1 1920.6 1997.3 2091.3 2103.5 9186.1 9436.3 9721.0 10833.5 13567.8 1782.0 1889.3 1898.8 1904.9 1913.7 67940.7 68994.0 69267.0 70461.3 71390.6 9946.4 10095.8 10115.1 10244.3 10274.2 14113.2 14226.5 14297.7 14298.3 14377.7 6803.6 6902.6 6917.9 7031.3 7048.5 6336.3 6362.9 6365.7 6470.1 6579.1 4372.3 4458.4 4460.6 4492.0 4544.7 1702.8 1754.4 1857.1 1863.0 1906.1 874.8 880.7 931.8 943.3 955.0 16013.3 16444.6 16649.4 16669.7 16811.0 859.3 881.7 883.3 915.8 921.9 8985.8 9198.9 9292.0 9440.0 9580.1 377886.0 383685.0 388211.0 392231.0 396630.0 76509.6 77171.0 77214.0 77551.6 78423.2 924.7 930.9 948.4 954.6 955.0 14732.2 14767.0 14797.8 14861.3 14965.0 32391.7 33562.7 34436.1 34524.3 34964.7 42428.8 44397.3 46384.3 47905.0 48388.0 4613.9 4749.3 7075.4 7365.4 7856.8 8206.4 11146.2 11319.7 11399.3 11941.3 9864.7 10079.8 10149.9 10194.7 10600.3 10040.3 10135.2 10180.2 10263.7 10335.3 10175.3 10357.3 10487.7 10682.9 10689.6 7728.3 7735.7 7838.6 7949.6 7958.5 9402.7 10254.9 10282.3 10407.2 10412.2 10:48:53 INFO - PROCESS | 3398 | 10:48:53 INFO - PROCESS | 3398 | [#3] mootools.html Cycles:180 Average:5277.73 Median:5512.94 stddev:2904.73 (52.7%) stddev-sans-first:2898.65 10:48:53 INFO - PROCESS | 3398 | Values: 1452.0 1482.3 1636.3 1771.2 1801.5 7030.3 7710.5 7720.2 7941.8 7965.6 7595.1 7747.5 7764.5 7798.2 7838.9 2195.5 2209.6 2222.3 2229.9 2234.3 2144.6 2150.5 2193.0 2220.2 2226.8 2146.5 2190.5 2192.2 2192.9 2209.8 2135.1 2152.0 2157.9 2159.8 2164.7 2127.5 2164.1 2168.1 2170.2 2186.5 7911.4 7920.0 7952.2 7983.6 8006.6 4560.7 4634.5 4699.6 4712.2 4713.7 3051.9 3058.6 3124.2 3166.4 3186.6 995.7 1007.5 1015.1 1025.9 1027.2 11021.7 11043.1 11079.6 11112.1 11133.3 4245.7 4252.9 4456.5 4460.4 4479.2 9330.9 9371.9 9380.6 9396.2 9396.7 4830.3 4838.4 4853.4 4853.4 4863.0 3768.2 4281.2 4354.8 4365.5 4406.5 3640.4 3738.6 3769.8 3803.6 3826.7 1218.4 1267.1 1267.2 1272.5 1283.9 715.9 869.5 887.8 895.7 921.7 5394.4 5631.5 5700.7 5806.3 5927.3 922.8 931.0 956.0 972.0 1028.4 3769.6 3843.2 3883.2 3971.8 3984.5 9421.5 9660.0 9802.8 9806.9 9824.6 9546.3 9650.6 9667.6 9876.9 9980.8 7094.8 7397.3 7420.3 7477.0 7523.1 5640.3 5647.4 5696.4 5709.1 5833.6 8753.6 8782.6 8834.8 8873.6 8930.3 9044.2 9118.2 9151.6 9172.1 9273.5 6373.4 6836.7 6878.9 6985.6 7129.9 7589.1 7684.5 7694.9 7695.8 7703.5 6729.5 6819.2 6856.5 6946.5 7011.4 6780.8 6804.4 6817.0 6923.7 7021.9 6136.4 6504.9 6534.4 6565.6 6631.4 4756.3 4828.6 4831.5 4859.1 4951.5 4663.3 4761.3 4795.8 4921.0 5123.8 10:48:53 INFO - PROCESS | 3398 | 10:48:53 INFO - PROCESS | 3398 | [#4] prototype.html Cycles:180 Average:4715.79 Median:5395.47 stddev:1380.29 (25.6%) stddev-sans-first:1343.99 10:48:53 INFO - PROCESS | 3398 | Values: 311.5 320.6 327.8 328.4 329.6 5249.9 5323.4 5394.2 5427.5 5506.0 5383.8 5396.8 5406.9 5425.9 5429.1 4222.7 4231.8 4249.8 4250.2 4255.6 4169.0 4237.0 4256.7 4274.5 4276.8 4208.5 4214.9 4216.1 4218.4 4241.3 4182.5 4182.9 4197.2 4202.5 4223.6 3723.2 3723.8 3725.7 3735.7 3736.4 4917.3 5169.5 5172.7 5192.7 5196.7 4774.5 4798.6 4799.2 4814.6 4825.5 5401.5 5691.9 5764.3 5773.2 5778.7 3959.9 3978.6 3983.8 3993.8 3995.7 5945.8 6006.3 6014.7 6024.4 6027.9 3988.5 4067.4 4087.8 4099.0 4110.4 4132.4 4142.9 4148.1 4163.3 4165.1 4727.3 4745.5 4746.7 4765.5 4804.6 5163.0 5732.6 5737.1 5740.8 5762.1 1422.1 1437.9 1444.4 1447.4 1447.5 950.2 953.4 973.2 976.4 988.4 4945.7 4947.5 4962.8 4963.3 4964.6 5904.3 5908.9 5921.3 5926.2 5952.9 4778.4 4891.1 4912.5 4941.8 4967.6 3150.4 3156.5 3164.5 3166.4 3183.8 5464.9 5496.2 5501.0 5505.7 5540.8 5861.8 6012.6 6058.2 6071.8 6081.9 5386.7 5467.8 5483.2 5523.6 5525.4 5539.6 5809.7 5875.2 5880.3 5881.9 5858.7 5861.9 5869.3 5880.1 5900.0 5563.8 5570.7 5583.1 5598.9 5604.2 4014.2 4056.4 4095.1 4118.7 4134.8 5556.7 5724.3 5913.6 5914.0 5967.9 5707.7 5729.3 5737.2 5737.2 5741.3 5649.0 5709.6 5721.0 5726.7 5728.7 5475.2 5498.4 5606.9 5613.6 5629.2 5679.7 5690.6 5730.2 5747.7 5788.6 5493.9 5607.9 5608.5 5611.4 5617.8 10:48:53 INFO - PROCESS | 3398 | 10:48:53 INFO - PROCESS | 3398 | [#5] yui.html Cycles:180 Average:12497.00 Median:50675.24 stddev:14316.44 (28.3%) stddev-sans-first:14329.46 10:48:53 INFO - PROCESS | 3398 | Values: 757.7 764.1 769.1 782.5 797.2 11277.6 11607.7 11622.7 11644.9 11653.6 12004.4 12105.9 12138.2 12145.8 12154.5 640.3 797.3 803.9 810.1 811.6 785.1 807.6 812.7 813.6 814.7 857.0 860.5 864.7 867.4 869.8 859.1 862.5 863.3 864.2 866.0 625.6 626.4 626.8 627.4 627.9 11264.9 11391.2 11404.4 11437.9 11481.0 12156.9 12243.6 12502.4 12515.6 12564.8 9764.5 9902.3 9947.1 9967.5 10269.5 3369.2 3371.4 3378.5 3386.6 3499.5 46575.5 46743.5 46932.0 48083.8 48155.5 10296.3 10342.9 10395.8 10415.2 10475.6 16408.8 18243.7 18386.8 18431.6 18502.5 7010.9 7062.3 7092.6 7199.5 7318.9 3786.6 3843.2 3845.3 3866.4 3868.8 2876.0 2948.2 2958.2 2965.9 2972.0 521.5 527.2 535.3 539.7 541.9 501.8 563.6 608.6 624.3 626.9 7718.7 8104.6 8105.4 8207.5 8264.8 547.8 618.2 622.5 639.7 664.8 3745.5 3758.3 3812.2 3859.2 3867.6 50016.2 50236.7 50375.2 50466.2 50884.2 44770.3 44927.6 46352.0 46438.5 46722.0 41700.2 41958.2 42551.0 42635.8 43297.6 7498.6 7564.4 7611.6 7628.7 7643.4 29320.4 29450.0 29586.1 29751.4 30017.5 37330.8 37374.3 37393.0 38300.2 38352.6 9541.2 9607.7 9692.2 9739.9 9742.7 10353.8 10402.9 10413.4 10435.5 10449.6 9525.8 9742.2 9786.7 9949.3 9996.4 9779.6 9922.4 9924.3 10069.4 10110.5 9637.1 9852.5 10061.5 10151.8 10265.3 8710.6 8766.0 8770.8 8774.6 9282.7 8653.7 8744.7 8825.4 8882.8 8898.8 10:48:53 INFO - PROCESS | 3398 | -------- Summary: end -------- 10:48:53 INFO - PROCESS | 3398 | 10:48:54 INFO - TEST-INFO | 3398: exit 0 10:48:54 INFO - TEST-OK | dromaeo_css | took 1118605ms 10:48:54 INFO - TEST-START | kraken 10:48:54 INFO - operating with platform_type : linux_ 10:48:54 INFO - Initialising browser for kraken test... 10:48:54 INFO - TEST-INFO | started process 3629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk9asz3/profile http://localhost:57366/getInfo.html) 10:48:58 INFO - PROCESS | 3629 | 10:48:58 INFO - PROCESS | 3629 | (process:3698): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:48:59 INFO - PROCESS | 3629 | __metrics Screen width/height:1600/1200 10:48:59 INFO - PROCESS | 3629 | colorDepth:24 10:48:59 INFO - PROCESS | 3629 | Browser inner width/height: 1024/697 10:48:59 INFO - PROCESS | 3629 | __metrics 10:48:59 ERROR - PROCESS | 3629 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:49:00 INFO - TEST-INFO | 3629: exit 0 10:49:00 INFO - Browser initialized. 10:49:00 INFO - Running cycle 1/1 for kraken test... 10:49:00 INFO - TEST-INFO | started process 3749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk9asz3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:49:02 INFO - PROCESS | 3749 | 10:49:02 INFO - PROCESS | 3749 | (process:3809): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:49:12 INFO - PROCESS | 3749 | RSS: Main: 166006784 10:49:12 INFO - PROCESS | 3749 | 10:49:15 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57366/tests/kraken/driver.html?testName=audio-beat-detection) 10:49:16 INFO - PROCESS | 3749 | RSS: Main: 169758720 10:49:16 INFO - PROCESS | 3749 | 10:49:19 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57366/tests/kraken/driver.html?testName=audio-dft) 10:49:19 INFO - PROCESS | 3749 | RSS: Main: 172412928 10:49:19 INFO - PROCESS | 3749 | 10:49:22 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57366/tests/kraken/driver.html?testName=audio-fft) 10:49:23 INFO - PROCESS | 3749 | RSS: Main: 164847616 10:49:23 INFO - PROCESS | 3749 | 10:49:25 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57366/tests/kraken/driver.html?testName=audio-oscillator) 10:49:26 INFO - PROCESS | 3749 | RSS: Main: 165150720 10:49:26 INFO - PROCESS | 3749 | 10:49:28 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57366/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:49:28 INFO - PROCESS | 3749 | RSS: Main: 166092800 10:49:28 INFO - PROCESS | 3749 | 10:49:32 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57366/tests/kraken/driver.html?testName=imaging-darkroom) 10:49:32 INFO - PROCESS | 3749 | RSS: Main: 165744640 10:49:32 INFO - PROCESS | 3749 | 10:49:36 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57366/tests/kraken/driver.html?testName=imaging-desaturate) 10:49:36 INFO - PROCESS | 3749 | RSS: Main: 165806080 10:49:36 INFO - PROCESS | 3749 | 10:49:39 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57366/tests/kraken/driver.html?testName=json-parse-financial) 10:49:40 INFO - PROCESS | 3749 | RSS: Main: 165842944 10:49:40 INFO - PROCESS | 3749 | 10:49:42 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57366/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:49:42 INFO - PROCESS | 3749 | RSS: Main: 166375424 10:49:42 INFO - PROCESS | 3749 | 10:49:44 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57366/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:49:45 INFO - PROCESS | 3749 | RSS: Main: 166531072 10:49:45 INFO - PROCESS | 3749 | 10:49:47 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57366/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:49:48 INFO - PROCESS | 3749 | RSS: Main: 166563840 10:49:48 INFO - PROCESS | 3749 | 10:49:51 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:49:51 INFO - PROCESS | 3749 | RSS: Main: 167030784 10:49:51 INFO - PROCESS | 3749 | 10:49:54 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:49:55 INFO - PROCESS | 3749 | RSS: Main: 167051264 10:49:55 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | Cycle 1(1): loaded http://localhost:57366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57366/tests/kraken/driver.html?testName=ai-astar) 10:49:57 INFO - PROCESS | 3749 | RSS: Main: 168701952 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | __start_tp_report 10:49:57 INFO - PROCESS | 3749 | _x_x_mozilla_page_load 10:49:57 INFO - PROCESS | 3749 | _x_x_mozilla_page_load_details 10:49:57 INFO - PROCESS | 3749 | |i|pagename|runs| 10:49:57 INFO - PROCESS | 3749 | |0;ai-astar;118;111;118;117;115;135;114;113;117;114 10:49:57 INFO - PROCESS | 3749 | |1;audio-beat-detection;167;132;163;183;142;158;162;133;201;134 10:49:57 INFO - PROCESS | 3749 | |2;audio-dft;163;165;166;172;164;166;162;164;165;163 10:49:57 INFO - PROCESS | 3749 | |3;audio-fft;77;75;76;163;75;75;74;77;159;74 10:49:57 INFO - PROCESS | 3749 | |4;audio-oscillator;96;95;153;96;98;95;149;95;95;144 10:49:57 INFO - PROCESS | 3749 | |5;imaging-gaussian-blur;118;118;117;118;119;119;119;119;120;118 10:49:57 INFO - PROCESS | 3749 | |6;imaging-darkroom;148;148;148;150;148;148;147;148;148;149 10:49:57 INFO - PROCESS | 3749 | |7;imaging-desaturate;95;96;96;96;95;95;95;97;96;96 10:49:57 INFO - PROCESS | 3749 | |8;json-parse-financial;67;69;67;67;68;67;67;82;65;64 10:49:57 INFO - PROCESS | 3749 | |9;json-stringify-tinderbox;65;65;65;70;64;66;65;65;66;66 10:49:57 INFO - PROCESS | 3749 | |10;stanford-crypto-aes;80;87;88;79;88;80;83;80;82;81 10:49:57 INFO - PROCESS | 3749 | |11;stanford-crypto-ccm;148;135;142;134;135;138;136;133;170;134 10:49:57 INFO - PROCESS | 3749 | |12;stanford-crypto-pbkdf2;181;178;172;174;173;174;172;178;175;175 10:49:57 INFO - PROCESS | 3749 | |13;stanford-crypto-sha256-iterative;75;74;72;74;74;73;76;73;76;71 10:49:57 INFO - PROCESS | 3749 | __end_tp_report 10:49:57 INFO - PROCESS | 3749 | __start_cc_report 10:49:57 INFO - PROCESS | 3749 | _x_x_mozilla_cycle_collect,961 10:49:57 INFO - PROCESS | 3749 | __end_cc_report 10:49:57 INFO - PROCESS | 3749 | __startTimestamp1461347397380__endTimestamp 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | ------- Summary: start ------- 10:49:57 INFO - PROCESS | 3749 | Number of tests: 14 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#0] ai-astar Cycles:10 Average:117.20 Median:117.00 stddev:6.66 (5.7%) stddev-sans-first:7.06 10:49:57 INFO - PROCESS | 3749 | Values: 118.0 111.0 118.0 117.0 115.0 135.0 114.0 113.0 117.0 114.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#1] audio-beat-detection Cycles:10 Average:157.50 Median:162.50 stddev:22.92 (14.1%) stddev-sans-first:24.05 10:49:57 INFO - PROCESS | 3749 | Values: 167.0 132.0 163.0 183.0 142.0 158.0 162.0 133.0 201.0 134.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.79 (1.7%) stddev-sans-first:2.86 10:49:57 INFO - PROCESS | 3749 | Values: 163.0 165.0 166.0 172.0 164.0 166.0 162.0 164.0 165.0 163.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:36.13 (48.2%) stddev-sans-first:37.88 10:49:57 INFO - PROCESS | 3749 | Values: 77.0 75.0 76.0 163.0 75.0 75.0 74.0 77.0 159.0 74.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:95.00 stddev:25.68 (27.0%) stddev-sans-first:26.61 10:49:57 INFO - PROCESS | 3749 | Values: 96.0 95.0 153.0 96.0 98.0 95.0 149.0 95.0 95.0 144.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 10:49:57 INFO - PROCESS | 3749 | Values: 118.0 118.0 117.0 118.0 119.0 119.0 119.0 119.0 120.0 118.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:49:57 INFO - PROCESS | 3749 | Values: 148.0 148.0 148.0 150.0 148.0 148.0 147.0 148.0 148.0 149.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 10:49:57 INFO - PROCESS | 3749 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 97.0 96.0 96.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:67.00 stddev:5.01 (7.5%) stddev-sans-first:5.29 10:49:57 INFO - PROCESS | 3749 | Values: 67.0 69.0 67.0 67.0 68.0 67.0 67.0 82.0 65.0 64.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.64 (2.5%) stddev-sans-first:1.72 10:49:57 INFO - PROCESS | 3749 | Values: 65.0 65.0 65.0 70.0 64.0 66.0 65.0 65.0 66.0 66.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:3.55 (4.3%) stddev-sans-first:3.62 10:49:57 INFO - PROCESS | 3749 | Values: 80.0 87.0 88.0 79.0 88.0 80.0 83.0 80.0 82.0 81.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:137.00 stddev:11.34 (8.3%) stddev-sans-first:11.69 10:49:57 INFO - PROCESS | 3749 | Values: 148.0 135.0 142.0 134.0 135.0 138.0 136.0 133.0 170.0 134.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:175.00 stddev:2.94 (1.7%) stddev-sans-first:2.24 10:49:57 INFO - PROCESS | 3749 | Values: 181.0 178.0 172.0 174.0 173.0 174.0 172.0 178.0 175.0 175.0 10:49:57 INFO - PROCESS | 3749 | 10:49:57 INFO - PROCESS | 3749 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.00 stddev:1.62 (2.2%) stddev-sans-first:1.66 10:49:57 INFO - PROCESS | 3749 | Values: 75.0 74.0 72.0 74.0 74.0 73.0 76.0 73.0 76.0 71.0 10:49:57 INFO - PROCESS | 3749 | -------- Summary: end -------- 10:49:57 INFO - PROCESS | 3749 | 10:49:58 INFO - TEST-INFO | 3749: exit 0 10:49:58 INFO - TEST-OK | kraken | took 64323ms 10:49:58 INFO - SUITE-END | took 1182s 10:49:58 INFO - Completed test suite (00:19:43) 10:49:58 INFO - javascript benchmark 10:49:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.577667573188, 2687.803927252373, 2694.7978901582387, 2719.1434698070107, 2721.238053345063, 4810.230363141898, 4813.109574728674, 4846.39420072491, 4862.124817532843, 4876.049170411771, 4643.233866412046, 4742.193827049401, 4778.426588809348, 4848.903021939559, 4890.095332363515, 4380.561943805626, 4468.642508599304, 4470.798814053375, 4488.483824360208, 4488.685791994561, 545.8245597524965, 4374.5188029316905, 4428.535003824601, 4450.910981780363, 4510.030343476152, 4435.068635586531, 4436.800343984529, 4441.0, 4444.0, 4484.775761211927, 4285.828566857322, 4522.3668686383935, 4538.614217791492, 4538.954610453886, 4565.680402371835, 4313.935290970638, 4317.050248945227, 4326.5673432656795, 4354.869353919387, 4361.236783562864, 4608.746518941457, 4629.513901040376, 4650.883727906796, 4674.766261686936, 4697.7181369117625, 5071.315372424712, 5079.5428411443145, 5112.769925353368, 5148.974255128738, 5246.501582349671, 5189.506996835295, 5226.033183860998, 5235.712035838027, 5240.266362709223, 5254.737263136828, 4870.732109733999, 4883.780229889663, 4885.462599114059, 4899.265110233422, 4920.040592084545, 5198.246254293182, 5328.254044433782, 5339.839804805862, 5417.0, 5431.2396264522995, 5022.698638081653, 5044.218146187347, 5047.646664733506, 5060.949390506122, 5085.898282034413, 5118.795248190105, 5120.078385890575, 5138.794448222104, 5141.948580514222, 5142.5628821549835, 5032.974835125801, 5034.244863270539, 5079.161938280143, 5119.411267704261, 5142.820001299937, 4943.505649435027, 5082.263071854634, 5093.312402825645, 5147.202183661464, 5160.948390516121, 4381.627561657295, 4443.555644435531, 4455.0, 4455.1757924784015, 4482.843100491467, 3702.33357995558, 3755.2301778135416, 3756.6431189037, 3788.4885540451687, 3818.9236215275537, 4404.8458303959205, 4429.069895321954, 4446.911061778811, 4482.574155455227, 4493.146302202571, 4979.103761322925, 5179.974100129475, 5216.739163041832, 5242.711650859239, 5245.186996015624, 4357.520672725997, 4395.956040439619, 4405.515393306734, 4433.202023635777, 4435.556444355603, 4613.907721845544, 4619.514950930104, 4628.236341003764, 4662.673612847068, 4704.435467743824, 4780.163471392423, 4846.491118432514, 4884.267359896044, 4891.095147397743, 4895.045466134141, 5029.84910452687, 5113.463086375877, 5119.5648369887485, 5165.715885626327, 5167.870803229799, 4754.381930349033, 4756.16767065769, 4769.14155452022, 4832.589229915356, 4844.297576851266, 4981.551660350586, 5001.699898006132, 5072.492750724898, 5107.719075450737, 5179.922301165561, 5120.257562653469, 5144.382674079135, 5158.97420512895, 5159.277701121771, 5169.0, 4920.966597014667, 4933.180982661775, 4965.081459929925, 4971.304017437489, 5012.248162775612, 4825.831095911626, 4947.975260123676, 4968.55283024515, 4981.651284410056, 4994.001199760135, 4799.208130658402, 4909.828156014522, 4926.827561035347, 4935.876603084952, 5047.864230548097, 5070.2394640802695, 5080.872978175427, 5090.41460232078, 5115.1559992600805, 5146.536811686966, 4860.149473842134, 4921.926171107365, 4989.950100499093, 5019.52314530119, 5063.5695965843315], "value": 4693.860037449503, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.4007961680044, 604.625132417901, 608.917796097527, 617.7374615788289, 636.6212103798239, 34857.30285394291, 36278.81860590696, 36296.818515907384, 36321.818390908076, 36525.0, 35278.82360588193, 36079.819600902025, 36103.458448123296, 36161.09597260063, 36203.09492262688, 7411.33298003181, 7534.359579435754, 7598.962005189994, 7599.468037237396, 7607.961960190191, 7566.281203285706, 7758.534487930714, 7788.610569471503, 7812.726554570591, 7823.452358334919, 7811.726589569366, 7834.921650783504, 7844.254795794419, 7894.6052697365185, 7923.564203968779, 7702.345300649452, 7734.303912647889, 7735.342495887856, 7782.766517004499, 7825.7260995865445, 7695.6152192390155, 7788.532688038736, 7796.064472263365, 7800.0, 7800.960995194988, 29547.0, 33512.83243583791, 33872.66127338744, 34057.829710851285, 34199.829000854836, 3036.3471853551373, 3048.481758101128, 3129.5618613394145, 3147.213196700825, 3156.7474602031784, 24271.393215169584, 24535.509289814105, 24816.255512334657, 25198.748012519824, 25752.0, 3239.2549713566013, 3389.813560254185, 3430.125318043908, 3454.0501362125365, 3514.9121271968406, 156554.0, 156679.21660391625, 158180.20909895492, 158259.20870395575, 158705.0, 32089.51865722016, 32389.35221295608, 32441.837790810896, 33289.001329959654, 34640.82679586586, 31619.20951976173, 32006.35987280288, 32154.19614509609, 32213.194670133435, 32314.35371292561, 12221.633350999484, 12423.62729118128, 12498.562550310695, 12508.437120329607, 12531.93734031324, 9519.714408567754, 9618.615255389706, 9628.807423851484, 9643.0, 9675.9032409675, 8106.959465202636, 8138.064122625856, 8231.753047408587, 8259.95870020658, 8293.95853020731, 3194.8242846643657, 3230.2893363460003, 3243.6107667079627, 3255.4791233402543, 3284.178955261185, 875.094277422877, 887.0863011098579, 996.9651062212788, 998.201438848918, 1053.5153829238636, 27649.308767280978, 28284.43431131366, 28937.0, 29080.85459572731, 29288.121356359345, 1023.7798873242289, 1028.7736697926443, 1043.8695163104612, 1069.8127827630133, 1132.0999805154756, 14843.628909277139, 15079.472218472301, 15511.45709900148, 15544.689106217813, 15648.374065037271, 367069.0, 367434.0, 368577.0, 369652.0, 370405.0, 49992.750036249585, 50422.74788626033, 50743.492565074615, 51083.0, 51186.48813511892, 1210.8123240897676, 1214.8663646998823, 1216.7262365967763, 1219.359836086062, 1274.8215249865027, 26969.460610788068, 27295.551299481223, 27745.07472152807, 28305.858470707513, 28591.85704071466, 43482.34776478292, 43535.346969794846, 43753.343699845165, 43840.780796095816, 44271.77864110659, 302891.0, 305000.0, 305648.0, 306400.0, 308893.0, 25849.0, 26046.479070418107, 26117.216483505526, 26132.477350453264, 26135.215943520965, 42625.0, 43092.0, 43989.78005110082, 44036.559634403246, 45450.0, 32087.77261617284, 36065.63934360623, 36840.26319473542, 36935.44596831103, 37139.81430092832, 35317.470237945934, 35323.470147947286, 35375.82312088423, 35477.1130721734, 35643.64356356507, 35590.28819423649, 36188.09529761777, 36272.45591316185, 37437.251254975294, 37799.24401512009, 27765.72234277712, 29404.264893377836, 29538.852305738335, 29551.556726648687, 29715.0, 23315.53368932578, 23430.76569234286, 23912.521749565258, 24066.39834004164, 24229.273121806375], "value": 15803.419100168343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.5155001597954, 379.66505988172725, 387.2004311097583, 394.84798352634226, 405.9959400405995, 15153.924230378847, 16528.0, 16832.495025149234, 16955.830441695594, 16986.915065424688, 14953.551393458187, 15168.620784480367, 15237.61905952349, 15261.618459538517, 15312.310946007428, 5036.244563315514, 5136.280920671109, 5200.531952124308, 5204.635675502697, 5205.609579281569, 3645.4531820227044, 5683.119116536944, 5974.0, 6015.759369625232, 6027.035674292114, 5042.899142017176, 5957.225560677128, 5963.4334738199805, 5969.462748352647, 5988.580799344048, 5260.289860868772, 5281.471852814726, 5303.098473259536, 5332.706701131437, 5348.358197016363, 4934.830068592034, 5407.783688652449, 5421.864453388657, 5442.265294185314, 5454.10007348787, 19484.610307793766, 19774.40676779699, 20361.287354942655, 20365.8981705092, 20474.18103275882, 1916.1090093106773, 1920.5870737791442, 1997.3209108902897, 2091.3307741522717, 2103.4531021934254, 9186.081391860827, 9436.292278079172, 9720.95139524305, 10833.512491937881, 13567.796483052762, 1782.0, 1889.2537447708216, 1898.8480921526245, 1904.9238030478764, 1913.655542002439, 67940.6602966987, 68994.0, 69267.0, 70461.2953870465, 71390.64304678443, 9946.403215807075, 10095.798084038279, 10115.14021308197, 10244.334118282288, 10274.22943279257, 14113.223772692396, 14226.502072427415, 14297.714045719027, 14298.28508574567, 14377.712445751236, 6803.625800580917, 6902.585844849325, 6917.9308206918295, 7031.29687031303, 7048.471364647672, 6336.271328797156, 6362.872742545216, 6365.713542890581, 6470.12653291809, 6579.111819904348, 4372.278574035312, 4458.417261872054, 4460.598546130864, 4491.977540112279, 4544.727316361029, 1702.778638776951, 1754.385964912296, 1857.0900258873055, 1862.9534261643296, 1906.104131058428, 874.8294082653821, 880.7181701855345, 931.8462453695064, 943.2831048403126, 954.9570269337758, 16013.279402426919, 16444.588885277964, 16649.41727039572, 16669.749953750703, 16811.0, 859.3383095016802, 881.7002219245487, 883.2845395229756, 915.8305713442901, 921.9354645174908, 8985.820283594423, 9198.862017069749, 9291.953540232256, 9440.007936114253, 9580.0898914603, 377886.0, 383685.0, 388211.0, 392231.0, 396630.0, 76509.61745191239, 77171.0, 77214.0, 77551.61224193955, 78423.21576784273, 924.7410724997012, 930.930180236485, 948.3977674176947, 954.613381580461, 954.9522523873778, 14732.158480189977, 14767.0, 14797.778033329294, 14861.256937153315, 14965.027273227206, 32391.676083238865, 33562.664373355954, 34436.139096522784, 34524.30951381008, 34964.650353497156, 42428.787856060524, 44397.33403999007, 46384.30423543717, 47905.04189916112, 48388.0, 4613.884652883705, 4749.3113498541825, 7075.363217310467, 7365.373943214672, 7856.803579910548, 8206.425550211428, 11146.164037697043, 11319.717007074889, 11399.259048161843, 11941.343226122299, 9864.668269783488, 10079.848802268118, 10149.949250253701, 10194.694159175237, 10600.250958591745, 10040.347377420445, 10135.189184865341, 10180.243132473912, 10263.7434064149, 10335.328203666737, 10175.338602990782, 10357.326773759682, 10487.737806554593, 10682.946585267024, 10689.625863094754, 7728.26581474759, 7735.729249476241, 7838.608069596611, 7949.602519873867, 7958.461975849392, 9402.717918462457, 10254.897451025394, 10282.280240383401, 10407.167426605702, 10412.167026638002], "value": 8152.222820925742, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.9637009074775, 1482.3181336585171, 1636.3045705575134, 1771.2472199315305, 1801.531601783536, 7030.296970302968, 7710.537367757932, 7720.189380115091, 7941.761747147588, 7965.6415461304305, 7595.12656044555, 7747.535147891131, 7764.456488045839, 7798.181190974937, 7838.882416763753, 2195.5169862630237, 2209.6464565669494, 2222.3333000099988, 2229.944251393712, 2234.318532847481, 2144.5710857828417, 2150.494633761065, 2193.024104273599, 2220.156340590573, 2226.7773222677683, 2146.5384942237415, 2190.518086021073, 2192.177933275022, 2192.9232476863313, 2209.812165965895, 2135.1032566322183, 2152.0315857863948, 2157.924472643466, 2159.7840215978354, 2164.7077644517944, 2127.478767701923, 2164.1343462614923, 2168.1002384010776, 2170.175333373308, 2186.464316242515, 7911.406644501685, 7919.96040019802, 7952.1650226726515, 7983.640736166828, 8006.55963921984, 4560.749158796265, 4634.513376095529, 4699.624030077585, 4712.175369310391, 4713.740744259065, 3051.862666180027, 3058.648255450629, 3124.172094394987, 3166.3667266546554, 3186.601674790651, 995.6813819577739, 1007.4861820471539, 1015.137133436573, 1025.8510468275504, 1027.209049032241, 11021.724456888562, 11043.061339786127, 11079.612213572485, 11112.055475284691, 11133.276337038067, 4245.681573881971, 4252.87241382759, 4456.509783923766, 4460.442444694413, 4479.216137175981, 9330.860037099448, 9371.859422108673, 9380.577873995686, 9396.201322887631, 9396.67111651089, 4830.3237546743485, 4838.443578988391, 4853.4418541867435, 4853.4418541867435, 4862.95137048632, 3768.1521657627363, 4281.207976524353, 4354.782260886943, 4365.476142862877, 4406.515283318897, 3640.399334109842, 3738.6074462181623, 3769.849206031783, 3803.581606023335, 3826.7321287510163, 1218.4090716002731, 1267.0687045021903, 1267.1636719765095, 1272.5291642092484, 1283.8587755346905, 715.9284071592904, 869.5217630303434, 887.7780554861284, 895.6686026170229, 921.6635927886273, 5394.352677678704, 5631.521320687705, 5700.743466544015, 5806.303243610793, 5927.288725352985, 922.7739203895088, 930.9534523273944, 955.9761005974906, 972.042538099971, 1028.4240825137947, 3769.566499852497, 3843.1929294847837, 3883.1845312484693, 3971.8014099295497, 3984.5019372578427, 9421.481818499911, 9659.951700241454, 9802.803943921082, 9806.90193098074, 9824.607015719434, 9546.284028697875, 9650.613975441043, 9667.613295468243, 9876.851847222297, 9980.800383992424, 7094.751683691046, 7397.334239918433, 7420.332170104716, 7477.0, 7523.134839493418, 5640.294963129609, 5647.407022262768, 5696.401877802771, 5709.086546152762, 5833.562482813721, 8753.562321884008, 8782.604782784661, 8834.823303533765, 8873.556322183995, 8930.330225233003, 9044.231240344381, 9118.179363857285, 9151.63393464254, 9172.082791720775, 9273.53632318395, 6373.3945275198785, 6836.658167091526, 6878.931210688029, 6985.5808651481075, 7129.893051604334, 7589.1272503662785, 7684.5389276641345, 7694.884576731241, 7695.807604809925, 7703.460757746904, 6729.528932974645, 6819.181698196248, 6856.5200435969, 6946.548474349152, 7011.404030657452, 6780.830479238059, 6804.4216241620015, 6817.0, 6923.653817309014, 7021.929780702332, 6136.447719705248, 6504.934950650622, 6534.379233972765, 6565.606063636197, 6631.436327911989, 4756.334113224082, 4828.637852161031, 4831.4685384608365, 4859.1010663027455, 4951.5048495150195, 4663.347131401674, 4761.262004389325, 4795.832145874878, 4921.0, 5123.846284611468], "value": 4283.057339859514, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.4642814359303, 320.61686284889555, 327.7509093089252, 328.43837038663884, 329.5682655721006, 5249.8950020999555, 5323.361196656407, 5394.1639045947895, 5427.538659213967, 5506.0, 5383.757730902119, 5396.784128634859, 5406.91889621656, 5425.945740542594, 5429.131338985763, 4222.662187025031, 4231.830726770925, 4249.787510624472, 4250.153610982066, 4255.553166917475, 4168.97915510422, 4236.978815105936, 4256.659467242629, 4274.487061552618, 4276.828926842923, 4208.473940757405, 4214.936775948363, 4216.114615930658, 4218.409422680812, 4241.34259189826, 4182.519010313792, 4182.895427614303, 4197.244495990721, 4202.453681021448, 4223.556526564713, 3723.1809002019513, 3723.757955732896, 3725.739198256123, 3735.655164140907, 3736.4021756518828, 4917.311576379309, 5169.53474187325, 5172.689638621695, 5192.662476939025, 5196.68819870809, 4774.450938142123, 4798.592119669832, 4799.208130658437, 4814.614830813562, 4825.493323201048, 5401.513863752242, 5691.886162276731, 5764.279465066867, 5773.2494775679315, 5778.7399567019165, 3959.891485184117, 3978.5822488638855, 3983.7609743415487, 3993.820278087493, 3995.680345572347, 5945.791897283574, 6006.279246490405, 6014.669193194372, 6024.3975602439405, 6027.8794424111275, 3988.4615576897327, 4067.389891516237, 4087.7547347159266, 4099.0, 4110.424540564323, 4132.442120313719, 4142.855000075043, 4148.066684995852, 4163.271427500236, 4165.10450253197, 4727.314539391838, 4745.525447455227, 4746.691465054761, 4765.451973023147, 4804.567588917014, 5163.0, 5732.627379220337, 5737.08206686928, 5740.799072032459, 5762.135679648086, 1422.118286662276, 1437.9352929118215, 1444.415011920153, 1447.3776276201334, 1447.5006122887587, 950.1733491862125, 953.3755390219279, 973.2019743810008, 976.3507267667064, 988.3871999360299, 4945.653804233741, 4947.455779864212, 4962.826301079445, 4963.255511673206, 4964.60283177345, 5904.261967254093, 5908.911366329508, 5921.348651648315, 5926.170336152942, 5952.9107063394085, 4778.37881075458, 4891.119598472309, 4912.45962944083, 4941.802327906844, 4967.5777558907175, 3150.4486714824816, 3156.463401221798, 3164.493681011073, 3166.4458719724416, 3183.793053451518, 5464.9180262296095, 5496.203050557727, 5501.0, 5505.724713764296, 5540.806071787549, 5861.794837180763, 6012.6392416455155, 6058.242719660043, 6071.817845464643, 6081.908771368433, 5386.703731294817, 5467.808626698046, 5483.177523371526, 5523.585731070106, 5525.392206857323, 5539.556835453073, 5809.651420914759, 5875.20684707559, 5880.26496687914, 5881.941180588139, 5858.736356863866, 5861.9413805861395, 5869.275233436953, 5880.088586269135, 5899.970500147643, 5563.7774489019985, 5570.749316280696, 5583.106702927512, 5598.916016259678, 5604.243427137448, 4014.159398075851, 4056.4320995061307, 4095.1367127957305, 4118.732282401635, 4134.793260336911, 5556.749946252347, 5724.284464441945, 5913.556483263858, 5914.0, 5967.940320596738, 5707.68607726579, 5729.3124825019595, 5737.225474560881, 5737.225474560881, 5741.3397459291045, 5648.971755141198, 5709.600327977002, 5721.0, 5726.685032323096, 5728.684922329146, 5475.172066141206, 5498.367687715964, 5606.85982850432, 5613.635113717595, 5629.155626655871, 5679.74441150141, 5690.557212886144, 5730.169125476866, 5747.7413516391025, 5788.565857560784, 5493.917591236214, 5607.8878422432135, 5608.495235428831, 5611.352620796515, 5617.831465056055], "value": 4274.322858013545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.6931342806164, 764.1327093748594, 769.119502815616, 782.4757412533602, 797.2346547314579, 11277.605283815057, 11607.709807254823, 11622.651320460389, 11644.883551164487, 11653.592124275652, 12004.399780011008, 12105.878941210607, 12138.211016283936, 12145.757084858298, 12154.513819447211, 640.266894405905, 797.3143096936644, 803.8512875118092, 810.1412502747078, 811.5577010529246, 785.1402714028159, 807.64059993303, 812.7399232245684, 813.5810057820228, 814.7189219719187, 857.0401150711181, 860.5396113079472, 864.7449002544264, 867.397158974513, 869.7955980344614, 859.0936561927195, 862.5126803356115, 863.3093525179862, 864.1876635962176, 866.0386970462781, 625.6402568523072, 626.3548544998658, 626.7774939896362, 627.4384425938805, 627.937206279373, 11264.887351126466, 11391.202615816896, 11404.429778511041, 11437.885621143849, 11481.0, 12156.939215303955, 12243.571474998333, 12502.3748812559, 12515.56195533161, 12564.81152782709, 9764.51177441125, 9902.257330700226, 9947.10476057151, 9967.501624918725, 10269.486525673761, 3369.22507823202, 3371.3594417060926, 3378.527006219131, 3386.5597472328686, 3499.5450591423205, 46575.53424465746, 46743.53256467426, 46932.0, 48083.75958120257, 48155.518444815454, 10296.330738501973, 10342.930496974064, 10395.792084158275, 10415.1667866572, 10475.580976760844, 16408.83591164073, 18243.72634410485, 18386.81613183878, 18431.631367372847, 18502.537436563925, 7010.859782804316, 7062.258462861326, 7092.6099064551945, 7199.460040496983, 7318.938753880658, 3786.638447408325, 3843.1737176507186, 3845.250176215611, 3866.3813789794062, 3868.8259028343227, 2876.0, 2948.189247956829, 2958.2160727407254, 2965.8813647453862, 2972.048944337791, 521.5202014146994, 527.1697077103577, 535.253321616343, 539.7116227196658, 541.9430959749249, 501.8268697299426, 563.5519761789305, 608.5983251054283, 624.2976651267325, 626.8683576448906, 7718.729844455417, 8104.6222142235965, 8105.351571874236, 8207.466514676527, 8264.793380165424, 547.7836254679379, 618.1593033474471, 622.4957784194817, 639.6705696566272, 664.8105289992426, 3745.4943582615997, 3758.342290099222, 3812.218495208476, 3859.1702783901596, 3867.555231148454, 50016.24975625369, 50236.74881625642, 50375.24437133446, 50466.24300635493, 50884.236736448984, 44770.32844507335, 44927.550724492336, 46352.0, 46438.5356146441, 46722.0, 41700.1659966799, 41958.16083678309, 42551.0, 42635.786821066315, 43297.56702432936, 7498.58757768328, 7564.357029652321, 7611.581363025087, 7628.732994345171, 7643.388528917784, 29320.413591728473, 29450.0, 29586.112416626675, 29751.404971900007, 30017.5497367544, 37330.81334593309, 37374.252514950094, 37393.0, 38300.233995320494, 38352.6164738349, 9541.188998935168, 9607.711768646952, 9692.17616502577, 9739.853902191615, 9742.659006934724, 10353.792924141626, 10402.895971040192, 10413.36398224478, 10435.530401131815, 10449.634262800766, 9525.809483810146, 9742.220622350053, 9786.706398808046, 9949.303548751517, 9996.400215987063, 9779.559919803769, 9922.40465572068, 9924.255680824112, 10069.446180460145, 10110.545025473724, 9637.132658060807, 9852.458114803754, 10061.547230374797, 10151.796964060824, 10265.281430299807, 8710.608022639124, 8766.0, 8770.824583508167, 8774.56127193625, 9282.72151835446, 8653.653853845775, 8744.650213991368, 8825.38222324431, 8882.777930551789, 8898.799620566999], "value": 5849.021387700549, "unit": "score"}], "name": "dromaeo_css", "value": 6336.996923912463, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 111.0, 118.0, 117.0, 115.0, 135.0, 114.0, 113.0, 117.0, 114.0], "value": 117.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 132.0, 163.0, 183.0, 142.0, 158.0, 162.0, 133.0, 201.0, 134.0], "value": 157.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 172.0, 164.0, 166.0, 162.0, 164.0, 165.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 163.0, 75.0, 75.0, 74.0, 77.0, 159.0, 74.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 153.0, 96.0, 98.0, 95.0, 149.0, 95.0, 95.0, 144.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 119.0, 119.0, 119.0, 119.0, 120.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 150.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 67.0, 68.0, 67.0, 67.0, 82.0, 65.0, 64.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 70.0, 64.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 88.0, 79.0, 88.0, 80.0, 83.0, 80.0, 82.0, 81.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 135.0, 142.0, 134.0, 135.0, 138.0, 136.0, 133.0, 170.0, 134.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 178.0, 172.0, 174.0, 173.0, 174.0, 172.0, 178.0, 175.0, 175.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 72.0, 74.0, 74.0, 73.0, 76.0, 73.0, 76.0, 71.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1612.5, "alertThreshold": 2.0}]} 10:49:58 INFO - Return code: 0 10:49:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:49:58 ERROR - # TBPL SUCCESS # 10:49:58 INFO - Running post-action listener: _resource_record_post_action 10:49:58 INFO - Running post-run listener: _resource_record_post_run 10:49:59 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7921664; Write bytes: 300916736; Read time: 1428; Write time: 265196 10:49:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15376384; Read time: 0; Write time: 6720 10:49:59 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 6160384; Write bytes: 285540352; Read time: 1356; Write time: 258476 10:49:59 INFO - Running post-run listener: _upload_blobber_files 10:49:59 INFO - Blob upload gear active. 10:49:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:49:59 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 10:49:59 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:49:59 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:50:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:50:01 INFO - (blobuploader) - INFO - Done attempting. 10:50:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:50:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:50:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:50:01 INFO - (blobuploader) - INFO - Done attempting. 10:50:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:50:01 INFO - Return code: 0 10:50:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:50:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:50:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64ddf85fff6d1d5f6f795ae949165b2c6e9946768d20ed5b08f161471a487f79c349358e77f64e53b8ebdedf74c99f10dcdd3e4868a4a0e9fa55a54d1fa74e2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95d1d9ae1c27b9a019049a8a6a71e50c5139f6c9bc228ba9724c610cf9fc90d3c6ddc8376d2f8c989584701a6bb70666af50d4aa972b2c875af535b2d7e62de1"} 10:50:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:50:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:50:01 INFO - Contents: 10:50:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64ddf85fff6d1d5f6f795ae949165b2c6e9946768d20ed5b08f161471a487f79c349358e77f64e53b8ebdedf74c99f10dcdd3e4868a4a0e9fa55a54d1fa74e2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95d1d9ae1c27b9a019049a8a6a71e50c5139f6c9bc228ba9724c610cf9fc90d3c6ddc8376d2f8c989584701a6bb70666af50d4aa972b2c875af535b2d7e62de1"} 10:50:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:50:01 INFO - Copying logs to upload dir... 10:50:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:50:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1304.517976 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-04-22 10:50:02.075413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 10:50:02.083405) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192 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-Non-PGO/sha512/64ddf85fff6d1d5f6f795ae949165b2c6e9946768d20ed5b08f161471a487f79c349358e77f64e53b8ebdedf74c99f10dcdd3e4868a4a0e9fa55a54d1fa74e2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95d1d9ae1c27b9a019049a8a6a71e50c5139f6c9bc228ba9724c610cf9fc90d3c6ddc8376d2f8c989584701a6bb70666af50d4aa972b2c875af535b2d7e62de1"} build_url:https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/SZ2UfKcoSwyHPkeDXMCZYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64ddf85fff6d1d5f6f795ae949165b2c6e9946768d20ed5b08f161471a487f79c349358e77f64e53b8ebdedf74c99f10dcdd3e4868a4a0e9fa55a54d1fa74e2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95d1d9ae1c27b9a019049a8a6a71e50c5139f6c9bc228ba9724c610cf9fc90d3c6ddc8376d2f8c989584701a6bb70666af50d4aa972b2c875af535b2d7e62de1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 10:50:02.110492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 10:50:02.110818) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461346091.488044-1232286192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 10:50:02.191743) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 10:50:02.195094) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 10:50:02.195402) ========= ========= Total master_lag: 0.19 =========