builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1463067715.5 results: success (0) buildid: 20160512053006 builduid: 6b2d49f9d5b94a34aa058938e529741e revision: 092d7ffc5eeed5c0096117fff18638bbda0ebf6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:55.504674) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:55.505124) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:55.505417) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:55.521426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:55.521762) ========= 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=62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 08:41:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-12 08:41:56 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137366 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:55.672420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:55.672796) ========= 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=62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015685 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:55.722641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 08:41:55.723000) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 092d7ffc5eeed5c0096117fff18638bbda0ebf6e --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 092d7ffc5eeed5c0096117fff18638bbda0ebf6e --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=62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 08:41:56,170 truncating revision to first 12 chars 2016-05-12 08:41:56,170 Setting DEBUG logging. 2016-05-12 08:41:56,170 attempt 1/10 2016-05-12 08:41:56,170 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/092d7ffc5eee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 08:41:57,566 unpacking tar archive at: fx-team-092d7ffc5eee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.705956 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 08:41:57.441989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:57.442319) ========= script_repo_revision: 092d7ffc5eeed5c0096117fff18638bbda0ebf6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:57.443008) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:57.443285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 08:41:57.451991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-12 08:41:57.452310) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:41:57 INFO - MultiFileLogger online at 20160512 08:41:57 in /builds/slave/test 08:41:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:41:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:57 INFO - {'append_to_log': False, 08:41:57 INFO - 'base_work_dir': '/builds/slave/test', 08:41:57 INFO - 'blob_upload_branch': 'Fx-Team', 08:41:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:57 INFO - 'branch': 'Fx-Team', 08:41:57 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:57 INFO - 'config_files': ('talos/linux_config.py',), 08:41:57 INFO - 'default_actions': ('clobber', 08:41:57 INFO - 'read-buildbot-config', 08:41:57 INFO - 'download-and-extract', 08:41:57 INFO - 'populate-webroot', 08:41:57 INFO - 'create-virtualenv', 08:41:57 INFO - 'install', 08:41:57 INFO - 'run-tests'), 08:41:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:57 INFO - 'download_minidump_stackwalk': True, 08:41:57 INFO - 'download_symbols': 'ondemand', 08:41:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:57 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:57 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:57 INFO - 'installer_path': 'installer.exe', 08:41:57 INFO - 'log_level': 'info', 08:41:57 INFO - 'log_name': 'talos', 08:41:57 INFO - 'log_to_console': True, 08:41:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:41:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:41:57 INFO - 'opt_config_files': (), 08:41:57 INFO - 'pip_index': False, 08:41:57 INFO - 'sps_profile': False, 08:41:57 INFO - 'sps_profile_interval': 0, 08:41:57 INFO - 'suite': 'dromaeojs-e10s', 08:41:57 INFO - 'system_bits': '32', 08:41:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:57 INFO - 'title': 'talos-linux64-ix-018', 08:41:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:57 INFO - 'use_talos_json': True, 08:41:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:57 INFO - 'work_dir': 'build'} 08:41:57 INFO - ##### 08:41:57 INFO - ##### Running clobber step. 08:41:57 INFO - ##### 08:41:57 INFO - Running pre-action listener: _resource_record_pre_action 08:41:57 INFO - Running main action method: clobber 08:41:57 INFO - rmtree: /builds/slave/test/build 08:41:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:58 INFO - Running post-action listener: _resource_record_post_action 08:41:58 INFO - ##### 08:41:58 INFO - ##### Finished clobber step (success) 08:41:58 INFO - ##### 08:41:58 INFO - ##### 08:41:58 INFO - ##### Running read-buildbot-config step. 08:41:58 INFO - ##### 08:41:58 INFO - Running pre-action listener: _resource_record_pre_action 08:41:58 INFO - Running main action method: read_buildbot_config 08:41:58 INFO - Using buildbot properties: 08:41:58 INFO - { 08:41:58 INFO - "project": "", 08:41:58 INFO - "product": "firefox", 08:41:58 INFO - "script_repo_revision": "production", 08:41:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:41:58 INFO - "repository": "", 08:41:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:41:58 INFO - "buildid": "20160512053006", 08:41:58 INFO - "pgo_build": "True", 08:41:58 INFO - "basedir": "/builds/slave/test", 08:41:58 INFO - "buildnumber": 459, 08:41:58 INFO - "slavename": "talos-linux64-ix-018", 08:41:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:41:58 INFO - "platform": "ubuntu64_hw", 08:41:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:41:58 INFO - "branch": "fx-team", 08:41:58 INFO - "repo_path": "integration/fx-team", 08:41:58 INFO - "revision": "092d7ffc5eeed5c0096117fff18638bbda0ebf6e", 08:41:58 INFO - "stage_platform": "linux64-pgo", 08:41:58 INFO - "builduid": "6b2d49f9d5b94a34aa058938e529741e", 08:41:58 INFO - "slavebuilddir": "test" 08:41:58 INFO - } 08:41:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:41:58 INFO - Running post-action listener: _resource_record_post_action 08:41:58 INFO - ##### 08:41:58 INFO - ##### Finished read-buildbot-config step (success) 08:41:58 INFO - ##### 08:41:58 INFO - ##### 08:41:58 INFO - ##### Running download-and-extract step. 08:41:58 INFO - ##### 08:41:58 INFO - Running pre-action listener: _resource_record_pre_action 08:41:58 INFO - Running main action method: download_and_extract 08:41:58 INFO - mkdir: /builds/slave/test/build/tests 08:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:58 INFO - https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:41:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:41:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:41:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:41:59 INFO - Downloaded 1361 bytes. 08:41:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:41:59 INFO - Using the following test package requirements: 08:41:59 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:59 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:41:59 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:41:59 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:59 INFO - u'jsshell-linux-x86_64.zip'], 08:41:59 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:41:59 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:59 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:41:59 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:41:59 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:41:59 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:41:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:41:59 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')]} 08:41:59 INFO - https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:00 INFO - Downloaded 23902869 bytes. 08:42:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:01 INFO - Return code: 0 08:42:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:01 INFO - https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:42:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:42:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:42:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:02 INFO - Downloaded 23902869 bytes. 08:42:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:04 INFO - Return code: 0 08:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:04 INFO - https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:42:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:42:05 INFO - Downloaded 10840239 bytes. 08:42:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:42:05 INFO - Return code: 0 08:42:05 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')]} 08:42:05 INFO - https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:42:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:42:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:42:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:42:06 INFO - Downloaded 58336046 bytes. 08:42:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:42:06 INFO - mkdir: /builds/slave/test/properties 08:42:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:06 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:06 INFO - Contents: 08:42:06 INFO - build_url:https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:42:07 INFO - Running post-action listener: _resource_record_post_action 08:42:07 INFO - Running post-action listener: set_extra_try_arguments 08:42:07 INFO - ##### 08:42:07 INFO - ##### Finished download-and-extract step (success) 08:42:07 INFO - ##### 08:42:07 INFO - ##### 08:42:07 INFO - ##### Running populate-webroot step. 08:42:07 INFO - ##### 08:42:07 INFO - Running pre-action listener: _resource_record_pre_action 08:42:07 INFO - Running main action method: populate_webroot 08:42:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:07 INFO - '--tppagecycles', 08:42:07 INFO - '7'], 08:42:07 INFO - 'tests': ['tsvgm']}}, 08:42:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:07 INFO - 'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:07 INFO - 'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['damp', 'tps']}, 08:42:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:07 INFO - 'tests': ['damp', 'tps']}, 08:42:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['dromaeo_dom']}, 08:42:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['a11yr', 08:42:07 INFO - 'ts_paint', 08:42:07 INFO - 'tpaint', 08:42:07 INFO - 'sessionrestore', 08:42:07 INFO - 'sessionrestore_no_auto_restore', 08:42:07 INFO - 'tabpaint']}, 08:42:07 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:07 INFO - 'ts_paint', 08:42:07 INFO - 'tpaint', 08:42:07 INFO - 'sessionrestore', 08:42:07 INFO - 'sessionrestore_no_auto_restore', 08:42:07 INFO - 'tabpaint']}, 08:42:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:07 INFO - 'ts_paint', 08:42:07 INFO - 'tpaint', 08:42:07 INFO - 'sessionrestore', 08:42:07 INFO - 'sessionrestore_no_auto_restore', 08:42:07 INFO - 'tabpaint']}, 08:42:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:07 INFO - 'ts_paint', 08:42:07 INFO - 'tpaint', 08:42:07 INFO - 'sessionrestore', 08:42:07 INFO - 'sessionrestore_no_auto_restore', 08:42:07 INFO - 'tabpaint']}, 08:42:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['a11yr', 08:42:07 INFO - 'ts_paint', 08:42:07 INFO - 'tpaint', 08:42:07 INFO - 'sessionrestore', 08:42:07 INFO - 'sessionrestore_no_auto_restore', 08:42:07 INFO - 'tabpaint']}, 08:42:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['a11yr', 08:42:07 INFO - 'ts_paint', 08:42:07 INFO - 'tpaint', 08:42:07 INFO - 'sessionrestore', 08:42:07 INFO - 'sessionrestore_no_auto_restore', 08:42:07 INFO - 'tabpaint']}, 08:42:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['tsvgx', 08:42:07 INFO - 'tsvgr_opacity', 08:42:07 INFO - 'tart', 08:42:07 INFO - 'tscrollx', 08:42:07 INFO - 'cart']}, 08:42:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:07 INFO - 'tsvgr_opacity', 08:42:07 INFO - 'tart', 08:42:07 INFO - 'tscrollx', 08:42:07 INFO - 'cart']}, 08:42:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:07 INFO - 'talos_options': ['--disable-e10s'], 08:42:07 INFO - 'tests': ['tp5o']}, 08:42:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:07 INFO - 'tests': ['tp5o']}, 08:42:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:07 INFO - 'talos_options': ['--disable-e10s', 08:42:07 INFO - '--xperf_path', 08:42:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:07 INFO - 'tests': ['tp5n']}, 08:42:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:07 INFO - 'talos_options': ['--xperf_path', 08:42:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:07 INFO - 'tests': ['tp5n']}}, 08:42:07 INFO - 'talos.zip': {'path': '', 08:42:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:07 INFO - Running post-action listener: _resource_record_post_action 08:42:07 INFO - ##### 08:42:07 INFO - ##### Finished populate-webroot step (success) 08:42:07 INFO - ##### 08:42:07 INFO - ##### 08:42:07 INFO - ##### Running create-virtualenv step. 08:42:07 INFO - ##### 08:42:07 INFO - Running pre-action listener: _resource_record_pre_action 08:42:07 INFO - Running main action method: create_virtualenv 08:42:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:07 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 08:42:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:07 INFO - Using real prefix '/usr' 08:42:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:10 INFO - Installing pip.................done. 08:42:10 INFO - Return code: 0 08:42:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:10 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 0x7f44e4bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', '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 08:42:10 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 08:42:10 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 08:42:10 INFO - Using env: {'DISPLAY': ':0', 08:42:10 INFO - 'HOME': '/home/cltbld', 08:42:10 INFO - 'LANG': 'en_US.UTF-8', 08:42:10 INFO - 'LANGUAGE': 'en_US:en', 08:42:10 INFO - 'LOGNAME': 'cltbld', 08:42:10 INFO - 'MAIL': '/var/mail/cltbld', 08:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:10 INFO - 'MOZ_NO_REMOTE': '1', 08:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:10 INFO - 'NO_EM_RESTART': '1', 08:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:10 INFO - 'PWD': '/builds/slave/test', 08:42:10 INFO - 'SHELL': '/bin/bash', 08:42:10 INFO - 'SHLVL': '1', 08:42:10 INFO - 'TERM': 'linux', 08:42:10 INFO - 'TMOUT': '86400', 08:42:10 INFO - 'USER': 'cltbld', 08:42:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:10 INFO - '_': '/tools/buildbot/bin/python'} 08:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:10 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 08:42:10 INFO - Cleaning up... 08:42:10 INFO - Return code: 0 08:42:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:10 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 0x7f44e4bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', '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 08:42:10 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 08:42:10 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 08:42:10 INFO - Using env: {'DISPLAY': ':0', 08:42:10 INFO - 'HOME': '/home/cltbld', 08:42:10 INFO - 'LANG': 'en_US.UTF-8', 08:42:10 INFO - 'LANGUAGE': 'en_US:en', 08:42:10 INFO - 'LOGNAME': 'cltbld', 08:42:10 INFO - 'MAIL': '/var/mail/cltbld', 08:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:10 INFO - 'MOZ_NO_REMOTE': '1', 08:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:10 INFO - 'NO_EM_RESTART': '1', 08:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:10 INFO - 'PWD': '/builds/slave/test', 08:42:10 INFO - 'SHELL': '/bin/bash', 08:42:10 INFO - 'SHLVL': '1', 08:42:10 INFO - 'TERM': 'linux', 08:42:10 INFO - 'TMOUT': '86400', 08:42:10 INFO - 'USER': 'cltbld', 08:42:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:10 INFO - '_': '/tools/buildbot/bin/python'} 08:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:10 INFO - Downloading/unpacking psutil>=0.7.1 08:42:10 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 08:42:10 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 08:42:10 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 08:42:10 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 08:42:10 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 08:42:10 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 08:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:12 INFO - Installing collected packages: psutil 08:42:12 INFO - Running setup.py install for psutil 08:42:12 INFO - building 'psutil._psutil_linux' extension 08:42:12 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 08:42:12 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 08:42:13 INFO - building 'psutil._psutil_posix' extension 08:42:13 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 08:42:13 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 08:42:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:13 INFO - Successfully installed psutil 08:42:13 INFO - Cleaning up... 08:42:13 INFO - Return code: 0 08:42:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:42:13 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')]} 08:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:13 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')]} 08:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:13 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 0x7f44e4bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', '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 08:42:13 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 08:42:13 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 08:42:13 INFO - Using env: {'DISPLAY': ':0', 08:42:13 INFO - 'HOME': '/home/cltbld', 08:42:13 INFO - 'LANG': 'en_US.UTF-8', 08:42:13 INFO - 'LANGUAGE': 'en_US:en', 08:42:13 INFO - 'LOGNAME': 'cltbld', 08:42:13 INFO - 'MAIL': '/var/mail/cltbld', 08:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:13 INFO - 'MOZ_NO_REMOTE': '1', 08:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:13 INFO - 'NO_EM_RESTART': '1', 08:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:13 INFO - 'PWD': '/builds/slave/test', 08:42:13 INFO - 'SHELL': '/bin/bash', 08:42:13 INFO - 'SHLVL': '1', 08:42:13 INFO - 'TERM': 'linux', 08:42:13 INFO - 'TMOUT': '86400', 08:42:13 INFO - 'USER': 'cltbld', 08:42:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:13 INFO - '_': '/tools/buildbot/bin/python'} 08:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:42:13 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 08:42:13 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 08:42:13 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 08:42:13 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 08:42:13 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 08:42:13 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 08:42:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:42:15 INFO - Installing collected packages: mozsystemmonitor 08:42:15 INFO - Running setup.py install for mozsystemmonitor 08:42:15 INFO - Successfully installed mozsystemmonitor 08:42:15 INFO - Cleaning up... 08:42:15 INFO - Return code: 0 08:42:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:15 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 0x7f44e4bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', '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 08:42:15 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 08:42:15 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 08:42:15 INFO - Using env: {'DISPLAY': ':0', 08:42:15 INFO - 'HOME': '/home/cltbld', 08:42:15 INFO - 'LANG': 'en_US.UTF-8', 08:42:15 INFO - 'LANGUAGE': 'en_US:en', 08:42:15 INFO - 'LOGNAME': 'cltbld', 08:42:15 INFO - 'MAIL': '/var/mail/cltbld', 08:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:15 INFO - 'MOZ_NO_REMOTE': '1', 08:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:15 INFO - 'NO_EM_RESTART': '1', 08:42:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:15 INFO - 'PWD': '/builds/slave/test', 08:42:15 INFO - 'SHELL': '/bin/bash', 08:42:15 INFO - 'SHLVL': '1', 08:42:15 INFO - 'TERM': 'linux', 08:42:15 INFO - 'TMOUT': '86400', 08:42:15 INFO - 'USER': 'cltbld', 08:42:15 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:15 INFO - '_': '/tools/buildbot/bin/python'} 08:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:15 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:18 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 08:42:18 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 08:42:18 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 08:42:18 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 08:42:18 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 08:42:18 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 08:42:18 INFO - Downloading docopt-0.6.1.tar.gz 08:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:18 INFO - Running setup.py install for blobuploader 08:42:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:18 INFO - Running setup.py install for requests 08:42:18 INFO - Running setup.py install for docopt 08:42:18 INFO - Successfully installed blobuploader requests docopt 08:42:18 INFO - Cleaning up... 08:42:19 INFO - Return code: 0 08:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:19 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 0x7f44e4bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', '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 08:42:19 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 08:42:19 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 08:42:19 INFO - Using env: {'DISPLAY': ':0', 08:42:19 INFO - 'HOME': '/home/cltbld', 08:42:19 INFO - 'LANG': 'en_US.UTF-8', 08:42:19 INFO - 'LANGUAGE': 'en_US:en', 08:42:19 INFO - 'LOGNAME': 'cltbld', 08:42:19 INFO - 'MAIL': '/var/mail/cltbld', 08:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:19 INFO - 'MOZ_NO_REMOTE': '1', 08:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:19 INFO - 'NO_EM_RESTART': '1', 08:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:19 INFO - 'PWD': '/builds/slave/test', 08:42:19 INFO - 'SHELL': '/bin/bash', 08:42:19 INFO - 'SHLVL': '1', 08:42:19 INFO - 'TERM': 'linux', 08:42:19 INFO - 'TMOUT': '86400', 08:42:19 INFO - 'USER': 'cltbld', 08:42:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:19 INFO - '_': '/tools/buildbot/bin/python'} 08:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:19 INFO - Running setup.py (path:/tmp/pip-qowfUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:19 INFO - Running setup.py (path:/tmp/pip-sWGQOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:19 INFO - Running setup.py (path:/tmp/pip-mrcqgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:19 INFO - Running setup.py (path:/tmp/pip-F4BvgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:19 INFO - Running setup.py (path:/tmp/pip-pno5px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:19 INFO - Running setup.py (path:/tmp/pip-F8RtJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:19 INFO - Running setup.py (path:/tmp/pip-YbNQGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:19 INFO - Running setup.py (path:/tmp/pip-AxDV_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:19 INFO - Running setup.py (path:/tmp/pip-noXPLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:19 INFO - Running setup.py (path:/tmp/pip-Z9UajL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:19 INFO - Running setup.py (path:/tmp/pip-ohSfy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:20 INFO - Running setup.py (path:/tmp/pip-GDejix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:20 INFO - Running setup.py (path:/tmp/pip-Res5eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:20 INFO - Running setup.py (path:/tmp/pip-UL5NHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:20 INFO - Running setup.py (path:/tmp/pip-007Jz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:20 INFO - Running setup.py (path:/tmp/pip-m_Sxg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:20 INFO - Running setup.py (path:/tmp/pip-IKAaLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:20 INFO - Running setup.py install for manifestparser 08:42:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:20 INFO - Running setup.py install for mozcrash 08:42:20 INFO - Running setup.py install for mozdebug 08:42:20 INFO - Running setup.py install for mozdevice 08:42:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:20 INFO - Running setup.py install for mozfile 08:42:20 INFO - Running setup.py install for mozhttpd 08:42:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Running setup.py install for mozinfo 08:42:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Running setup.py install for mozInstall 08:42:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Running setup.py install for mozleak 08:42:21 INFO - Running setup.py install for mozlog 08:42:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Running setup.py install for moznetwork 08:42:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Running setup.py install for mozprocess 08:42:21 INFO - Running setup.py install for mozprofile 08:42:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Running setup.py install for mozrunner 08:42:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:21 INFO - Running setup.py install for mozscreenshot 08:42:22 INFO - Running setup.py install for moztest 08:42:22 INFO - Running setup.py install for mozversion 08:42:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:22 INFO - Cleaning up... 08:42:22 INFO - Return code: 0 08:42:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:22 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 0x7f44e4bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', '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 08:42:22 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 08:42:22 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 08:42:22 INFO - Using env: {'DISPLAY': ':0', 08:42:22 INFO - 'HOME': '/home/cltbld', 08:42:22 INFO - 'LANG': 'en_US.UTF-8', 08:42:22 INFO - 'LANGUAGE': 'en_US:en', 08:42:22 INFO - 'LOGNAME': 'cltbld', 08:42:22 INFO - 'MAIL': '/var/mail/cltbld', 08:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:22 INFO - 'MOZ_NO_REMOTE': '1', 08:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:22 INFO - 'NO_EM_RESTART': '1', 08:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:22 INFO - 'PWD': '/builds/slave/test', 08:42:22 INFO - 'SHELL': '/bin/bash', 08:42:22 INFO - 'SHLVL': '1', 08:42:22 INFO - 'TERM': 'linux', 08:42:22 INFO - 'TMOUT': '86400', 08:42:22 INFO - 'USER': 'cltbld', 08:42:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:22 INFO - '_': '/tools/buildbot/bin/python'} 08:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:22 INFO - Running setup.py (path:/tmp/pip-iuFHjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:22 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)) 08:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:22 INFO - Running setup.py (path:/tmp/pip-BFwqkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:22 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)) 08:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:22 INFO - Running setup.py (path:/tmp/pip-pIsJ3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:22 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)) 08:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:22 INFO - Running setup.py (path:/tmp/pip-djQMI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:22 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)) 08:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:22 INFO - Running setup.py (path:/tmp/pip-q3MGh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:22 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)) 08:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:22 INFO - Running setup.py (path:/tmp/pip-4Qqoig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:22 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)) 08:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:22 INFO - Running setup.py (path:/tmp/pip-NXVjbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:22 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)) 08:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:22 INFO - Running setup.py (path:/tmp/pip-9aPKeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:23 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)) 08:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:23 INFO - Running setup.py (path:/tmp/pip-c5bktP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:23 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)) 08:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:23 INFO - Running setup.py (path:/tmp/pip-ui2TBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:23 INFO - Running setup.py (path:/tmp/pip-Jj4pCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:23 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)) 08:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:23 INFO - Running setup.py (path:/tmp/pip-Fzk9HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:23 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)) 08:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:23 INFO - Running setup.py (path:/tmp/pip-Th2gz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:23 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)) 08:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:23 INFO - Running setup.py (path:/tmp/pip-8YStz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:23 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)) 08:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:23 INFO - Running setup.py (path:/tmp/pip-zqv_oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:23 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)) 08:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:23 INFO - Running setup.py (path:/tmp/pip-KI2kL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:23 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)) 08:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:23 INFO - Running setup.py (path:/tmp/pip-zqirrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:23 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)) 08:42:23 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)) 08:42:23 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)) 08:42:23 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)) 08:42:23 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)) 08:42:23 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)) 08:42:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:23 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 08:42:23 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 08:42:23 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 08:42:23 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 08:42:23 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 08:42:23 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 08:42:25 INFO - Downloading blessings-1.6.tar.gz 08:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:25 INFO - Installing collected packages: blessings 08:42:25 INFO - Running setup.py install for blessings 08:42:25 INFO - Successfully installed blessings 08:42:25 INFO - Cleaning up... 08:42:25 INFO - Return code: 0 08:42:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:26 INFO - Reading from file tmpfile_stdout 08:42:26 INFO - Current package versions: 08:42:26 INFO - argparse == 1.2.1 08:42:26 INFO - blessings == 1.6 08:42:26 INFO - blobuploader == 1.2.4 08:42:26 INFO - docopt == 0.6.1 08:42:26 INFO - manifestparser == 1.1 08:42:26 INFO - mozInstall == 1.12 08:42:26 INFO - mozcrash == 0.17 08:42:26 INFO - mozdebug == 0.1 08:42:26 INFO - mozdevice == 0.48 08:42:26 INFO - mozfile == 1.2 08:42:26 INFO - mozhttpd == 0.7 08:42:26 INFO - mozinfo == 0.9 08:42:26 INFO - mozleak == 0.1 08:42:26 INFO - mozlog == 3.2 08:42:26 INFO - moznetwork == 0.27 08:42:26 INFO - mozprocess == 0.22 08:42:26 INFO - mozprofile == 0.28 08:42:26 INFO - mozrunner == 6.11 08:42:26 INFO - mozscreenshot == 0.1 08:42:26 INFO - mozsystemmonitor == 0.0 08:42:26 INFO - moztest == 0.7 08:42:26 INFO - mozversion == 1.4 08:42:26 INFO - psutil == 3.1.1 08:42:26 INFO - requests == 1.2.3 08:42:26 INFO - wsgiref == 0.1.2 08:42:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:26 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')]} 08:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:26 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')]} 08:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:26 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 0x7f44e4bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', '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 08:42:26 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 08:42:26 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 08:42:26 INFO - Using env: {'DISPLAY': ':0', 08:42:26 INFO - 'HOME': '/home/cltbld', 08:42:26 INFO - 'LANG': 'en_US.UTF-8', 08:42:26 INFO - 'LANGUAGE': 'en_US:en', 08:42:26 INFO - 'LOGNAME': 'cltbld', 08:42:26 INFO - 'MAIL': '/var/mail/cltbld', 08:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:26 INFO - 'MOZ_NO_REMOTE': '1', 08:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:26 INFO - 'NO_EM_RESTART': '1', 08:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:26 INFO - 'PWD': '/builds/slave/test', 08:42:26 INFO - 'SHELL': '/bin/bash', 08:42:26 INFO - 'SHLVL': '1', 08:42:26 INFO - 'TERM': 'linux', 08:42:26 INFO - 'TMOUT': '86400', 08:42:26 INFO - 'USER': 'cltbld', 08:42:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:26 INFO - '_': '/tools/buildbot/bin/python'} 08:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:26 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)) 08:42:26 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)) 08:42:26 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)) 08:42:26 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)) 08:42:26 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)) 08:42:26 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)) 08:42:26 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)) 08:42:26 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)) 08:42:26 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)) 08:42:26 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)) 08:42:26 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)) 08:42:26 INFO - Cleaning up... 08:42:26 INFO - Return code: 0 08:42:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:26 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')]} 08:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:26 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')]} 08:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:26 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 0x7f44e4bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', '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 08:42:26 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 08:42:26 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 08:42:26 INFO - Using env: {'DISPLAY': ':0', 08:42:26 INFO - 'HOME': '/home/cltbld', 08:42:26 INFO - 'LANG': 'en_US.UTF-8', 08:42:26 INFO - 'LANGUAGE': 'en_US:en', 08:42:26 INFO - 'LOGNAME': 'cltbld', 08:42:26 INFO - 'MAIL': '/var/mail/cltbld', 08:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:26 INFO - 'MOZ_NO_REMOTE': '1', 08:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:26 INFO - 'NO_EM_RESTART': '1', 08:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:26 INFO - 'PWD': '/builds/slave/test', 08:42:26 INFO - 'SHELL': '/bin/bash', 08:42:26 INFO - 'SHLVL': '1', 08:42:26 INFO - 'TERM': 'linux', 08:42:26 INFO - 'TMOUT': '86400', 08:42:26 INFO - 'USER': 'cltbld', 08:42:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:26 INFO - '_': '/tools/buildbot/bin/python'} 08:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:26 INFO - Downloading/unpacking jsonschema 08:42:26 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 08:42:26 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 08:42:26 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 08:42:26 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 08:42:26 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 08:42:26 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 08:42:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:28 INFO - Downloading/unpacking functools32 (from jsonschema) 08:42:28 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 08:42:28 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 08:42:28 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 08:42:28 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 08:42:28 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 08:42:28 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 08:42:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:28 INFO - warning: no files found matching '*.txt' 08:42:28 INFO - no previously-included directories found matching 'build' 08:42:28 INFO - no previously-included directories found matching 'dist' 08:42:28 INFO - no previously-included directories found matching '.git*' 08:42:28 INFO - Installing collected packages: jsonschema, functools32 08:42:28 INFO - Running setup.py install for functools32 08:42:28 INFO - warning: no files found matching '*.txt' 08:42:28 INFO - no previously-included directories found matching 'build' 08:42:28 INFO - no previously-included directories found matching 'dist' 08:42:28 INFO - no previously-included directories found matching '.git*' 08:42:28 INFO - Successfully installed jsonschema functools32 08:42:28 INFO - Cleaning up... 08:42:28 INFO - Return code: 0 08:42:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:28 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 0x7f44e4bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', '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 08:42:28 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 08:42:28 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 08:42:28 INFO - Using env: {'DISPLAY': ':0', 08:42:28 INFO - 'HOME': '/home/cltbld', 08:42:28 INFO - 'LANG': 'en_US.UTF-8', 08:42:28 INFO - 'LANGUAGE': 'en_US:en', 08:42:28 INFO - 'LOGNAME': 'cltbld', 08:42:28 INFO - 'MAIL': '/var/mail/cltbld', 08:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:28 INFO - 'MOZ_NO_REMOTE': '1', 08:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:28 INFO - 'NO_EM_RESTART': '1', 08:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:28 INFO - 'PWD': '/builds/slave/test', 08:42:28 INFO - 'SHELL': '/bin/bash', 08:42:28 INFO - 'SHLVL': '1', 08:42:28 INFO - 'TERM': 'linux', 08:42:28 INFO - 'TMOUT': '86400', 08:42:28 INFO - 'USER': 'cltbld', 08:42:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:28 INFO - '_': '/tools/buildbot/bin/python'} 08:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:29 INFO - Downloading/unpacking flake8 08:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:42:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:42:30 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 08:42:30 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 08:42:30 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 08:42:30 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 08:42:30 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 08:42:30 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 08:42:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:42:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:42:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:31 INFO - no previously-included directories found matching 'docs/_build' 08:42:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:42:31 INFO - Running setup.py install for pep8 08:42:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:31 INFO - no previously-included directories found matching 'docs/_build' 08:42:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:42:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:42:31 INFO - Cleaning up... 08:42:31 INFO - Return code: 0 08:42:31 INFO - Running post-action listener: _resource_record_post_action 08:42:31 INFO - Running post-action listener: _start_resource_monitoring 08:42:31 INFO - Starting resource monitoring. 08:42:31 INFO - ##### 08:42:31 INFO - ##### Finished create-virtualenv step (success) 08:42:31 INFO - ##### 08:42:31 INFO - ##### 08:42:31 INFO - ##### Running install step. 08:42:31 INFO - ##### 08:42:31 INFO - Running pre-action listener: _resource_record_pre_action 08:42:31 INFO - Running main action method: install 08:42:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:32 INFO - Reading from file tmpfile_stdout 08:42:32 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:32 INFO - Reading from file tmpfile_stdout 08:42:32 INFO - Output received: 08:42:32 INFO - Usage: mozinstall [options] installer 08:42:32 INFO - Options: 08:42:32 INFO - -h, --help show this help message and exit 08:42:32 INFO - -d DEST, --destination=DEST 08:42:32 INFO - Directory to install application into. [default: 08:42:32 INFO - "/builds/slave/test"] 08:42:32 INFO - --app=APP Application being installed. [default: firefox] 08:42:32 INFO - mkdir: /builds/slave/test/build/application 08:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:42:48 INFO - Reading from file tmpfile_stdout 08:42:48 INFO - Output received: 08:42:48 INFO - /builds/slave/test/build/application/firefox/firefox 08:42:48 INFO - Running post-action listener: _resource_record_post_action 08:42:48 INFO - ##### 08:42:48 INFO - ##### Finished install step (success) 08:42:48 INFO - ##### 08:42:48 INFO - ##### 08:42:48 INFO - ##### Running run-tests step. 08:42:48 INFO - ##### 08:42:48 INFO - Running pre-action listener: _resource_record_pre_action 08:42:48 INFO - Running main action method: run_tests 08:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:48 INFO - Python 2.7.3 08:42:48 INFO - Return code: 0 08:42:48 INFO - grabbing minidump binary from tooltool 08:42: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')]} 08:42:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f59c0>, '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 0x18f68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:48 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 08:42:48 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 08:42:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:42:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:48 INFO - Return code: 0 08:42:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:42:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:42:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:42:49 INFO - Return code: 0 08:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 08:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 08:42:49 INFO - Using env: {'DISPLAY': ':0', 08:42:49 INFO - 'HOME': '/home/cltbld', 08:42:49 INFO - 'LANG': 'en_US.UTF-8', 08:42:49 INFO - 'LANGUAGE': 'en_US:en', 08:42:49 INFO - 'LOGNAME': 'cltbld', 08:42:49 INFO - 'MAIL': '/var/mail/cltbld', 08:42:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:49 INFO - 'MOZ_NO_REMOTE': '1', 08:42:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:49 INFO - 'NO_EM_RESTART': '1', 08:42:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:49 INFO - 'PWD': '/builds/slave/test', 08:42:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:49 INFO - 'SHELL': '/bin/bash', 08:42:49 INFO - 'SHLVL': '1', 08:42:49 INFO - 'TERM': 'linux', 08:42:49 INFO - 'TMOUT': '86400', 08:42:49 INFO - 'USER': 'cltbld', 08:42:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909', 08:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:49 INFO - '_': '/tools/buildbot/bin/python'} 08:42:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 08:42:49 INFO - mozversion application_buildid: 20160512053006 08:42:49 INFO - mozversion application_changeset: 092d7ffc5eeed5c0096117fff18638bbda0ebf6e 08:42:49 INFO - mozversion application_display_name: Nightly 08:42:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:49 INFO - mozversion application_name: Firefox 08:42:49 INFO - mozversion application_remotingname: firefox 08:42:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:42:49 INFO - mozversion application_vendor: Mozilla 08:42:49 INFO - mozversion application_version: 49.0a1 08:42:49 INFO - mozversion platform_buildid: 20160512053006 08:42:49 INFO - mozversion platform_changeset: 092d7ffc5eeed5c0096117fff18638bbda0ebf6e 08:42:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:42:49 INFO - mozversion platform_version: 49.0a1 08:42:49 INFO - using testdate: 1463067769 08:42:49 INFO - actual date: 1463067769 08:42:49 INFO - starting webserver on 'localhost:59413' 08:42:49 INFO - SUITE-START | Running 2 tests 08:42:49 INFO - TEST-START | dromaeo_css 08:42:49 INFO - operating with platform_type : linux_ 08:42:49 INFO - Initialising browser for dromaeo_css test... 08:42:49 INFO - TEST-INFO | started process 26752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZrnXBd/profile http://localhost:59413/getInfo.html) 08:42:53 INFO - PROCESS | 26752 | 08:42:53 INFO - PROCESS | 26752 | (process:26819): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:42:54 INFO - PROCESS | 26752 | __metrics Screen width/height:1600/1200 08:42:54 INFO - PROCESS | 26752 | colorDepth:24 08:42:54 INFO - PROCESS | 26752 | Browser inner width/height: 1024/697 08:42:54 INFO - PROCESS | 26752 | __metrics 08:42:54 ERROR - PROCESS | 26752 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:42:55 INFO - TEST-INFO | 26752: exit 0 08:42:55 INFO - Browser initialized. 08:42:55 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:55 INFO - TEST-INFO | started process 26870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZrnXBd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:57 INFO - PROCESS | 26870 | 08:42:57 INFO - PROCESS | 26870 | (process:26932): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:43:07 INFO - PROCESS | 26870 | RSS: Main: 163282944 08:43:07 INFO - PROCESS | 26870 | 08:43:57 INFO - PROCESS | 26870 | 1463067837138 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] 08:46:05 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:59413/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59413/tests/dromaeo/cssquery-ext.html) 08:46:06 INFO - PROCESS | 26870 | RSS: Main: 166449152 08:46:06 INFO - PROCESS | 26870 | 08:49:08 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:59413/tests/dromaeo/cssquery-ext.html (next: http://localhost:59413/tests/dromaeo/cssquery-jquery.html) 08:49:08 INFO - PROCESS | 26870 | RSS: Main: 166035456 08:49:08 INFO - PROCESS | 26870 | 08:52:10 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:59413/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59413/tests/dromaeo/cssquery-mootools.html) 08:52:11 INFO - PROCESS | 26870 | RSS: Main: 167219200 08:52:11 INFO - PROCESS | 26870 | 08:55:12 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:59413/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59413/tests/dromaeo/cssquery-prototype.html) 08:55:13 INFO - PROCESS | 26870 | RSS: Main: 165023744 08:55:13 INFO - PROCESS | 26870 | 08:58:15 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:59413/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59413/tests/dromaeo/cssquery-yui.html) 08:58:16 INFO - PROCESS | 26870 | RSS: Main: 166199296 08:58:16 INFO - PROCESS | 26870 | 09:01:18 INFO - PROCESS | 26870 | Cycle 1(1): loaded http://localhost:59413/tests/dromaeo/cssquery-yui.html (next: http://localhost:59413/tests/dromaeo/cssquery-dojo.html) 09:01:19 INFO - PROCESS | 26870 | RSS: Main: 168058880 09:01:19 INFO - PROCESS | 26870 | 09:01:19 INFO - PROCESS | 26870 | __start_tp_report 09:01:19 INFO - PROCESS | 26870 | _x_x_mozilla_page_load 09:01:19 INFO - PROCESS | 26870 | _x_x_mozilla_page_load_details 09:01:19 INFO - PROCESS | 26870 | |i|pagename|runs| 09:01:19 INFO - PROCESS | 26870 | |0;dojo.html;3193.80837149771;3230.4992726127457;3245.9126192725444;3257.2019855135495;3257.9411691200366;5424.647397919138;5434.510894019538;5479.232907392963;5529.640573362729;5560.138178582326;5412.539934105596;5474.945250547494;5488.9725551372185;5517.972410137953;5523.530499907502;4917.680350777197;4965.404151501825;5090.516400941923;5110.080185566597;5155.510226528474;895.3719150244356;4865.464798872121;4987.725675087869;5069;5127.359080114986;5002.499750025005;5008.899822003557;5026.97486512567;5051.797928082872;5090.796368145269;5037.798488060474;5048.596112311043;5055;5073.239014147907;5074.13739664258;4960.156773348539;5022.372203474566;5052.292679024939;5055.772490237948;5091.949080509185;5444;5460.863478413032;5464.043792336365;5479.6164268501225;5538.723063846792;5677.659340439587;5766.913496297517;5905.4980326672285;5932.584719069667;5937.70311484424;5830.737616807254;5878.41215878413;5889.411058894119;5935.287765468128;5948.583599148062;5437.483439073281;5467.0705979983495;5472.972635136839;5492.395836457987;5500.037493438632;5839.824805255849;5898.262717160355;5917.792877249276;5990.520758339322;6017.18767966319;5627.380988091307;5634.774609015593;5702.486776190163;5724.742386592613;5744.396838331999;5728.312602487728;5740.885182296414;5827.038538641162;5836.649801011953;5838.182654428383;5748.367679555246;5791.88416231673;5801.6809075500405;5818.854528636733;5859.1797148399255;5914.76340946366;5929.822105336761;5958.374370691015;5966.552508561876;6007.699615019232;4488.147252022105;4509.458864936163;4510.571495707903;4513.616342610915;4546.52261512543;3925.116848709075;3935.4490371348033;3961.8613348532663;4011.91976160481;4076.735012224255;5542.196381524656;5578.330600327906;5603.971980140073;5609.1305847593685;5659.462351076641;5865.35481097079;5871.236739223959;5881.059030555176;5884.617499862581;5885.793997210077;5506.476884695948;5559.499645031967;5560.527355174855;5567.526760225426;5601.383847776741;5031.195008798648;5061.190209566452;5084.669496482717;5106.336176297058;5123.205903085028;6106.511479081662;6126.203593532812;6134.693265336716;6158.1686472326555;6160.353162917919;5817.272840894888;5828.6211396259105;5880.8235752927485;5887.08750143737;5912.231409916683;6073.058675905242;6084.269887613515;6098.644029113846;6100.096771792299;6128.938710612837;5770.336411312753;5773.076307790733;5790.10253410722;5795.072788353843;5842.269716285465;5731.426857314235;5852.707364631837;5876.382979787061;5884.617499862496;5914.467697907209;5727.627704199213;5762.7694892203845;5770.596058276048;5775.451332123442;5777.74000169985;5740.68426236561;5782.335031471434;5783.652980821164;5790.10253410722;5810.448007439287;5557.805476808292;5624.100143977108;5652.660840349592;5666.376698563073;5732.025555655632;5809.419058094326;5854.941450585439;5857.7949771757785;5862.618929769551;5866.911996320144;5572.693501857437;5726.799562015476;5738.053221218453;5753.539716822561;5759.136129580429 09:01:19 INFO - PROCESS | 26870 | |1;ext.html;597.5040716205547;653.8365408647838;659.6899457255089;663.2174034639125;673.942714869236;43164.78417607911;43913.78043109784;44242.55757442429;46877;47183.76408117954;44145.33781993265;44643.10713785722;44764.552354476444;44786.7760661197;44876;8833.779155521115;8963.95518022409;8971.192592666659;8974.775630609221;8992.100789920989;8904.777380565472;8951.95524022379;8952.239059679934;8960.910390896106;8979.730608081769;8997.145271199226;8999.865002024975;9015.729528114167;9016.188543031127;9032.232260257886;8919.598618062171;8949.821003579957;8960.462372257685;8961.775955601097;9002.819943601156;8840.204381605687;8861.335399845037;8912.24245939096;8937.64249430022;8943;40646.39030414546;40911.38632920509;41050.178996419905;41122.1775564487;41346.793266033776;3401.183715908189;3579.1231148368556;3605.801680907549;3617.475466057433;4085.6935729820384;31496.527552086736;32253.677463225304;32295.51556726651;32360.5145922809;32429.35141297161;4192.601702838256;4197.706160568761;4209.957900420987;4251;4266.5946735060115;289072;290230;291785;292378;294603;58655;59179.63281468779;59207.40792592105;59318.406815932154;59401.702991484766;36313.45529817055;37126.257474850354;37145.62854371476;38561;38585.614143858766;17774;17893.28426862937;18053.548661283574;18054.368097116538;18068.819311806976;13646.931765341309;13649.86350136486;13694.383752730952;13708.52020179289;13791.379387927567;20072.89599072065;20073.698894516303;20223.393298201077;20238.291659792132;20337.76284608692;7479.065116860393;7522.5862577558755;7584.748516494827;7712.9614351927885;7794.207332313599;923.4462100021885;1134.466800603715;1142.9371384573928;1151.7696460707891;1220.7009282725612;31208.063758087294;31486.685133148374;32230.516542251884;32378;32554.511682324784;1122.814735568622;1144.582227486978;1149.287441786098;1175.7060734816296;1206.5776978057609;16817.15914204285;16964.660706785795;17152.142392880305;17293.913530432517;17315.826841731672;454933;455321;455618;455714;457769;58325.416745832845;58399.70800145972;58802.705986469795;58974.41025589775;59008.7049564758;1367.2548461088732;1394.7907813827803;1402.7545179593735;1407.3596513586294;1413.8162038934872;30582.388352232385;31086.37827243488;31219.531707023958;31722.68277317197;32593.18517037093;52625.210621839935;52739.208911865586;52925.470745292056;53033;53204.733976331416;357156;362031;364638;366591;366891;28092.297692557848;28600;28620.42759144847;28650.283742906595;28674.56988145221;48438.27342589793;49412;49830.50169498259;50039.24941125959;50433.74783126061;39881.800590996856;40630.593694063864;41610.167796644506;41923.58076419197;42488.36267456052;41804.372934406616;42238.366424503045;42290.57709422989;42483.78758106189;43010;42583;42601.786991064844;43176.784116079216;43371.34942975921;45349;36250.456243155844;36562.63437365592;37191.8140409307;37780;37994.240115198096;28979.710202898543;29074.418511630072;29171.66626669819;29291.707082928897;29633.703662963955 09:01:19 INFO - PROCESS | 26870 | |2;jquery.html;403.7516927089841;407.7961019490255;408.12660905661886;408.3547994169212;416.27775808971427;17878.463646090622;19544;19595.412137635893;19600.31398901039;20452.284170054052;19127.330543430984;19378.321758738446;19906.601867962632;19945.401637950847;19952.50118747032;5443;5647.548196144319;5711.657300561958;5715.885682286352;5792.507636850873;5698.430156984289;5700.8859822803515;5734.168545560891;6483.870322593545;6504.447121994636;6451.903221451682;6454.128692626482;6458.192725909262;6470.385313395243;6494.967525162368;5759.769609215627;5785.999999999979;5809.564282678773;5859.853503662443;6261.530385221126;5456.127019676833;5629.4652008059165;5666.546676265889;5676.631018983753;5681.460261275172;13658.317084145852;13855;13873.445062197601;13964.231967241798;13991.440342386293;2245.7529671736097;2245.9326220213256;2500.335265455735;2594.416256342327;2735.7948153888337;10173.033561811617;10320.79358412835;10333.173346132291;10481.213908956859;10505.737356566071;1976.239147928058;2020.3332900142918;2030.4213299209803;2057.506198512346;2060.6805945078386;81990.59004704938;84588.57705711493;84875.57562212211;85251.57374213151;85907.57046214728;10880.510377032893;10991.890081099087;11233.269837460539;11470.942645286721;11474.827877581843;15924.681506369807;15973.201339932957;15978.76031859523;15997;16144;8331.95834020826;8596.398252122417;8661.350398720122;8682.175193356621;8719.624868366136;8239.876401853857;8375.785511100978;8388.496690198608;8413.831723365498;8457.154284571494;4760;4768.9523104768505;4880.9749952509665;4973.254011898244;4973.303737476756;2018.4348382452642;2032.5325175209489;2085.843561732876;2099.118370284484;2123.766385697572;975.7414285214423;1057.318029870729;1076.7954088723118;1083.4907593431076;1130.6947124276564;19233.134508946852;19432.611347772967;19526;19634.509137271398;19740.65689662013;953.6423841059602;964.0455948610964;986.4647855012691;990.7997169143706;1024.6823484719762;10655.733606659896;10782.892171078345;10918.781624367468;10957.397343146204;11144.554217831359;497346;513000;523215;526386;529035;94872;97938;99103;99597;101414;1088.1186239146316;1090.5637744901944;1126.5099681638515;1132.7281452451352;1139.8746137924823;17740;17837.197326120615;17917.104144792447;17946.641067178844;17967.82032179714;42982.57017429911;43226.78386608173;43351.34972975345;44409;44598.77700611476;59277.407225927185;59286.70356648189;59603.403965959784;60564.6971765156;61458;8870.112988701077;8924.375293729376;8983.146601072887;9072.319576031692;9180.44917304964;11822.172447928562;13262.93368533151;13421.798673020108;13607.047506674438;13715.519956801863;11656.475458604213;11977.461014254206;11982.460789264329;12002.21985570935;12237.755244894874;11878.287302761863;11918.642440726791;11928.224665396721;11929.224600400947;11982.281063136239;12013.339266340436;12072.275663460221;12556.121071524905;12674.936625316814;12852.742945141232;8814.338924580554;8879.511626860585;9000.684976025808;9113.270938324786;9153.313501487548;12066.095042871644;12300.200486968319;12362;12377.876221238033;12429.401121585071 09:01:19 INFO - PROCESS | 26870 | |3;mootools.html;1472.7569950958089;1527.90832550047;1691.509462255946;1829.7438358629786;1831.9267229310828;8093.716719914804;8311.750647480578;8533.957330213356;9045.09549045095;9048.5928133234;8622.267107295887;8856.734297971056;8866.290696744261;8883.422577532456;8960.462372257653;2343.2267351773917;2349.107339211106;2370.3363058343693;2374.6912901322803;2377.6076947303673;2299.2642354446584;2305.6080466320764;2335.065973610561;2335.7664233576675;2339.3800642829665;2349.6475528670667;2350.588646986779;2354.564405584964;2365.1603680693365;2374.905003799846;2231.933042008742;2303.3435470890718;2305.6310990241564;2321.7097862767237;2339.21636251855;2302.6200676888293;2332.93001209964;2346.765323467657;2353.505763789606;2360.386299562109;8747.343949203836;8821.338399620054;8856.734297971072;8872.245859101984;8919.06349833271;5042.09242336383;5050.191969284933;5209.166533354645;5210.947890521122;5242.266082748418;3372.3423932333203;3407.267437500949;3485.9302813943577;3503.562054743157;3515.2617950230483;1182.5151687808043;1196.116581760215;1203.6930582701443;1218.0986070307997;1247.9688007799787;11836.408179591072;11852.34812085335;11875.34685592292;11886.583969561023;11928.40357982106;4382.474103107647;4398.516163222043;4470.86587402372;4481.081378317503;4493.213687604656;9995.600175992879;10063.19494440443;10080.69757907264;10095.44475053879;10100.949495252476;5118.360204974379;5122.385313762373;5128.79484820603;5148.536631703165;5162.174052151638;4361.781910904442;4739.928901066487;4787.162246606899;4896.828610998598;4899.093667671421;3914.6085391461197;3974.4833171687496;4042.4542686737504;4066.1054567994993;4120.402541631447;1256.9371531423392;1262.3625069339926;1267.9112462127562;1273.3505911984769;1273.4142294544429;988.8170688422665;991.8512223166583;994.9850752238722;1005.2460654509118;1011.2971484817981;5971.820845374646;5974.253218347707;6024.216851809324;6043.7280322385595;6146.5390095743;458.1478450082843;461.16529082361035;466.19348527048396;476.9523047695272;477.9665423420397;4010.7192496525545;4101.7744024078365;4135.276326642826;4147.564505726916;4158.6465150462545;10327.070563649308;10626.628068017582;10759.946200269105;10782.514786834612;10808.567657293777;10231.846522302172;10564.894351056391;10754.569817207224;10754.623588174376;10777.137828973664;8329.916700833035;8348.373871959628;8406.873896891551;8519.403641745143;8522.786930326667;5939.495142912728;5975.790847320497;6164.229471316085;6214.782482613087;6356.442671545501;9446;9496.050394960448;9542.284328675238;9547.522623868917;9696.22430205596;10136.74658133523;10395.792084158124;10513.211509136998;10549.841752373566;10633.840492392466;7018.543794653331;7639.694412223449;7945.721899733481;7964.761057168294;8043.075046369742;8654.653813847375;8749;8768.430052046597;8777;8782.297416206817;7785.221477852169;8011.340664167464;8050.758477245692;8105.513669179868;8133.918660813316;7884.921150788418;7918.604069796372;7940.404469664913;8018.558979256197;8028.07677117139;7190.712371505081;7208.531445456028;7260.092488438945;7290.817729556804;7295.890561641473;5259.316288882421;5328.227407026037;5337.119375303031;5354.170103633943;5380.408155103014;5217.295665085165;5325.440828713085;5326.201069839555;5328.62699611039;5419.187121931742 09:01:19 INFO - PROCESS | 26870 | |4;prototype.html;324.87167568810304;333.1654206213435;339.0726363396113;339.1639608365379;340.9880654177104;5430.266913966613;5517.420670829565;5553.861153471165;5667.149927510875;5689.345725241593;5571.609987300891;5594.440555944404;5632.549396048316;5643.548516118711;5645.943540564593;4341.826326946926;4362.781860906958;4372.366006928994;4436.8668939931695;4461.977690111545;4170.4578404807335;4422.889427764299;4424.623906967911;4455.754933478657;4476.910461790762;4331.371951067109;4347.760873151976;4367.475902891658;4374.912501749963;4392.912141757163;4371.3661519079715;4390.69265151438;4397.5602439756085;4410.206162890679;4428.357888106207;3778.735488515805;3840.2511510255513;3864.8840534784003;3866.381378979378;3876.379779235337;5458.925608268833;5462.781488740446;5464.890702185974;5491.917621235684;5519.9448005519835;4946.788036930975;4962.900741985176;4975.427825800043;5005.449400565934;5007.799688012475;5623.522000629951;5841.707914604252;5842.474177324061;5889.8822023559715;5909.852253693649;4136.172765446892;4138.627523522868;4142.668586513072;4146.709730318879;4150.709450338478;6113.908291375633;6140.802543504018;6159.445649891486;6177.413145751147;6182.319944806068;3997.720159588801;4299.14017196562;4312.116016216668;4313.4823821141035;4319.43847299849;4289.313709806416;4304.48346198452;4326.437563116775;4333.569921925757;4362.411074504965;4850.320955066293;4879.0725564661625;4897.314375987365;4923.975380123076;4947.381577302837;5760.279965004374;5886.852828679317;5911.76352945886;5963.612365196335;5979.372165922602;1487.8586534279227;1504.8495150484864;1507.0957425544805;1509.4415066425493;1509.8112735908012;926.6061923682408;952.3999880075646;952.7284723853807;964.81668482988;965.6137544982064;5047;5068.619853511002;5078.720670363092;5094.974525127424;5140.40885298188;5384.91922621161;5430.782768689208;5439.673619582838;5441.863953401196;5447.591430642718;4911.68074075184;4996;5103.438621751604;5172.560332371715;5217.478252174752;2876.395956849085;2907;2907.4039821836473;2919;2926.707329267056;5434.456554344534;5545.334559852843;5551.084071128299;5630.211770352154;5638.011853717537;5379.327584051994;5689.9146512802345;6178;6195.915714749901;6205.2553693557065;6284.49172198669;6285.434310911948;6295.937040629535;6330.778422755181;6333.176687030748;6001.5798894077;6104.8779024420155;6133.141360209664;6138.416850399205;6163.35284795108;6009.519238461;6015.218021657157;6018.879622407615;6042.1540984261355;6051.910656081947;5984.222051133324;6069.9089513656445;6235.661626889916;6296.748130074746;6332.588381755171;4230.302000169938;4283.250431174594;4297.247981603269;4299.376590394438;4305.526392096805;6123.571350005457;6157.476614487819;6181;6188.288346840171;6211.565190436626;5752.798652047159;5890.852728681817;5903.586748927534;5916.467517923407;5994.610350327215;5770.538356931519;5877.147813567094;5881.823545293648;5899.203607513103;5937.376575459687;5656;5711.400302968129;5804.245448091721;5819.76720931175;5857.355690873916;5961.344252132175;5983.7008149591475;5992.64044157352;6020.127081573235;6074.0281554951;5891.1457838612305;5893.941060589511;5896.616719913192;5904.852378690567;5909.349971503045 09:01:19 INFO - PROCESS | 26870 | |5;yui.html;800.9199080091992;807.725373373053;844.2739244249948;854.2397266432872;864.1358641358642;14222.57332280032;15105.244737763109;15135.62160945977;15247.847521524809;15291.770623440658;14163.929180354084;14202.36089375978;14233;14246.572602821932;14269.143851368925;693.2720643324502;813.9593020348989;828.9709860154895;829.6142293833366;830.323286521483;835.1439774231401;836.8326334733048;840.357126798;840.3949156607233;841.167244428018;857.652650676477;860.8536548786722;860.9926386128213;866.8829707989404;867.375489647456;860.3289434241302;862.5514732339179;864.4510735682824;865.1002956924791;865.2342676731075;624.7032659486753;625.9530535209832;627.7896904536985;628.0202883501706;630.3161070238797;14376.281185940661;14380.64048398788;14467.855321446756;14486.275686215753;14497.34761935705;13997.860021399758;14053.297335133202;14155.787663185061;14284.500042498463;14528.636784080376;11508.654740357802;11785.705357366049;11791.764164716658;11896.762064758655;12000.21998570099;3870.806459677033;3872.283627528888;3914.3541315683165;3945.861894833667;3960.1683646434285;53698.463015369736;54487.727561362335;54654;55102;55254;11070.931572305635;11155.498002589902;11239.21325507223;11306.095512358992;11405.201635885409;19078.33225837089;19088.045597720058;19108.522286942938;19117.61764764697;19138.904305478383;8243.464174828738;8340.249377556049;8429.747107586782;8568.742937711879;8653.826923461496;4805.831795887128;4834.105690447279;4915.459299477055;4965.453800081988;5001.074801161797;3218.2758879251983;3365.5793025871767;3377.7804442711144;3383.018924511864;3387.6612338765926;686.842026333946;687.5084314714903;695.9826004349932;697.1425147069032;697.3096634331974;768.5657603454031;770.876659734451;772.9497582657109;774.5197977254138;787.0987719061642;9334.533273336307;9617.134457898823;9626.95186524077;9736.853947190797;9759.951200244095;744.7840126363402;754.6792613139394;770.5723323555369;779.0223269796369;788.1409263902374;4292.806823692941;4304.548022457597;4321.178975994614;4329.956700433018;4434.379186913835;56411;61281.38718612846;61324;61368.69315653483;61402;53697.46302537003;54033;54914.45085549093;56258;56477.43522564804;49906.75046624744;50365.49634503608;50690.23964640533;50723;50840.237396439086;8625.8706119407;8790.164934331227;8804.911950880409;8814.867776983223;8849.690260841096;33099.83450082831;33270.16824579405;33371.16572085717;33540.66459335473;33923.15192120118;43433.3484997719;44146.117077658906;44720;44980.550194498945;45445.77277113593;11132.443377830914;11320.886791131983;11689.824652630048;11696.941515292368;11827.645170644895;12043.458044388199;12179.817302740288;12336.691582710504;12360.320182390054;12371.69070773238;11776;11965.880341196826;11967.940160299142;12062.577809776616;12147.028237740782;12029.15795894314;12202.450889709808;12339;12341.753164936472;12413.813792792935;11480.770384592428;11603.477843497232;11859.169858110195;11919.642410727693;11953.701157471132;9769;9933.3543319684;10207.336523125972;10297.691069267934;10367.63713270032;9605.47169905634;9933.701988940344;9976.950115249378;10043.89956100459;10096.610430744375 09:01:19 INFO - PROCESS | 26870 | __end_tp_report 09:01:19 INFO - PROCESS | 26870 | __start_cc_report 09:01:19 INFO - PROCESS | 26870 | _x_x_mozilla_cycle_collect,331 09:01:19 INFO - PROCESS | 26870 | __end_cc_report 09:01:19 INFO - PROCESS | 26870 | __startTimestamp1463068879113__endTimestamp 09:01:19 INFO - PROCESS | 26870 | 09:01:19 INFO - PROCESS | 26870 | ------- Summary: start ------- 09:01:19 INFO - PROCESS | 26870 | Number of tests: 6 09:01:19 INFO - PROCESS | 26870 | 09:01:19 INFO - PROCESS | 26870 | [#0] dojo.html Cycles:165 Average:5440.85 Median:5702.49 stddev:704.40 (12.4%) stddev-sans-first:684.15 09:01:19 INFO - PROCESS | 26870 | Values: 3193.8 3230.5 3245.9 3257.2 3257.9 5424.6 5434.5 5479.2 5529.6 5560.1 5412.5 5474.9 5489.0 5518.0 5523.5 4917.7 4965.4 5090.5 5110.1 5155.5 895.4 4865.5 4987.7 5069.0 5127.4 5002.5 5008.9 5027.0 5051.8 5090.8 5037.8 5048.6 5055.0 5073.2 5074.1 4960.2 5022.4 5052.3 5055.8 5091.9 5444.0 5460.9 5464.0 5479.6 5538.7 5677.7 5766.9 5905.5 5932.6 5937.7 5830.7 5878.4 5889.4 5935.3 5948.6 5437.5 5467.1 5473.0 5492.4 5500.0 5839.8 5898.3 5917.8 5990.5 6017.2 5627.4 5634.8 5702.5 5724.7 5744.4 5728.3 5740.9 5827.0 5836.6 5838.2 5748.4 5791.9 5801.7 5818.9 5859.2 5914.8 5929.8 5958.4 5966.6 6007.7 4488.1 4509.5 4510.6 4513.6 4546.5 3925.1 3935.4 3961.9 4011.9 4076.7 5542.2 5578.3 5604.0 5609.1 5659.5 5865.4 5871.2 5881.1 5884.6 5885.8 5506.5 5559.5 5560.5 5567.5 5601.4 5031.2 5061.2 5084.7 5106.3 5123.2 6106.5 6126.2 6134.7 6158.2 6160.4 5817.3 5828.6 5880.8 5887.1 5912.2 6073.1 6084.3 6098.6 6100.1 6128.9 5770.3 5773.1 5790.1 5795.1 5842.3 5731.4 5852.7 5876.4 5884.6 5914.5 5727.6 5762.8 5770.6 5775.5 5777.7 5740.7 5782.3 5783.7 5790.1 5810.4 5557.8 5624.1 5652.7 5666.4 5732.0 5809.4 5854.9 5857.8 5862.6 5866.9 5572.7 5726.8 5738.1 5753.5 5759.1 09:01:19 INFO - PROCESS | 26870 | 09:01:19 INFO - PROCESS | 26870 | [#1] ext.html Cycles:180 Average:54187.60 Median:41478.48 stddev:99128.89 (239.0%) stddev-sans-first:99325.31 09:01:19 INFO - PROCESS | 26870 | Values: 597.5 653.8 659.7 663.2 673.9 43164.8 43913.8 44242.6 46877.0 47183.8 44145.3 44643.1 44764.6 44786.8 44876.0 8833.8 8964.0 8971.2 8974.8 8992.1 8904.8 8952.0 8952.2 8960.9 8979.7 8997.1 8999.9 9015.7 9016.2 9032.2 8919.6 8949.8 8960.5 8961.8 9002.8 8840.2 8861.3 8912.2 8937.6 8943.0 40646.4 40911.4 41050.2 41122.2 41346.8 3401.2 3579.1 3605.8 3617.5 4085.7 31496.5 32253.7 32295.5 32360.5 32429.4 4192.6 4197.7 4210.0 4251.0 4266.6 289072.0 290230.0 291785.0 292378.0 294603.0 58655.0 59179.6 59207.4 59318.4 59401.7 36313.5 37126.3 37145.6 38561.0 38585.6 17774.0 17893.3 18053.5 18054.4 18068.8 13646.9 13649.9 13694.4 13708.5 13791.4 20072.9 20073.7 20223.4 20238.3 20337.8 7479.1 7522.6 7584.7 7713.0 7794.2 923.4 1134.5 1142.9 1151.8 1220.7 31208.1 31486.7 32230.5 32378.0 32554.5 1122.8 1144.6 1149.3 1175.7 1206.6 16817.2 16964.7 17152.1 17293.9 17315.8 454933.0 455321.0 455618.0 455714.0 457769.0 58325.4 58399.7 58802.7 58974.4 59008.7 1367.3 1394.8 1402.8 1407.4 1413.8 30582.4 31086.4 31219.5 31722.7 32593.2 52625.2 52739.2 52925.5 53033.0 53204.7 357156.0 362031.0 364638.0 366591.0 366891.0 28092.3 28600.0 28620.4 28650.3 28674.6 48438.3 49412.0 49830.5 50039.2 50433.7 39881.8 40630.6 41610.2 41923.6 42488.4 41804.4 42238.4 42290.6 42483.8 43010.0 42583.0 42601.8 43176.8 43371.3 45349.0 36250.5 36562.6 37191.8 37780.0 37994.2 28979.7 29074.4 29171.7 29291.7 29633.7 09:01:19 INFO - PROCESS | 26870 | 09:01:19 INFO - PROCESS | 26870 | [#2] jquery.html Cycles:180 Average:30136.69 Median:2184.76 stddev:85465.02 (3911.9%) stddev-sans-first:85675.62 09:01:19 INFO - PROCESS | 26870 | Values: 403.8 407.8 408.1 408.4 416.3 17878.5 19544.0 19595.4 19600.3 20452.3 19127.3 19378.3 19906.6 19945.4 19952.5 5443.0 5647.5 5711.7 5715.9 5792.5 5698.4 5700.9 5734.2 6483.9 6504.4 6451.9 6454.1 6458.2 6470.4 6495.0 5759.8 5786.0 5809.6 5859.9 6261.5 5456.1 5629.5 5666.5 5676.6 5681.5 13658.3 13855.0 13873.4 13964.2 13991.4 2245.8 2245.9 2500.3 2594.4 2735.8 10173.0 10320.8 10333.2 10481.2 10505.7 1976.2 2020.3 2030.4 2057.5 2060.7 81990.6 84588.6 84875.6 85251.6 85907.6 10880.5 10991.9 11233.3 11470.9 11474.8 15924.7 15973.2 15978.8 15997.0 16144.0 8332.0 8596.4 8661.4 8682.2 8719.6 8239.9 8375.8 8388.5 8413.8 8457.2 4760.0 4769.0 4881.0 4973.3 4973.3 2018.4 2032.5 2085.8 2099.1 2123.8 975.7 1057.3 1076.8 1083.5 1130.7 19233.1 19432.6 19526.0 19634.5 19740.7 953.6 964.0 986.5 990.8 1024.7 10655.7 10782.9 10918.8 10957.4 11144.6 497346.0 513000.0 523215.0 526386.0 529035.0 94872.0 97938.0 99103.0 99597.0 101414.0 1088.1 1090.6 1126.5 1132.7 1139.9 17740.0 17837.2 17917.1 17946.6 17967.8 42982.6 43226.8 43351.3 44409.0 44598.8 59277.4 59286.7 59603.4 60564.7 61458.0 8870.1 8924.4 8983.1 9072.3 9180.4 11822.2 13262.9 13421.8 13607.0 13715.5 11656.5 11977.5 11982.5 12002.2 12237.8 11878.3 11918.6 11928.2 11929.2 11982.3 12013.3 12072.3 12556.1 12674.9 12852.7 8814.3 8879.5 9000.7 9113.3 9153.3 12066.1 12300.2 12362.0 12377.9 12429.4 09:01:19 INFO - PROCESS | 26870 | 09:01:19 INFO - PROCESS | 26870 | [#3] mootools.html Cycles:180 Average:5799.86 Median:2608.44 stddev:3264.45 (125.1%) stddev-sans-first:3257.41 09:01:19 INFO - PROCESS | 26870 | Values: 1472.8 1527.9 1691.5 1829.7 1831.9 8093.7 8311.8 8534.0 9045.1 9048.6 8622.3 8856.7 8866.3 8883.4 8960.5 2343.2 2349.1 2370.3 2374.7 2377.6 2299.3 2305.6 2335.1 2335.8 2339.4 2349.6 2350.6 2354.6 2365.2 2374.9 2231.9 2303.3 2305.6 2321.7 2339.2 2302.6 2332.9 2346.8 2353.5 2360.4 8747.3 8821.3 8856.7 8872.2 8919.1 5042.1 5050.2 5209.2 5210.9 5242.3 3372.3 3407.3 3485.9 3503.6 3515.3 1182.5 1196.1 1203.7 1218.1 1248.0 11836.4 11852.3 11875.3 11886.6 11928.4 4382.5 4398.5 4470.9 4481.1 4493.2 9995.6 10063.2 10080.7 10095.4 10100.9 5118.4 5122.4 5128.8 5148.5 5162.2 4361.8 4739.9 4787.2 4896.8 4899.1 3914.6 3974.5 4042.5 4066.1 4120.4 1256.9 1262.4 1267.9 1273.4 1273.4 988.8 991.9 995.0 1005.2 1011.3 5971.8 5974.3 6024.2 6043.7 6146.5 458.1 461.2 466.2 477.0 478.0 4010.7 4101.8 4135.3 4147.6 4158.6 10327.1 10626.6 10759.9 10782.5 10808.6 10231.8 10564.9 10754.6 10754.6 10777.1 8329.9 8348.4 8406.9 8519.4 8522.8 5939.5 5975.8 6164.2 6214.8 6356.4 9446.0 9496.1 9542.3 9547.5 9696.2 10136.7 10395.8 10513.2 10549.8 10633.8 7018.5 7639.7 7945.7 7964.8 8043.1 8654.7 8749.0 8768.4 8777.0 8782.3 7785.2 8011.3 8050.8 8105.5 8133.9 7884.9 7918.6 7940.4 8018.6 8028.1 7190.7 7208.5 7260.1 7290.8 7295.9 5259.3 5328.2 5337.1 5354.2 5380.4 5217.3 5325.4 5326.2 5328.6 5419.2 09:01:19 INFO - PROCESS | 26870 | 09:01:19 INFO - PROCESS | 26870 | [#4] prototype.html Cycles:180 Average:4884.38 Median:5478.40 stddev:1452.10 (26.5%) stddev-sans-first:1415.27 09:01:19 INFO - PROCESS | 26870 | Values: 324.9 333.2 339.1 339.2 341.0 5430.3 5517.4 5553.9 5667.1 5689.3 5571.6 5594.4 5632.5 5643.5 5645.9 4341.8 4362.8 4372.4 4436.9 4462.0 4170.5 4422.9 4424.6 4455.8 4476.9 4331.4 4347.8 4367.5 4374.9 4392.9 4371.4 4390.7 4397.6 4410.2 4428.4 3778.7 3840.3 3864.9 3866.4 3876.4 5458.9 5462.8 5464.9 5491.9 5519.9 4946.8 4962.9 4975.4 5005.4 5007.8 5623.5 5841.7 5842.5 5889.9 5909.9 4136.2 4138.6 4142.7 4146.7 4150.7 6113.9 6140.8 6159.4 6177.4 6182.3 3997.7 4299.1 4312.1 4313.5 4319.4 4289.3 4304.5 4326.4 4333.6 4362.4 4850.3 4879.1 4897.3 4924.0 4947.4 5760.3 5886.9 5911.8 5963.6 5979.4 1487.9 1504.8 1507.1 1509.4 1509.8 926.6 952.4 952.7 964.8 965.6 5047.0 5068.6 5078.7 5095.0 5140.4 5384.9 5430.8 5439.7 5441.9 5447.6 4911.7 4996.0 5103.4 5172.6 5217.5 2876.4 2907.0 2907.4 2919.0 2926.7 5434.5 5545.3 5551.1 5630.2 5638.0 5379.3 5689.9 6178.0 6195.9 6205.3 6284.5 6285.4 6295.9 6330.8 6333.2 6001.6 6104.9 6133.1 6138.4 6163.4 6009.5 6015.2 6018.9 6042.2 6051.9 5984.2 6069.9 6235.7 6296.7 6332.6 4230.3 4283.3 4297.2 4299.4 4305.5 6123.6 6157.5 6181.0 6188.3 6211.6 5752.8 5890.9 5903.6 5916.5 5994.6 5770.5 5877.1 5881.8 5899.2 5937.4 5656.0 5711.4 5804.2 5819.8 5857.4 5961.3 5983.7 5992.6 6020.1 6074.0 5891.1 5893.9 5896.6 5904.9 5909.3 09:01:19 INFO - PROCESS | 26870 | 09:01:19 INFO - PROCESS | 26870 | [#5] yui.html Cycles:180 Average:14689.53 Median:4819.97 stddev:16924.28 (351.1%) stddev-sans-first:16939.62 09:01:19 INFO - PROCESS | 26870 | Values: 800.9 807.7 844.3 854.2 864.1 14222.6 15105.2 15135.6 15247.8 15291.8 14163.9 14202.4 14233.0 14246.6 14269.1 693.3 814.0 829.0 829.6 830.3 835.1 836.8 840.4 840.4 841.2 857.7 860.9 861.0 866.9 867.4 860.3 862.6 864.5 865.1 865.2 624.7 626.0 627.8 628.0 630.3 14376.3 14380.6 14467.9 14486.3 14497.3 13997.9 14053.3 14155.8 14284.5 14528.6 11508.7 11785.7 11791.8 11896.8 12000.2 3870.8 3872.3 3914.4 3945.9 3960.2 53698.5 54487.7 54654.0 55102.0 55254.0 11070.9 11155.5 11239.2 11306.1 11405.2 19078.3 19088.0 19108.5 19117.6 19138.9 8243.5 8340.2 8429.7 8568.7 8653.8 4805.8 4834.1 4915.5 4965.5 5001.1 3218.3 3365.6 3377.8 3383.0 3387.7 686.8 687.5 696.0 697.1 697.3 768.6 770.9 772.9 774.5 787.1 9334.5 9617.1 9627.0 9736.9 9760.0 744.8 754.7 770.6 779.0 788.1 4292.8 4304.5 4321.2 4330.0 4434.4 56411.0 61281.4 61324.0 61368.7 61402.0 53697.5 54033.0 54914.5 56258.0 56477.4 49906.8 50365.5 50690.2 50723.0 50840.2 8625.9 8790.2 8804.9 8814.9 8849.7 33099.8 33270.2 33371.2 33540.7 33923.2 43433.3 44146.1 44720.0 44980.6 45445.8 11132.4 11320.9 11689.8 11696.9 11827.6 12043.5 12179.8 12336.7 12360.3 12371.7 11776.0 11965.9 11967.9 12062.6 12147.0 12029.2 12202.5 12339.0 12341.8 12413.8 11480.8 11603.5 11859.2 11919.6 11953.7 9769.0 9933.4 10207.3 10297.7 10367.6 9605.5 9933.7 9977.0 10043.9 10096.6 09:01:19 INFO - PROCESS | 26870 | -------- Summary: end -------- 09:01:19 INFO - PROCESS | 26870 | 09:01:19 INFO - TEST-INFO | 26870: exit 0 09:01:19 INFO - TEST-OK | dromaeo_css | took 1109912ms 09:01:19 INFO - TEST-START | kraken 09:01:19 INFO - operating with platform_type : linux_ 09:01:19 INFO - Initialising browser for kraken test... 09:01:19 INFO - TEST-INFO | started process 27112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpth3fzo/profile http://localhost:59413/getInfo.html) 09:01:23 INFO - PROCESS | 27112 | 09:01:23 INFO - PROCESS | 27112 | (process:27179): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:01:24 INFO - PROCESS | 27112 | __metrics Screen width/height:1600/1200 09:01:24 INFO - PROCESS | 27112 | colorDepth:24 09:01:24 INFO - PROCESS | 27112 | Browser inner width/height: 1024/697 09:01:24 INFO - PROCESS | 27112 | __metrics 09:01:24 ERROR - PROCESS | 27112 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 09:01:25 INFO - TEST-INFO | 27112: exit 0 09:01:25 INFO - Browser initialized. 09:01:25 INFO - Running cycle 1/1 for kraken test... 09:01:25 INFO - TEST-INFO | started process 27230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpth3fzo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:27 INFO - PROCESS | 27230 | 09:01:27 INFO - PROCESS | 27230 | (process:27292): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:01:37 INFO - PROCESS | 27230 | RSS: Main: 163414016 09:01:37 INFO - PROCESS | 27230 | 09:01:39 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59413/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:40 INFO - PROCESS | 27230 | RSS: Main: 167886848 09:01:40 INFO - PROCESS | 27230 | 09:01:43 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59413/tests/kraken/driver.html?testName=audio-dft) 09:01:44 INFO - PROCESS | 27230 | RSS: Main: 167858176 09:01:44 INFO - PROCESS | 27230 | 09:01:46 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59413/tests/kraken/driver.html?testName=audio-fft) 09:01:47 INFO - PROCESS | 27230 | RSS: Main: 162717696 09:01:47 INFO - PROCESS | 27230 | 09:01:49 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59413/tests/kraken/driver.html?testName=audio-oscillator) 09:01:50 INFO - PROCESS | 27230 | RSS: Main: 163278848 09:01:50 INFO - PROCESS | 27230 | 09:01:52 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59413/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:53 INFO - PROCESS | 27230 | RSS: Main: 163532800 09:01:53 INFO - PROCESS | 27230 | 09:01:56 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59413/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:57 INFO - PROCESS | 27230 | RSS: Main: 164364288 09:01:57 INFO - PROCESS | 27230 | 09:02:00 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59413/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:01 INFO - PROCESS | 27230 | RSS: Main: 162807808 09:02:01 INFO - PROCESS | 27230 | 09:02:04 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59413/tests/kraken/driver.html?testName=json-parse-financial) 09:02:04 INFO - PROCESS | 27230 | RSS: Main: 163340288 09:02:04 INFO - PROCESS | 27230 | 09:02:06 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59413/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:07 INFO - PROCESS | 27230 | RSS: Main: 163483648 09:02:07 INFO - PROCESS | 27230 | 09:02:08 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59413/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:09 INFO - PROCESS | 27230 | RSS: Main: 163532800 09:02:09 INFO - PROCESS | 27230 | 09:02:11 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59413/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:12 INFO - PROCESS | 27230 | RSS: Main: 163524608 09:02:12 INFO - PROCESS | 27230 | 09:02:14 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59413/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:15 INFO - PROCESS | 27230 | RSS: Main: 164569088 09:02:15 INFO - PROCESS | 27230 | 09:02:18 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59413/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:19 INFO - PROCESS | 27230 | RSS: Main: 164077568 09:02:19 INFO - PROCESS | 27230 | 09:02:20 INFO - PROCESS | 27230 | Cycle 1(1): loaded http://localhost:59413/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59413/tests/kraken/driver.html?testName=ai-astar) 09:02:21 INFO - PROCESS | 27230 | RSS: Main: 165412864 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | __start_tp_report 09:02:21 INFO - PROCESS | 27230 | _x_x_mozilla_page_load 09:02:21 INFO - PROCESS | 27230 | _x_x_mozilla_page_load_details 09:02:21 INFO - PROCESS | 27230 | |i|pagename|runs| 09:02:21 INFO - PROCESS | 27230 | |0;ai-astar;109;110;105;112;113;110;104;112;111;110 09:02:21 INFO - PROCESS | 27230 | |1;audio-beat-detection;156;132;153;222;126;157;160;131;178;133 09:02:21 INFO - PROCESS | 27230 | |2;audio-dft;163;163;163;161;165;173;162;162;162;162 09:02:21 INFO - PROCESS | 27230 | |3;audio-fft;75;75;75;158;75;86;74;74;172;76 09:02:21 INFO - PROCESS | 27230 | |4;audio-oscillator;92;91;181;91;92;93;148;95;92;163 09:02:21 INFO - PROCESS | 27230 | |5;imaging-gaussian-blur;117;118;117;117;118;118;117;117;117;117 09:02:21 INFO - PROCESS | 27230 | |6;imaging-darkroom;147;147;147;147;147;147;149;147;147;146 09:02:21 INFO - PROCESS | 27230 | |7;imaging-desaturate;96;96;95;96;95;95;96;96;95;95 09:02:21 INFO - PROCESS | 27230 | |8;json-parse-financial;61;61;60;59;61;60;65;109;58;59 09:02:21 INFO - PROCESS | 27230 | |9;json-stringify-tinderbox;59;60;59;60;60;60;60;60;61;59 09:02:21 INFO - PROCESS | 27230 | |10;stanford-crypto-aes;83;85;79;80;79;91;79;80;79;80 09:02:21 INFO - PROCESS | 27230 | |11;stanford-crypto-ccm;145;127;131;124;130;124;135;123;187;136 09:02:21 INFO - PROCESS | 27230 | |12;stanford-crypto-pbkdf2;175;173;170;171;174;171;169;172;169;181 09:02:21 INFO - PROCESS | 27230 | |13;stanford-crypto-sha256-iterative;67;68;67;65;66;64;72;71;65;65 09:02:21 INFO - PROCESS | 27230 | __end_tp_report 09:02:21 INFO - PROCESS | 27230 | __start_cc_report 09:02:21 INFO - PROCESS | 27230 | _x_x_mozilla_cycle_collect,862 09:02:21 INFO - PROCESS | 27230 | __end_cc_report 09:02:21 INFO - PROCESS | 27230 | __startTimestamp1463068941108__endTimestamp 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | ------- Summary: start ------- 09:02:21 INFO - PROCESS | 27230 | Number of tests: 14 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.95 (2.7%) stddev-sans-first:3.12 09:02:21 INFO - PROCESS | 27230 | Values: 109.0 110.0 105.0 112.0 113.0 110.0 104.0 112.0 111.0 110.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:156.50 stddev:28.83 (18.4%) stddev-sans-first:30.58 09:02:21 INFO - PROCESS | 27230 | Values: 156.0 132.0 153.0 222.0 126.0 157.0 160.0 131.0 178.0 133.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.47 (2.1%) stddev-sans-first:3.67 09:02:21 INFO - PROCESS | 27230 | Values: 163.0 163.0 163.0 161.0 165.0 173.0 162.0 162.0 162.0 162.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:37.73 (50.3%) stddev-sans-first:39.39 09:02:21 INFO - PROCESS | 27230 | Values: 75.0 75.0 75.0 158.0 75.0 86.0 74.0 74.0 172.0 76.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#4] audio-oscillator Cycles:10 Average:113.80 Median:92.00 stddev:35.52 (38.6%) stddev-sans-first:36.79 09:02:21 INFO - PROCESS | 27230 | Values: 92.0 91.0 181.0 91.0 92.0 93.0 148.0 95.0 92.0 163.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:02:21 INFO - PROCESS | 27230 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:02:21 INFO - PROCESS | 27230 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 149.0 147.0 147.0 146.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:02:21 INFO - PROCESS | 27230 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:60.50 stddev:15.47 (25.6%) stddev-sans-first:16.33 09:02:21 INFO - PROCESS | 27230 | Values: 61.0 61.0 60.0 59.0 61.0 60.0 65.0 109.0 58.0 59.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 09:02:21 INFO - PROCESS | 27230 | Values: 59.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 61.0 59.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.00 stddev:3.89 (4.9%) stddev-sans-first:4.09 09:02:21 INFO - PROCESS | 27230 | Values: 83.0 85.0 79.0 80.0 79.0 91.0 79.0 80.0 79.0 80.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:133.00 stddev:19.10 (14.4%) stddev-sans-first:19.99 09:02:21 INFO - PROCESS | 27230 | Values: 145.0 127.0 131.0 124.0 130.0 124.0 135.0 123.0 187.0 136.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.50 stddev:3.60 (2.1%) stddev-sans-first:3.70 09:02:21 INFO - PROCESS | 27230 | Values: 175.0 173.0 170.0 171.0 174.0 171.0 169.0 172.0 169.0 181.0 09:02:21 INFO - PROCESS | 27230 | 09:02:21 INFO - PROCESS | 27230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.67 (4.0%) stddev-sans-first:2.83 09:02:21 INFO - PROCESS | 27230 | Values: 67.0 68.0 67.0 65.0 66.0 64.0 72.0 71.0 65.0 65.0 09:02:21 INFO - PROCESS | 27230 | -------- Summary: end -------- 09:02:21 INFO - PROCESS | 27230 | 09:02:22 INFO - TEST-INFO | 27230: exit 0 09:02:22 INFO - TEST-OK | kraken | took 62218ms 09:02:22 INFO - SUITE-END | took 1172s 09:02:22 INFO - Completed test suite (00:19:32) 09:02:22 INFO - javascript benchmark 09:02:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7205.569255980602, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3193.80837149771, 3230.4992726127457, 3245.9126192725444, 3257.2019855135495, 3257.9411691200366, 5424.647397919138, 5434.510894019538, 5479.232907392963, 5529.640573362729, 5560.138178582326, 5412.539934105596, 5474.945250547494, 5488.9725551372185, 5517.972410137953, 5523.530499907502, 4917.680350777197, 4965.404151501825, 5090.516400941923, 5110.080185566597, 5155.510226528474, 895.3719150244356, 4865.464798872121, 4987.725675087869, 5069.0, 5127.359080114986, 5002.499750025005, 5008.899822003557, 5026.97486512567, 5051.797928082872, 5090.796368145269, 5037.798488060474, 5048.596112311043, 5055.0, 5073.239014147907, 5074.13739664258, 4960.156773348539, 5022.372203474566, 5052.292679024939, 5055.772490237948, 5091.949080509185, 5444.0, 5460.863478413032, 5464.043792336365, 5479.6164268501225, 5538.723063846792, 5677.659340439587, 5766.913496297517, 5905.4980326672285, 5932.584719069667, 5937.70311484424, 5830.737616807254, 5878.41215878413, 5889.411058894119, 5935.287765468128, 5948.583599148062, 5437.483439073281, 5467.0705979983495, 5472.972635136839, 5492.395836457987, 5500.037493438632, 5839.824805255849, 5898.262717160355, 5917.792877249276, 5990.520758339322, 6017.18767966319, 5627.380988091307, 5634.774609015593, 5702.486776190163, 5724.742386592613, 5744.396838331999, 5728.312602487728, 5740.885182296414, 5827.038538641162, 5836.649801011953, 5838.182654428383, 5748.367679555246, 5791.88416231673, 5801.6809075500405, 5818.854528636733, 5859.1797148399255, 5914.76340946366, 5929.822105336761, 5958.374370691015, 5966.552508561876, 6007.699615019232, 4488.147252022105, 4509.458864936163, 4510.571495707903, 4513.616342610915, 4546.52261512543, 3925.116848709075, 3935.4490371348033, 3961.8613348532663, 4011.91976160481, 4076.735012224255, 5542.196381524656, 5578.330600327906, 5603.971980140073, 5609.1305847593685, 5659.462351076641, 5865.35481097079, 5871.236739223959, 5881.059030555176, 5884.617499862581, 5885.793997210077, 5506.476884695948, 5559.499645031967, 5560.527355174855, 5567.526760225426, 5601.383847776741, 5031.195008798648, 5061.190209566452, 5084.669496482717, 5106.336176297058, 5123.205903085028, 6106.511479081662, 6126.203593532812, 6134.693265336716, 6158.1686472326555, 6160.353162917919, 5817.272840894888, 5828.6211396259105, 5880.8235752927485, 5887.08750143737, 5912.231409916683, 6073.058675905242, 6084.269887613515, 6098.644029113846, 6100.096771792299, 6128.938710612837, 5770.336411312753, 5773.076307790733, 5790.10253410722, 5795.072788353843, 5842.269716285465, 5731.426857314235, 5852.707364631837, 5876.382979787061, 5884.617499862496, 5914.467697907209, 5727.627704199213, 5762.7694892203845, 5770.596058276048, 5775.451332123442, 5777.74000169985, 5740.68426236561, 5782.335031471434, 5783.652980821164, 5790.10253410722, 5810.448007439287, 5557.805476808292, 5624.100143977108, 5652.660840349592, 5666.376698563073, 5732.025555655632, 5809.419058094326, 5854.941450585439, 5857.7949771757785, 5862.618929769551, 5866.911996320144, 5572.693501857437, 5726.799562015476, 5738.053221218453, 5753.539716822561, 5759.136129580429], "value": 5396.112932514004, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.5040716205547, 653.8365408647838, 659.6899457255089, 663.2174034639125, 673.942714869236, 43164.78417607911, 43913.78043109784, 44242.55757442429, 46877.0, 47183.76408117954, 44145.33781993265, 44643.10713785722, 44764.552354476444, 44786.7760661197, 44876.0, 8833.779155521115, 8963.95518022409, 8971.192592666659, 8974.775630609221, 8992.100789920989, 8904.777380565472, 8951.95524022379, 8952.239059679934, 8960.910390896106, 8979.730608081769, 8997.145271199226, 8999.865002024975, 9015.729528114167, 9016.188543031127, 9032.232260257886, 8919.598618062171, 8949.821003579957, 8960.462372257685, 8961.775955601097, 9002.819943601156, 8840.204381605687, 8861.335399845037, 8912.24245939096, 8937.64249430022, 8943.0, 40646.39030414546, 40911.38632920509, 41050.178996419905, 41122.1775564487, 41346.793266033776, 3401.183715908189, 3579.1231148368556, 3605.801680907549, 3617.475466057433, 4085.6935729820384, 31496.527552086736, 32253.677463225304, 32295.51556726651, 32360.5145922809, 32429.35141297161, 4192.601702838256, 4197.706160568761, 4209.957900420987, 4251.0, 4266.5946735060115, 289072.0, 290230.0, 291785.0, 292378.0, 294603.0, 58655.0, 59179.63281468779, 59207.40792592105, 59318.406815932154, 59401.702991484766, 36313.45529817055, 37126.257474850354, 37145.62854371476, 38561.0, 38585.614143858766, 17774.0, 17893.28426862937, 18053.548661283574, 18054.368097116538, 18068.819311806976, 13646.931765341309, 13649.86350136486, 13694.383752730952, 13708.52020179289, 13791.379387927567, 20072.89599072065, 20073.698894516303, 20223.393298201077, 20238.291659792132, 20337.76284608692, 7479.065116860393, 7522.5862577558755, 7584.748516494827, 7712.9614351927885, 7794.207332313599, 923.4462100021885, 1134.466800603715, 1142.9371384573928, 1151.7696460707891, 1220.7009282725612, 31208.063758087294, 31486.685133148374, 32230.516542251884, 32378.0, 32554.511682324784, 1122.814735568622, 1144.582227486978, 1149.287441786098, 1175.7060734816296, 1206.5776978057609, 16817.15914204285, 16964.660706785795, 17152.142392880305, 17293.913530432517, 17315.826841731672, 454933.0, 455321.0, 455618.0, 455714.0, 457769.0, 58325.416745832845, 58399.70800145972, 58802.705986469795, 58974.41025589775, 59008.7049564758, 1367.2548461088732, 1394.7907813827803, 1402.7545179593735, 1407.3596513586294, 1413.8162038934872, 30582.388352232385, 31086.37827243488, 31219.531707023958, 31722.68277317197, 32593.18517037093, 52625.210621839935, 52739.208911865586, 52925.470745292056, 53033.0, 53204.733976331416, 357156.0, 362031.0, 364638.0, 366591.0, 366891.0, 28092.297692557848, 28600.0, 28620.42759144847, 28650.283742906595, 28674.56988145221, 48438.27342589793, 49412.0, 49830.50169498259, 50039.24941125959, 50433.74783126061, 39881.800590996856, 40630.593694063864, 41610.167796644506, 41923.58076419197, 42488.36267456052, 41804.372934406616, 42238.366424503045, 42290.57709422989, 42483.78758106189, 43010.0, 42583.0, 42601.786991064844, 43176.784116079216, 43371.34942975921, 45349.0, 36250.456243155844, 36562.63437365592, 37191.8140409307, 37780.0, 37994.240115198096, 28979.710202898543, 29074.418511630072, 29171.66626669819, 29291.707082928897, 29633.703662963955], "value": 20014.167504543533, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.7516927089841, 407.7961019490255, 408.12660905661886, 408.3547994169212, 416.27775808971427, 17878.463646090622, 19544.0, 19595.412137635893, 19600.31398901039, 20452.284170054052, 19127.330543430984, 19378.321758738446, 19906.601867962632, 19945.401637950847, 19952.50118747032, 5443.0, 5647.548196144319, 5711.657300561958, 5715.885682286352, 5792.507636850873, 5698.430156984289, 5700.8859822803515, 5734.168545560891, 6483.870322593545, 6504.447121994636, 6451.903221451682, 6454.128692626482, 6458.192725909262, 6470.385313395243, 6494.967525162368, 5759.769609215627, 5785.999999999979, 5809.564282678773, 5859.853503662443, 6261.530385221126, 5456.127019676833, 5629.4652008059165, 5666.546676265889, 5676.631018983753, 5681.460261275172, 13658.317084145852, 13855.0, 13873.445062197601, 13964.231967241798, 13991.440342386293, 2245.7529671736097, 2245.9326220213256, 2500.335265455735, 2594.416256342327, 2735.7948153888337, 10173.033561811617, 10320.79358412835, 10333.173346132291, 10481.213908956859, 10505.737356566071, 1976.239147928058, 2020.3332900142918, 2030.4213299209803, 2057.506198512346, 2060.6805945078386, 81990.59004704938, 84588.57705711493, 84875.57562212211, 85251.57374213151, 85907.57046214728, 10880.510377032893, 10991.890081099087, 11233.269837460539, 11470.942645286721, 11474.827877581843, 15924.681506369807, 15973.201339932957, 15978.76031859523, 15997.0, 16144.0, 8331.95834020826, 8596.398252122417, 8661.350398720122, 8682.175193356621, 8719.624868366136, 8239.876401853857, 8375.785511100978, 8388.496690198608, 8413.831723365498, 8457.154284571494, 4760.0, 4768.9523104768505, 4880.9749952509665, 4973.254011898244, 4973.303737476756, 2018.4348382452642, 2032.5325175209489, 2085.843561732876, 2099.118370284484, 2123.766385697572, 975.7414285214423, 1057.318029870729, 1076.7954088723118, 1083.4907593431076, 1130.6947124276564, 19233.134508946852, 19432.611347772967, 19526.0, 19634.509137271398, 19740.65689662013, 953.6423841059602, 964.0455948610964, 986.4647855012691, 990.7997169143706, 1024.6823484719762, 10655.733606659896, 10782.892171078345, 10918.781624367468, 10957.397343146204, 11144.554217831359, 497346.0, 513000.0, 523215.0, 526386.0, 529035.0, 94872.0, 97938.0, 99103.0, 99597.0, 101414.0, 1088.1186239146316, 1090.5637744901944, 1126.5099681638515, 1132.7281452451352, 1139.8746137924823, 17740.0, 17837.197326120615, 17917.104144792447, 17946.641067178844, 17967.82032179714, 42982.57017429911, 43226.78386608173, 43351.34972975345, 44409.0, 44598.77700611476, 59277.407225927185, 59286.70356648189, 59603.403965959784, 60564.6971765156, 61458.0, 8870.112988701077, 8924.375293729376, 8983.146601072887, 9072.319576031692, 9180.44917304964, 11822.172447928562, 13262.93368533151, 13421.798673020108, 13607.047506674438, 13715.519956801863, 11656.475458604213, 11977.461014254206, 11982.460789264329, 12002.21985570935, 12237.755244894874, 11878.287302761863, 11918.642440726791, 11928.224665396721, 11929.224600400947, 11982.281063136239, 12013.339266340436, 12072.275663460221, 12556.121071524905, 12674.936625316814, 12852.742945141232, 8814.338924580554, 8879.511626860585, 9000.684976025808, 9113.270938324786, 9153.313501487548, 12066.095042871644, 12300.200486968319, 12362.0, 12377.876221238033, 12429.401121585071], "value": 9440.755409211743, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.7569950958089, 1527.90832550047, 1691.509462255946, 1829.7438358629786, 1831.9267229310828, 8093.716719914804, 8311.750647480578, 8533.957330213356, 9045.09549045095, 9048.5928133234, 8622.267107295887, 8856.734297971056, 8866.290696744261, 8883.422577532456, 8960.462372257653, 2343.2267351773917, 2349.107339211106, 2370.3363058343693, 2374.6912901322803, 2377.6076947303673, 2299.2642354446584, 2305.6080466320764, 2335.065973610561, 2335.7664233576675, 2339.3800642829665, 2349.6475528670667, 2350.588646986779, 2354.564405584964, 2365.1603680693365, 2374.905003799846, 2231.933042008742, 2303.3435470890718, 2305.6310990241564, 2321.7097862767237, 2339.21636251855, 2302.6200676888293, 2332.93001209964, 2346.765323467657, 2353.505763789606, 2360.386299562109, 8747.343949203836, 8821.338399620054, 8856.734297971072, 8872.245859101984, 8919.06349833271, 5042.09242336383, 5050.191969284933, 5209.166533354645, 5210.947890521122, 5242.266082748418, 3372.3423932333203, 3407.267437500949, 3485.9302813943577, 3503.562054743157, 3515.2617950230483, 1182.5151687808043, 1196.116581760215, 1203.6930582701443, 1218.0986070307997, 1247.9688007799787, 11836.408179591072, 11852.34812085335, 11875.34685592292, 11886.583969561023, 11928.40357982106, 4382.474103107647, 4398.516163222043, 4470.86587402372, 4481.081378317503, 4493.213687604656, 9995.600175992879, 10063.19494440443, 10080.69757907264, 10095.44475053879, 10100.949495252476, 5118.360204974379, 5122.385313762373, 5128.79484820603, 5148.536631703165, 5162.174052151638, 4361.781910904442, 4739.928901066487, 4787.162246606899, 4896.828610998598, 4899.093667671421, 3914.6085391461197, 3974.4833171687496, 4042.4542686737504, 4066.1054567994993, 4120.402541631447, 1256.9371531423392, 1262.3625069339926, 1267.9112462127562, 1273.3505911984769, 1273.4142294544429, 988.8170688422665, 991.8512223166583, 994.9850752238722, 1005.2460654509118, 1011.2971484817981, 5971.820845374646, 5974.253218347707, 6024.216851809324, 6043.7280322385595, 6146.5390095743, 458.1478450082843, 461.16529082361035, 466.19348527048396, 476.9523047695272, 477.9665423420397, 4010.7192496525545, 4101.7744024078365, 4135.276326642826, 4147.564505726916, 4158.6465150462545, 10327.070563649308, 10626.628068017582, 10759.946200269105, 10782.514786834612, 10808.567657293777, 10231.846522302172, 10564.894351056391, 10754.569817207224, 10754.623588174376, 10777.137828973664, 8329.916700833035, 8348.373871959628, 8406.873896891551, 8519.403641745143, 8522.786930326667, 5939.495142912728, 5975.790847320497, 6164.229471316085, 6214.782482613087, 6356.442671545501, 9446.0, 9496.050394960448, 9542.284328675238, 9547.522623868917, 9696.22430205596, 10136.74658133523, 10395.792084158124, 10513.211509136998, 10549.841752373566, 10633.840492392466, 7018.543794653331, 7639.694412223449, 7945.721899733481, 7964.761057168294, 8043.075046369742, 8654.653813847375, 8749.0, 8768.430052046597, 8777.0, 8782.297416206817, 7785.221477852169, 8011.340664167464, 8050.758477245692, 8105.513669179868, 8133.918660813316, 7884.921150788418, 7918.604069796372, 7940.404469664913, 8018.558979256197, 8028.07677117139, 7190.712371505081, 7208.531445456028, 7260.092488438945, 7290.817729556804, 7295.890561641473, 5259.316288882421, 5328.227407026037, 5337.119375303031, 5354.170103633943, 5380.408155103014, 5217.295665085165, 5325.440828713085, 5326.201069839555, 5328.62699611039, 5419.187121931742], "value": 4589.911733153426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.87167568810304, 333.1654206213435, 339.0726363396113, 339.1639608365379, 340.9880654177104, 5430.266913966613, 5517.420670829565, 5553.861153471165, 5667.149927510875, 5689.345725241593, 5571.609987300891, 5594.440555944404, 5632.549396048316, 5643.548516118711, 5645.943540564593, 4341.826326946926, 4362.781860906958, 4372.366006928994, 4436.8668939931695, 4461.977690111545, 4170.4578404807335, 4422.889427764299, 4424.623906967911, 4455.754933478657, 4476.910461790762, 4331.371951067109, 4347.760873151976, 4367.475902891658, 4374.912501749963, 4392.912141757163, 4371.3661519079715, 4390.69265151438, 4397.5602439756085, 4410.206162890679, 4428.357888106207, 3778.735488515805, 3840.2511510255513, 3864.8840534784003, 3866.381378979378, 3876.379779235337, 5458.925608268833, 5462.781488740446, 5464.890702185974, 5491.917621235684, 5519.9448005519835, 4946.788036930975, 4962.900741985176, 4975.427825800043, 5005.449400565934, 5007.799688012475, 5623.522000629951, 5841.707914604252, 5842.474177324061, 5889.8822023559715, 5909.852253693649, 4136.172765446892, 4138.627523522868, 4142.668586513072, 4146.709730318879, 4150.709450338478, 6113.908291375633, 6140.802543504018, 6159.445649891486, 6177.413145751147, 6182.319944806068, 3997.720159588801, 4299.14017196562, 4312.116016216668, 4313.4823821141035, 4319.43847299849, 4289.313709806416, 4304.48346198452, 4326.437563116775, 4333.569921925757, 4362.411074504965, 4850.320955066293, 4879.0725564661625, 4897.314375987365, 4923.975380123076, 4947.381577302837, 5760.279965004374, 5886.852828679317, 5911.76352945886, 5963.612365196335, 5979.372165922602, 1487.8586534279227, 1504.8495150484864, 1507.0957425544805, 1509.4415066425493, 1509.8112735908012, 926.6061923682408, 952.3999880075646, 952.7284723853807, 964.81668482988, 965.6137544982064, 5047.0, 5068.619853511002, 5078.720670363092, 5094.974525127424, 5140.40885298188, 5384.91922621161, 5430.782768689208, 5439.673619582838, 5441.863953401196, 5447.591430642718, 4911.68074075184, 4996.0, 5103.438621751604, 5172.560332371715, 5217.478252174752, 2876.395956849085, 2907.0, 2907.4039821836473, 2919.0, 2926.707329267056, 5434.456554344534, 5545.334559852843, 5551.084071128299, 5630.211770352154, 5638.011853717537, 5379.327584051994, 5689.9146512802345, 6178.0, 6195.915714749901, 6205.2553693557065, 6284.49172198669, 6285.434310911948, 6295.937040629535, 6330.778422755181, 6333.176687030748, 6001.5798894077, 6104.8779024420155, 6133.141360209664, 6138.416850399205, 6163.35284795108, 6009.519238461, 6015.218021657157, 6018.879622407615, 6042.1540984261355, 6051.910656081947, 5984.222051133324, 6069.9089513656445, 6235.661626889916, 6296.748130074746, 6332.588381755171, 4230.302000169938, 4283.250431174594, 4297.247981603269, 4299.376590394438, 4305.526392096805, 6123.571350005457, 6157.476614487819, 6181.0, 6188.288346840171, 6211.565190436626, 5752.798652047159, 5890.852728681817, 5903.586748927534, 5916.467517923407, 5994.610350327215, 5770.538356931519, 5877.147813567094, 5881.823545293648, 5899.203607513103, 5937.376575459687, 5656.0, 5711.400302968129, 5804.245448091721, 5819.76720931175, 5857.355690873916, 5961.344252132175, 5983.7008149591475, 5992.64044157352, 6020.127081573235, 6074.0281554951, 5891.1457838612305, 5893.941060589511, 5896.616719913192, 5904.852378690567, 5909.349971503045], "value": 4416.322113420689, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.9199080091992, 807.725373373053, 844.2739244249948, 854.2397266432872, 864.1358641358642, 14222.57332280032, 15105.244737763109, 15135.62160945977, 15247.847521524809, 15291.770623440658, 14163.929180354084, 14202.36089375978, 14233.0, 14246.572602821932, 14269.143851368925, 693.2720643324502, 813.9593020348989, 828.9709860154895, 829.6142293833366, 830.323286521483, 835.1439774231401, 836.8326334733048, 840.357126798, 840.3949156607233, 841.167244428018, 857.652650676477, 860.8536548786722, 860.9926386128213, 866.8829707989404, 867.375489647456, 860.3289434241302, 862.5514732339179, 864.4510735682824, 865.1002956924791, 865.2342676731075, 624.7032659486753, 625.9530535209832, 627.7896904536985, 628.0202883501706, 630.3161070238797, 14376.281185940661, 14380.64048398788, 14467.855321446756, 14486.275686215753, 14497.34761935705, 13997.860021399758, 14053.297335133202, 14155.787663185061, 14284.500042498463, 14528.636784080376, 11508.654740357802, 11785.705357366049, 11791.764164716658, 11896.762064758655, 12000.21998570099, 3870.806459677033, 3872.283627528888, 3914.3541315683165, 3945.861894833667, 3960.1683646434285, 53698.463015369736, 54487.727561362335, 54654.0, 55102.0, 55254.0, 11070.931572305635, 11155.498002589902, 11239.21325507223, 11306.095512358992, 11405.201635885409, 19078.33225837089, 19088.045597720058, 19108.522286942938, 19117.61764764697, 19138.904305478383, 8243.464174828738, 8340.249377556049, 8429.747107586782, 8568.742937711879, 8653.826923461496, 4805.831795887128, 4834.105690447279, 4915.459299477055, 4965.453800081988, 5001.074801161797, 3218.2758879251983, 3365.5793025871767, 3377.7804442711144, 3383.018924511864, 3387.6612338765926, 686.842026333946, 687.5084314714903, 695.9826004349932, 697.1425147069032, 697.3096634331974, 768.5657603454031, 770.876659734451, 772.9497582657109, 774.5197977254138, 787.0987719061642, 9334.533273336307, 9617.134457898823, 9626.95186524077, 9736.853947190797, 9759.951200244095, 744.7840126363402, 754.6792613139394, 770.5723323555369, 779.0223269796369, 788.1409263902374, 4292.806823692941, 4304.548022457597, 4321.178975994614, 4329.956700433018, 4434.379186913835, 56411.0, 61281.38718612846, 61324.0, 61368.69315653483, 61402.0, 53697.46302537003, 54033.0, 54914.45085549093, 56258.0, 56477.43522564804, 49906.75046624744, 50365.49634503608, 50690.23964640533, 50723.0, 50840.237396439086, 8625.8706119407, 8790.164934331227, 8804.911950880409, 8814.867776983223, 8849.690260841096, 33099.83450082831, 33270.16824579405, 33371.16572085717, 33540.66459335473, 33923.15192120118, 43433.3484997719, 44146.117077658906, 44720.0, 44980.550194498945, 45445.77277113593, 11132.443377830914, 11320.886791131983, 11689.824652630048, 11696.941515292368, 11827.645170644895, 12043.458044388199, 12179.817302740288, 12336.691582710504, 12360.320182390054, 12371.69070773238, 11776.0, 11965.880341196826, 11967.940160299142, 12062.577809776616, 12147.028237740782, 12029.15795894314, 12202.450889709808, 12339.0, 12341.753164936472, 12413.813792792935, 11480.770384592428, 11603.477843497232, 11859.169858110195, 11919.642410727693, 11953.701157471132, 9769.0, 9933.3543319684, 10207.336523125972, 10297.691069267934, 10367.63713270032, 9605.47169905634, 9933.701988940344, 9976.950115249378, 10043.89956100459, 10096.610430744375], "value": 6771.3578018414855, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 105.0, 112.0, 113.0, 110.0, 104.0, 112.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 153.0, 222.0, 126.0, 157.0, 160.0, 131.0, 178.0, 133.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 161.0, 165.0, 173.0, 162.0, 162.0, 162.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 158.0, 75.0, 86.0, 74.0, 74.0, 172.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 181.0, 91.0, 92.0, 93.0, 148.0, 95.0, 92.0, 163.0], "value": 113.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 59.0, 61.0, 60.0, 65.0, 109.0, 58.0, 59.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 79.0, 80.0, 79.0, 91.0, 79.0, 80.0, 79.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 127.0, 131.0, 124.0, 130.0, 124.0, 135.0, 123.0, 187.0, 136.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 170.0, 171.0, 174.0, 171.0, 169.0, 172.0, 169.0, 181.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 65.0, 66.0, 64.0, 72.0, 71.0, 65.0, 65.0], "value": 67.0, "unit": "score"}]}]} 09:02:22 INFO - Return code: 0 09:02:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:02:22 ERROR - # TBPL SUCCESS # 09:02:22 INFO - Running post-action listener: _resource_record_post_action 09:02:22 INFO - ##### 09:02:22 INFO - ##### Finished run-tests step (success) 09:02:22 INFO - ##### 09:02:22 INFO - Running post-run listener: _resource_record_post_run 09:02:23 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 539086848; Read time: 276; Write time: 524308 09:02:23 INFO - TinderboxPrint: CPU usage
13.4% 09:02:23 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 276 09:02:23 INFO - TinderboxPrint: I/O write bytes / time
539,086,848 / 524,308 09:02:23 INFO - TinderboxPrint: CPU idle
8,222.1 (86.6%) 09:02:23 INFO - TinderboxPrint: CPU user
1,218.3 (12.8%) 09:02:23 INFO - TinderboxPrint: Swap in / out
0 / 0 09:02:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 251879424; Read time: 268; Write time: 269584 09:02:23 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287207424; Read time: 8; Write time: 254724 09:02:23 INFO - Running post-run listener: _upload_blobber_files 09:02:23 INFO - Blob upload gear active. 09:02:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:23 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 09:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:23 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:02:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:02:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:24 INFO - (blobuploader) - INFO - Done attempting. 09:02:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:02:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:02:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:25 INFO - (blobuploader) - INFO - Done attempting. 09:02:25 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:25 INFO - Return code: 0 09:02:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dbac156581d349470d5f261a72acbf202cdff219c7de6ce463402750b196bdfb5ef3eacc84cd2547cab74a76b296ace7a1ada64df5c9317692f5c5db2f540e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb077a81ee23266f885aa26a0ef008d7fdb6aca77c425817ad98f853b0ba9f9cc9a636cf2e7391a71dd311c1c877b5aab0a51ec3c99d8135345c53d4ef4ba55f"} 09:02:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:25 INFO - Contents: 09:02:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dbac156581d349470d5f261a72acbf202cdff219c7de6ce463402750b196bdfb5ef3eacc84cd2547cab74a76b296ace7a1ada64df5c9317692f5c5db2f540e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb077a81ee23266f885aa26a0ef008d7fdb6aca77c425817ad98f853b0ba9f9cc9a636cf2e7391a71dd311c1c877b5aab0a51ec3c99d8135345c53d4ef4ba55f"} 09:02:25 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:25 INFO - Copying logs to upload dir... 09:02:25 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.630961 ========= master_lag: 7.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-12 09:02:32.418452) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 09:02:32.421834) ========= 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=62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dbac156581d349470d5f261a72acbf202cdff219c7de6ce463402750b196bdfb5ef3eacc84cd2547cab74a76b296ace7a1ada64df5c9317692f5c5db2f540e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb077a81ee23266f885aa26a0ef008d7fdb6aca77c425817ad98f853b0ba9f9cc9a636cf2e7391a71dd311c1c877b5aab0a51ec3c99d8135345c53d4ef4ba55f"} build_url:https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010419 build_url: 'https://queue.taskcluster.net/v1/task/NZAgrqTqQrW3Ge8-1JnRcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dbac156581d349470d5f261a72acbf202cdff219c7de6ce463402750b196bdfb5ef3eacc84cd2547cab74a76b296ace7a1ada64df5c9317692f5c5db2f540e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb077a81ee23266f885aa26a0ef008d7fdb6aca77c425817ad98f853b0ba9f9cc9a636cf2e7391a71dd311c1c877b5aab0a51ec3c99d8135345c53d4ef4ba55f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 09:02:32.445321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:02:32.445654) ========= 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=62c568580acbfdaac3eec7be000001dc-1463067715.236729-682204909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:02:32.495435) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 09:02:32.495796) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 09:02:32.496115) ========= ========= Total master_lag: 7.45 =========