builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1464872303.29 results: success (0) buildid: 20160602023007 builduid: c63a654640cd4a968f69288208d50d0d revision: 034b45ace455de8b62f389fc0b940583d9c62ea6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:23.285568) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:23.286014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:23.286288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:23.301319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:23.301761) ========= 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=1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 05:58:23-- 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-06-02 05:58:23 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:23.430050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:23.430360) ========= 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=1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020073 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:23.480038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 05:58:23.480425) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 034b45ace455de8b62f389fc0b940583d9c62ea6 --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 034b45ace455de8b62f389fc0b940583d9c62ea6 --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=1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 05:58:24,036 truncating revision to first 12 chars 2016-06-02 05:58:24,036 Setting DEBUG logging. 2016-06-02 05:58:24,036 attempt 1/10 2016-06-02 05:58:24,036 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/034b45ace455?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 05:58:25,116 unpacking tar archive at: fx-team-034b45ace455/testing/mozharness/ program finished with exit code 0 elapsedTime=1.445875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 05:58:24.940272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:24.940748) ========= script_repo_revision: 034b45ace455de8b62f389fc0b940583d9c62ea6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:24.941147) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:24.941483) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 05:58:24.951455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-02 05:58:24.951785) ========= /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=1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:25 INFO - MultiFileLogger online at 20160602 05:58:25 in /builds/slave/test 05:58:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:58:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:25 INFO - {'append_to_log': False, 05:58:25 INFO - 'base_work_dir': '/builds/slave/test', 05:58:25 INFO - 'blob_upload_branch': 'Fx-Team', 05:58:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:25 INFO - 'branch': 'Fx-Team', 05:58:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:25 INFO - 'config_files': ('talos/linux_config.py',), 05:58:25 INFO - 'default_actions': ('clobber', 05:58:25 INFO - 'read-buildbot-config', 05:58:25 INFO - 'download-and-extract', 05:58:25 INFO - 'populate-webroot', 05:58:25 INFO - 'create-virtualenv', 05:58:25 INFO - 'install', 05:58:25 INFO - 'run-tests'), 05:58:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:25 INFO - 'download_minidump_stackwalk': True, 05:58:25 INFO - 'download_symbols': 'ondemand', 05:58:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:25 INFO - 'installer_path': 'installer.exe', 05:58:25 INFO - 'log_level': 'info', 05:58:25 INFO - 'log_name': 'talos', 05:58:25 INFO - 'log_to_console': True, 05:58:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:25 INFO - 'opt_config_files': (), 05:58:25 INFO - 'pip_index': False, 05:58:25 INFO - 'sps_profile': False, 05:58:25 INFO - 'sps_profile_interval': 0, 05:58:25 INFO - 'suite': 'dromaeojs-e10s', 05:58:25 INFO - 'system_bits': '32', 05:58:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:25 INFO - 'title': 'talos-linux64-ix-027', 05:58:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:25 INFO - 'use_talos_json': True, 05:58:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:25 INFO - 'work_dir': 'build'} 05:58:25 INFO - ##### 05:58:25 INFO - ##### Running clobber step. 05:58:25 INFO - ##### 05:58:25 INFO - Running pre-action listener: _resource_record_pre_action 05:58:25 INFO - Running main action method: clobber 05:58:25 INFO - rmtree: /builds/slave/test/build 05:58:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:26 INFO - Running post-action listener: _resource_record_post_action 05:58:26 INFO - ##### 05:58:26 INFO - ##### Finished clobber step (success) 05:58:26 INFO - ##### 05:58:26 INFO - ##### 05:58:26 INFO - ##### Running read-buildbot-config step. 05:58:26 INFO - ##### 05:58:26 INFO - Running pre-action listener: _resource_record_pre_action 05:58:26 INFO - Running main action method: read_buildbot_config 05:58:26 INFO - Using buildbot properties: 05:58:26 INFO - { 05:58:26 INFO - "project": "", 05:58:26 INFO - "product": "firefox", 05:58:26 INFO - "script_repo_revision": "production", 05:58:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:58:26 INFO - "repository": "", 05:58:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:58:26 INFO - "buildid": "20160602023007", 05:58:26 INFO - "pgo_build": "True", 05:58:26 INFO - "basedir": "/builds/slave/test", 05:58:26 INFO - "buildnumber": 801, 05:58:26 INFO - "slavename": "talos-linux64-ix-027", 05:58:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:58:26 INFO - "platform": "ubuntu64_hw", 05:58:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:58:26 INFO - "branch": "fx-team", 05:58:26 INFO - "repo_path": "integration/fx-team", 05:58:26 INFO - "revision": "034b45ace455de8b62f389fc0b940583d9c62ea6", 05:58:26 INFO - "stage_platform": "linux64-pgo", 05:58:26 INFO - "builduid": "c63a654640cd4a968f69288208d50d0d", 05:58:26 INFO - "slavebuilddir": "test" 05:58:26 INFO - } 05:58:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:58:26 INFO - Running post-action listener: _resource_record_post_action 05:58:26 INFO - ##### 05:58:26 INFO - ##### Finished read-buildbot-config step (success) 05:58:26 INFO - ##### 05:58:26 INFO - ##### 05:58:26 INFO - ##### Running download-and-extract step. 05:58:26 INFO - ##### 05:58:26 INFO - Running pre-action listener: _resource_record_pre_action 05:58:26 INFO - Running main action method: download_and_extract 05:58:26 INFO - mkdir: /builds/slave/test/build/tests 05:58: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')]} 05:58:26 INFO - https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:58:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:58:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:58:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:58:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:58:27 INFO - Downloaded 1361 bytes. 05:58:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:58:27 INFO - Using the following test package requirements: 05:58:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:58:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:27 INFO - u'jsshell-linux-x86_64.zip'], 05:58:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:58:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:58:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:27 INFO - https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:28 INFO - Downloaded 24422473 bytes. 05:58:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:58:29 INFO - Return code: 0 05:58:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:29 INFO - https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:30 INFO - Downloaded 24422473 bytes. 05:58:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:58:32 INFO - Return code: 0 05:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:32 INFO - https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:58:33 INFO - Downloaded 10834055 bytes. 05:58:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:58:33 INFO - Return code: 0 05:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:33 INFO - https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:58:35 INFO - Downloaded 59003548 bytes. 05:58:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:35 INFO - mkdir: /builds/slave/test/properties 05:58:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:35 INFO - Contents: 05:58:35 INFO - build_url:https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:36 INFO - Running post-action listener: _resource_record_post_action 05:58:36 INFO - Running post-action listener: set_extra_try_arguments 05:58:36 INFO - ##### 05:58:36 INFO - ##### Finished download-and-extract step (success) 05:58:36 INFO - ##### 05:58:36 INFO - ##### 05:58:36 INFO - ##### Running populate-webroot step. 05:58:36 INFO - ##### 05:58:36 INFO - Running pre-action listener: _resource_record_pre_action 05:58:36 INFO - Running main action method: populate_webroot 05:58:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:36 INFO - '--tppagecycles', 05:58:36 INFO - '7'], 05:58:36 INFO - 'tests': ['tsvgm']}}, 05:58:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:36 INFO - 'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:36 INFO - 'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['damp', 'tps']}, 05:58:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:36 INFO - 'tests': ['damp', 'tps']}, 05:58:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['dromaeo_dom']}, 05:58:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['a11yr', 05:58:36 INFO - 'ts_paint', 05:58:36 INFO - 'tpaint', 05:58:36 INFO - 'sessionrestore', 05:58:36 INFO - 'sessionrestore_no_auto_restore', 05:58:36 INFO - 'tabpaint']}, 05:58:36 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:36 INFO - 'ts_paint', 05:58:36 INFO - 'tpaint', 05:58:36 INFO - 'sessionrestore', 05:58:36 INFO - 'sessionrestore_no_auto_restore', 05:58:36 INFO - 'tabpaint']}, 05:58:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:36 INFO - 'ts_paint', 05:58:36 INFO - 'tpaint', 05:58:36 INFO - 'sessionrestore', 05:58:36 INFO - 'sessionrestore_no_auto_restore', 05:58:36 INFO - 'tabpaint']}, 05:58:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:36 INFO - 'ts_paint', 05:58:36 INFO - 'tpaint', 05:58:36 INFO - 'sessionrestore', 05:58:36 INFO - 'sessionrestore_no_auto_restore', 05:58:36 INFO - 'tabpaint']}, 05:58:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['a11yr', 05:58:36 INFO - 'ts_paint', 05:58:36 INFO - 'tpaint', 05:58:36 INFO - 'sessionrestore', 05:58:36 INFO - 'sessionrestore_no_auto_restore', 05:58:36 INFO - 'tabpaint']}, 05:58:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['a11yr', 05:58:36 INFO - 'ts_paint', 05:58:36 INFO - 'tpaint', 05:58:36 INFO - 'sessionrestore', 05:58:36 INFO - 'sessionrestore_no_auto_restore', 05:58:36 INFO - 'tabpaint']}, 05:58:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['tsvgx', 05:58:36 INFO - 'tsvgr_opacity', 05:58:36 INFO - 'tart', 05:58:36 INFO - 'tscrollx', 05:58:36 INFO - 'cart']}, 05:58:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:36 INFO - 'tsvgr_opacity', 05:58:36 INFO - 'tart', 05:58:36 INFO - 'tscrollx', 05:58:36 INFO - 'cart']}, 05:58:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:36 INFO - 'talos_options': ['--disable-e10s'], 05:58:36 INFO - 'tests': ['tp5o']}, 05:58:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:36 INFO - 'tests': ['tp5o']}, 05:58:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:36 INFO - 'talos_options': ['--disable-e10s', 05:58:36 INFO - '--xperf_path', 05:58:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:36 INFO - 'tests': ['tp5n']}, 05:58:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:36 INFO - 'talos_options': ['--xperf_path', 05:58:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:36 INFO - 'tests': ['tp5n']}}, 05:58:36 INFO - 'talos.zip': {'path': '', 05:58:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:36 INFO - Running post-action listener: _resource_record_post_action 05:58:36 INFO - ##### 05:58:36 INFO - ##### Finished populate-webroot step (success) 05:58:36 INFO - ##### 05:58:36 INFO - ##### 05:58:36 INFO - ##### Running create-virtualenv step. 05:58:36 INFO - ##### 05:58:36 INFO - Running pre-action listener: _resource_record_pre_action 05:58:36 INFO - Running main action method: create_virtualenv 05:58:36 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:58:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:36 INFO - Using real prefix '/usr' 05:58:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:39 INFO - Installing pip.................done. 05:58:39 INFO - Return code: 0 05:58:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f391401af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, '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': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:39 INFO - Using env: {'DISPLAY': ':0', 05:58:39 INFO - 'HOME': '/home/cltbld', 05:58:39 INFO - 'LANG': 'en_US.UTF-8', 05:58:39 INFO - 'LANGUAGE': 'en_US:en', 05:58:39 INFO - 'LOGNAME': 'cltbld', 05:58:39 INFO - 'MAIL': '/var/mail/cltbld', 05:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:39 INFO - 'MOZ_NO_REMOTE': '1', 05:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:39 INFO - 'NO_EM_RESTART': '1', 05:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:39 INFO - 'PWD': '/builds/slave/test', 05:58:39 INFO - 'SHELL': '/bin/bash', 05:58:39 INFO - 'SHLVL': '1', 05:58:39 INFO - 'TERM': 'linux', 05:58:39 INFO - 'TMOUT': '86400', 05:58:39 INFO - 'USER': 'cltbld', 05:58:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:39 INFO - '_': '/tools/buildbot/bin/python'} 05:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:58:39 INFO - Cleaning up... 05:58:39 INFO - Return code: 0 05:58:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f391401af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, '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': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:58:39 INFO - Using env: {'DISPLAY': ':0', 05:58:39 INFO - 'HOME': '/home/cltbld', 05:58:39 INFO - 'LANG': 'en_US.UTF-8', 05:58:39 INFO - 'LANGUAGE': 'en_US:en', 05:58:39 INFO - 'LOGNAME': 'cltbld', 05:58:39 INFO - 'MAIL': '/var/mail/cltbld', 05:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:39 INFO - 'MOZ_NO_REMOTE': '1', 05:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:39 INFO - 'NO_EM_RESTART': '1', 05:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:39 INFO - 'PWD': '/builds/slave/test', 05:58:39 INFO - 'SHELL': '/bin/bash', 05:58:39 INFO - 'SHLVL': '1', 05:58:39 INFO - 'TERM': 'linux', 05:58:39 INFO - 'TMOUT': '86400', 05:58:39 INFO - 'USER': 'cltbld', 05:58:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:39 INFO - '_': '/tools/buildbot/bin/python'} 05:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:39 INFO - Downloading/unpacking psutil>=3.1.1 05:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:41 INFO - Installing collected packages: psutil 05:58:41 INFO - Running setup.py install for psutil 05:58:41 INFO - building 'psutil._psutil_linux' extension 05:58:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:58:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:58:41 INFO - building 'psutil._psutil_posix' extension 05:58:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:58:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:58:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:41 INFO - Successfully installed psutil 05:58:41 INFO - Cleaning up... 05:58:41 INFO - Return code: 0 05:58:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f391401af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, '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': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:58:41 INFO - Using env: {'DISPLAY': ':0', 05:58:41 INFO - 'HOME': '/home/cltbld', 05:58:41 INFO - 'LANG': 'en_US.UTF-8', 05:58:41 INFO - 'LANGUAGE': 'en_US:en', 05:58:41 INFO - 'LOGNAME': 'cltbld', 05:58:41 INFO - 'MAIL': '/var/mail/cltbld', 05:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:41 INFO - 'MOZ_NO_REMOTE': '1', 05:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:41 INFO - 'NO_EM_RESTART': '1', 05:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:41 INFO - 'PWD': '/builds/slave/test', 05:58:41 INFO - 'SHELL': '/bin/bash', 05:58:41 INFO - 'SHLVL': '1', 05:58:41 INFO - 'TERM': 'linux', 05:58:41 INFO - 'TMOUT': '86400', 05:58:41 INFO - 'USER': 'cltbld', 05:58:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:41 INFO - '_': '/tools/buildbot/bin/python'} 05:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:44 INFO - Installing collected packages: mozsystemmonitor 05:58:44 INFO - Running setup.py install for mozsystemmonitor 05:58:44 INFO - Successfully installed mozsystemmonitor 05:58:44 INFO - Cleaning up... 05:58:44 INFO - Return code: 0 05:58:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f391401af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, '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': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:58:44 INFO - Using env: {'DISPLAY': ':0', 05:58:44 INFO - 'HOME': '/home/cltbld', 05:58:44 INFO - 'LANG': 'en_US.UTF-8', 05:58:44 INFO - 'LANGUAGE': 'en_US:en', 05:58:44 INFO - 'LOGNAME': 'cltbld', 05:58:44 INFO - 'MAIL': '/var/mail/cltbld', 05:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:44 INFO - 'MOZ_NO_REMOTE': '1', 05:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:44 INFO - 'NO_EM_RESTART': '1', 05:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:44 INFO - 'PWD': '/builds/slave/test', 05:58:44 INFO - 'SHELL': '/bin/bash', 05:58:44 INFO - 'SHLVL': '1', 05:58:44 INFO - 'TERM': 'linux', 05:58:44 INFO - 'TMOUT': '86400', 05:58:44 INFO - 'USER': 'cltbld', 05:58:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:44 INFO - '_': '/tools/buildbot/bin/python'} 05:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:47 INFO - Downloading docopt-0.6.1.tar.gz 05:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:47 INFO - Running setup.py install for blobuploader 05:58:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:47 INFO - Running setup.py install for requests 05:58:47 INFO - Running setup.py install for docopt 05:58:47 INFO - Successfully installed blobuploader requests docopt 05:58:47 INFO - Cleaning up... 05:58:47 INFO - Return code: 0 05:58:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:47 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 0x7f391401af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, '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': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:47 INFO - Using env: {'DISPLAY': ':0', 05:58:47 INFO - 'HOME': '/home/cltbld', 05:58:47 INFO - 'LANG': 'en_US.UTF-8', 05:58:47 INFO - 'LANGUAGE': 'en_US:en', 05:58:47 INFO - 'LOGNAME': 'cltbld', 05:58:47 INFO - 'MAIL': '/var/mail/cltbld', 05:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:47 INFO - 'MOZ_NO_REMOTE': '1', 05:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:47 INFO - 'NO_EM_RESTART': '1', 05:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:47 INFO - 'PWD': '/builds/slave/test', 05:58:47 INFO - 'SHELL': '/bin/bash', 05:58:47 INFO - 'SHLVL': '1', 05:58:47 INFO - 'TERM': 'linux', 05:58:47 INFO - 'TMOUT': '86400', 05:58:47 INFO - 'USER': 'cltbld', 05:58:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:47 INFO - '_': '/tools/buildbot/bin/python'} 05:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:48 INFO - Running setup.py (path:/tmp/pip-7AXPkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:48 INFO - Running setup.py (path:/tmp/pip-_gWB0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:48 INFO - Running setup.py (path:/tmp/pip-tzE5Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:48 INFO - Running setup.py (path:/tmp/pip-qyCZBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:48 INFO - Running setup.py (path:/tmp/pip-mNOZ6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:48 INFO - Running setup.py (path:/tmp/pip-supLUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:48 INFO - Running setup.py (path:/tmp/pip-dauqAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:48 INFO - Running setup.py (path:/tmp/pip-c5UJ6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:48 INFO - Running setup.py (path:/tmp/pip-vrSYSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:48 INFO - Running setup.py (path:/tmp/pip-iIGxS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:48 INFO - Running setup.py (path:/tmp/pip-d2ZriQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:48 INFO - Running setup.py (path:/tmp/pip-eZOE8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:48 INFO - Running setup.py (path:/tmp/pip-wx5uNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:49 INFO - Running setup.py (path:/tmp/pip-ezFtP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:49 INFO - Running setup.py (path:/tmp/pip-pE4MmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:49 INFO - Running setup.py (path:/tmp/pip-6AsHRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:49 INFO - Running setup.py (path:/tmp/pip-x0FliP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:49 INFO - Running setup.py install for manifestparser 05:58:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:49 INFO - Running setup.py install for mozcrash 05:58:49 INFO - Running setup.py install for mozdebug 05:58:49 INFO - Running setup.py install for mozdevice 05:58:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:49 INFO - Running setup.py install for mozfile 05:58:49 INFO - Running setup.py install for mozhttpd 05:58:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:49 INFO - Running setup.py install for mozinfo 05:58:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Running setup.py install for mozInstall 05:58:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Running setup.py install for mozleak 05:58:50 INFO - Running setup.py install for mozlog 05:58:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Running setup.py install for moznetwork 05:58:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Running setup.py install for mozprocess 05:58:50 INFO - Running setup.py install for mozprofile 05:58:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Running setup.py install for mozrunner 05:58:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:50 INFO - Running setup.py install for mozscreenshot 05:58:50 INFO - Running setup.py install for moztest 05:58:50 INFO - Running setup.py install for mozversion 05:58:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:51 INFO - Cleaning up... 05:58:51 INFO - Return code: 0 05:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f391401af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, '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': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:51 INFO - Using env: {'DISPLAY': ':0', 05:58:51 INFO - 'HOME': '/home/cltbld', 05:58:51 INFO - 'LANG': 'en_US.UTF-8', 05:58:51 INFO - 'LANGUAGE': 'en_US:en', 05:58:51 INFO - 'LOGNAME': 'cltbld', 05:58:51 INFO - 'MAIL': '/var/mail/cltbld', 05:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:51 INFO - 'MOZ_NO_REMOTE': '1', 05:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:51 INFO - 'NO_EM_RESTART': '1', 05:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:51 INFO - 'PWD': '/builds/slave/test', 05:58:51 INFO - 'SHELL': '/bin/bash', 05:58:51 INFO - 'SHLVL': '1', 05:58:51 INFO - 'TERM': 'linux', 05:58:51 INFO - 'TMOUT': '86400', 05:58:51 INFO - 'USER': 'cltbld', 05:58:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:51 INFO - '_': '/tools/buildbot/bin/python'} 05:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:51 INFO - Running setup.py (path:/tmp/pip-tKeQcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:51 INFO - Running setup.py (path:/tmp/pip-2TyngX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:51 INFO - Running setup.py (path:/tmp/pip-VAr3S6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:51 INFO - Running setup.py (path:/tmp/pip-2ovOZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:51 INFO - Running setup.py (path:/tmp/pip-LbUF3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:51 INFO - Running setup.py (path:/tmp/pip-mgJyuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:51 INFO - Running setup.py (path:/tmp/pip-UvBtMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:51 INFO - Running setup.py (path:/tmp/pip-ohGNgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:51 INFO - Running setup.py (path:/tmp/pip-acZxsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:51 INFO - Running setup.py (path:/tmp/pip-CVz_RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:52 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)) 05:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:52 INFO - Running setup.py (path:/tmp/pip-Pxmys2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:52 INFO - Running setup.py (path:/tmp/pip-XMc4ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:52 INFO - Running setup.py (path:/tmp/pip-4YMgDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:52 INFO - Running setup.py (path:/tmp/pip-xpvQ79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:52 INFO - Running setup.py (path:/tmp/pip-XMci75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:52 INFO - Running setup.py (path:/tmp/pip-YxmS8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:52 INFO - Running setup.py (path:/tmp/pip-dnWQWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:54 INFO - Downloading blessings-1.6.tar.gz 05:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:54 INFO - Installing collected packages: blessings 05:58:54 INFO - Running setup.py install for blessings 05:58:54 INFO - Successfully installed blessings 05:58:54 INFO - Cleaning up... 05:58:54 INFO - Return code: 0 05:58:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:54 INFO - Reading from file tmpfile_stdout 05:58:54 INFO - Current package versions: 05:58:54 INFO - argparse == 1.2.1 05:58:54 INFO - blessings == 1.6 05:58:54 INFO - blobuploader == 1.2.4 05:58:54 INFO - docopt == 0.6.1 05:58:54 INFO - manifestparser == 1.1 05:58:54 INFO - mozInstall == 1.12 05:58:54 INFO - mozcrash == 0.17 05:58:54 INFO - mozdebug == 0.1 05:58:54 INFO - mozdevice == 0.48 05:58:54 INFO - mozfile == 1.2 05:58:54 INFO - mozhttpd == 0.7 05:58:54 INFO - mozinfo == 0.9 05:58:54 INFO - mozleak == 0.1 05:58:54 INFO - mozlog == 3.2 05:58:54 INFO - moznetwork == 0.27 05:58:54 INFO - mozprocess == 0.22 05:58:54 INFO - mozprofile == 0.28 05:58:54 INFO - mozrunner == 6.11 05:58:54 INFO - mozscreenshot == 0.1 05:58:54 INFO - mozsystemmonitor == 0.3 05:58:54 INFO - moztest == 0.7 05:58:54 INFO - mozversion == 1.4 05:58:54 INFO - psutil == 3.1.1 05:58:54 INFO - requests == 1.2.3 05:58:54 INFO - wsgiref == 0.1.2 05:58:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:54 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 0x7f391401af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, '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': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:54 INFO - Using env: {'DISPLAY': ':0', 05:58:54 INFO - 'HOME': '/home/cltbld', 05:58:54 INFO - 'LANG': 'en_US.UTF-8', 05:58:54 INFO - 'LANGUAGE': 'en_US:en', 05:58:54 INFO - 'LOGNAME': 'cltbld', 05:58:54 INFO - 'MAIL': '/var/mail/cltbld', 05:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:54 INFO - 'MOZ_NO_REMOTE': '1', 05:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:54 INFO - 'NO_EM_RESTART': '1', 05:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:54 INFO - 'PWD': '/builds/slave/test', 05:58:54 INFO - 'SHELL': '/bin/bash', 05:58:54 INFO - 'SHLVL': '1', 05:58:54 INFO - 'TERM': 'linux', 05:58:54 INFO - 'TMOUT': '86400', 05:58:54 INFO - 'USER': 'cltbld', 05:58:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:54 INFO - '_': '/tools/buildbot/bin/python'} 05:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:58:55 INFO - Cleaning up... 05:58:55 INFO - Return code: 0 05:58:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f391401af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, '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': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:58:55 INFO - Using env: {'DISPLAY': ':0', 05:58:55 INFO - 'HOME': '/home/cltbld', 05:58:55 INFO - 'LANG': 'en_US.UTF-8', 05:58:55 INFO - 'LANGUAGE': 'en_US:en', 05:58:55 INFO - 'LOGNAME': 'cltbld', 05:58:55 INFO - 'MAIL': '/var/mail/cltbld', 05:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:55 INFO - 'MOZ_NO_REMOTE': '1', 05:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:55 INFO - 'NO_EM_RESTART': '1', 05:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:55 INFO - 'PWD': '/builds/slave/test', 05:58:55 INFO - 'SHELL': '/bin/bash', 05:58:55 INFO - 'SHLVL': '1', 05:58:55 INFO - 'TERM': 'linux', 05:58:55 INFO - 'TMOUT': '86400', 05:58:55 INFO - 'USER': 'cltbld', 05:58:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:55 INFO - '_': '/tools/buildbot/bin/python'} 05:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:55 INFO - Downloading/unpacking jsonschema 05:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:57 INFO - Downloading/unpacking functools32 (from jsonschema) 05:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:57 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:57 INFO - warning: no files found matching '*.txt' 05:58:57 INFO - no previously-included directories found matching 'build' 05:58:57 INFO - no previously-included directories found matching 'dist' 05:58:57 INFO - no previously-included directories found matching '.git*' 05:58:57 INFO - Installing collected packages: jsonschema, functools32 05:58:57 INFO - Running setup.py install for functools32 05:58:57 INFO - warning: no files found matching '*.txt' 05:58:57 INFO - no previously-included directories found matching 'build' 05:58:57 INFO - no previously-included directories found matching 'dist' 05:58:57 INFO - no previously-included directories found matching '.git*' 05:58:57 INFO - Successfully installed jsonschema functools32 05:58:57 INFO - Cleaning up... 05:58:57 INFO - Return code: 0 05:58:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f391401af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, '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': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:58:57 INFO - Using env: {'DISPLAY': ':0', 05:58:57 INFO - 'HOME': '/home/cltbld', 05:58:57 INFO - 'LANG': 'en_US.UTF-8', 05:58:57 INFO - 'LANGUAGE': 'en_US:en', 05:58:57 INFO - 'LOGNAME': 'cltbld', 05:58:57 INFO - 'MAIL': '/var/mail/cltbld', 05:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:57 INFO - 'MOZ_NO_REMOTE': '1', 05:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:57 INFO - 'NO_EM_RESTART': '1', 05:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:57 INFO - 'PWD': '/builds/slave/test', 05:58:57 INFO - 'SHELL': '/bin/bash', 05:58:57 INFO - 'SHLVL': '1', 05:58:57 INFO - 'TERM': 'linux', 05:58:57 INFO - 'TMOUT': '86400', 05:58:57 INFO - 'USER': 'cltbld', 05:58:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:57 INFO - '_': '/tools/buildbot/bin/python'} 05:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:57 INFO - Downloading/unpacking flake8 05:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:58:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:58:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:00 INFO - no previously-included directories found matching 'docs/_build' 05:59:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:59:00 INFO - Running setup.py install for pep8 05:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:00 INFO - no previously-included directories found matching 'docs/_build' 05:59:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:59:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:59:00 INFO - Cleaning up... 05:59:00 INFO - Return code: 0 05:59:00 INFO - Running post-action listener: _resource_record_post_action 05:59:00 INFO - Running post-action listener: _start_resource_monitoring 05:59:00 INFO - Starting resource monitoring. 05:59:00 INFO - ##### 05:59:00 INFO - ##### Finished create-virtualenv step (success) 05:59:00 INFO - ##### 05:59:00 INFO - ##### 05:59:00 INFO - ##### Running install step. 05:59:00 INFO - ##### 05:59:00 INFO - Running pre-action listener: _resource_record_pre_action 05:59:00 INFO - Running main action method: install 05:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:00 INFO - Reading from file tmpfile_stdout 05:59:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:01 INFO - Reading from file tmpfile_stdout 05:59:01 INFO - Output received: 05:59:01 INFO - Usage: mozinstall [options] installer 05:59:01 INFO - Options: 05:59:01 INFO - -h, --help show this help message and exit 05:59:01 INFO - -d DEST, --destination=DEST 05:59:01 INFO - Directory to install application into. [default: 05:59:01 INFO - "/builds/slave/test"] 05:59:01 INFO - --app=APP Application being installed. [default: firefox] 05:59:01 INFO - mkdir: /builds/slave/test/build/application 05:59:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:59:17 INFO - Reading from file tmpfile_stdout 05:59:17 INFO - Output received: 05:59:17 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:17 INFO - Running post-action listener: _resource_record_post_action 05:59:17 INFO - ##### 05:59:17 INFO - ##### Finished install step (success) 05:59:17 INFO - ##### 05:59:17 INFO - ##### 05:59:17 INFO - ##### Running run-tests step. 05:59:17 INFO - ##### 05:59:17 INFO - Running pre-action listener: _resource_record_pre_action 05:59:17 INFO - Running main action method: run_tests 05:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:17 INFO - Python 2.7.3 05:59:17 INFO - Return code: 0 05:59:17 INFO - grabbing minidump binary from tooltool 05:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b20>, '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 0x1059a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:59:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:59:17 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 05:59:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:17 INFO - Return code: 0 05:59:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:59:18 INFO - Return code: 0 05:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:59:18 INFO - Using env: {'DISPLAY': ':0', 05:59:18 INFO - 'HOME': '/home/cltbld', 05:59:18 INFO - 'LANG': 'en_US.UTF-8', 05:59:18 INFO - 'LANGUAGE': 'en_US:en', 05:59:18 INFO - 'LOGNAME': 'cltbld', 05:59:18 INFO - 'MAIL': '/var/mail/cltbld', 05:59:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:18 INFO - 'MOZ_NO_REMOTE': '1', 05:59:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:18 INFO - 'NO_EM_RESTART': '1', 05:59:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:18 INFO - 'PWD': '/builds/slave/test', 05:59:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:18 INFO - 'SHELL': '/bin/bash', 05:59:18 INFO - 'SHLVL': '1', 05:59:18 INFO - 'TERM': 'linux', 05:59:18 INFO - 'TMOUT': '86400', 05:59:18 INFO - 'USER': 'cltbld', 05:59:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769', 05:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:18 INFO - '_': '/tools/buildbot/bin/python'} 05:59:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:59:19 INFO - mozversion application_buildid: 20160602023007 05:59:19 INFO - mozversion application_changeset: 034b45ace455de8b62f389fc0b940583d9c62ea6 05:59:19 INFO - mozversion application_display_name: Nightly 05:59:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:19 INFO - mozversion application_name: Firefox 05:59:19 INFO - mozversion application_remotingname: firefox 05:59:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:59:19 INFO - mozversion application_vendor: Mozilla 05:59:19 INFO - mozversion application_version: 49.0a1 05:59:19 INFO - mozversion platform_buildid: 20160602023007 05:59:19 INFO - mozversion platform_changeset: 034b45ace455de8b62f389fc0b940583d9c62ea6 05:59:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:59:19 INFO - mozversion platform_version: 49.0a1 05:59:19 INFO - using testdate: 1464872359 05:59:19 INFO - actual date: 1464872359 05:59:19 INFO - starting webserver on 'localhost:39140' 05:59:19 INFO - SUITE-START | Running 2 tests 05:59:19 INFO - TEST-START | dromaeo_css 05:59:19 INFO - operating with platform_type : linux_ 05:59:19 INFO - Initialising browser for dromaeo_css test... 05:59:19 INFO - TEST-INFO | started process 30219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ0sQrz/profile http://localhost:39140/getInfo.html) 05:59:23 INFO - PROCESS | 30219 | __metrics Screen width/height:1600/1200 05:59:23 INFO - PROCESS | 30219 | colorDepth:24 05:59:23 INFO - PROCESS | 30219 | Browser inner width/height: 1024/697 05:59:23 INFO - PROCESS | 30219 | __metrics 05:59:23 ERROR - PROCESS | 30219 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:59:24 INFO - TEST-INFO | 30219: exit 0 05:59:24 INFO - Browser initialized. 05:59:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:24 INFO - TEST-INFO | started process 30339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ0sQrz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:36 INFO - PROCESS | 30339 | RSS: Main: 167596032 05:59:36 INFO - PROCESS | 30339 | 06:00:26 INFO - PROCESS | 30339 | 1464872426187 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] 06:02:33 INFO - PROCESS | 30339 | Cycle 1(1): loaded http://localhost:39140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39140/tests/dromaeo/cssquery-ext.html) 06:02:34 INFO - PROCESS | 30339 | RSS: Main: 170475520 06:02:34 INFO - PROCESS | 30339 | 06:05:37 INFO - PROCESS | 30339 | Cycle 1(1): loaded http://localhost:39140/tests/dromaeo/cssquery-ext.html (next: http://localhost:39140/tests/dromaeo/cssquery-jquery.html) 06:05:37 INFO - PROCESS | 30339 | RSS: Main: 169943040 06:05:37 INFO - PROCESS | 30339 | 06:08:39 INFO - PROCESS | 30339 | Cycle 1(1): loaded http://localhost:39140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39140/tests/dromaeo/cssquery-mootools.html) 06:08:40 INFO - PROCESS | 30339 | RSS: Main: 171036672 06:08:40 INFO - PROCESS | 30339 | 06:11:42 INFO - PROCESS | 30339 | Cycle 1(1): loaded http://localhost:39140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39140/tests/dromaeo/cssquery-prototype.html) 06:11:42 INFO - PROCESS | 30339 | RSS: Main: 168816640 06:11:42 INFO - PROCESS | 30339 | 06:14:45 INFO - PROCESS | 30339 | Cycle 1(1): loaded http://localhost:39140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39140/tests/dromaeo/cssquery-yui.html) 06:14:45 INFO - PROCESS | 30339 | RSS: Main: 170475520 06:14:45 INFO - PROCESS | 30339 | 06:17:48 INFO - PROCESS | 30339 | Cycle 1(1): loaded http://localhost:39140/tests/dromaeo/cssquery-yui.html (next: http://localhost:39140/tests/dromaeo/cssquery-dojo.html) 06:17:48 INFO - PROCESS | 30339 | RSS: Main: 171569152 06:17:48 INFO - PROCESS | 30339 | 06:17:48 INFO - PROCESS | 30339 | __start_tp_report 06:17:48 INFO - PROCESS | 30339 | _x_x_mozilla_page_load 06:17:48 INFO - PROCESS | 30339 | _x_x_mozilla_page_load_details 06:17:48 INFO - PROCESS | 30339 | |i|pagename|runs| 06:17:48 INFO - PROCESS | 30339 | |0;dojo.html;3099.2251937015744;3157.6210854697433;3163.557102005718;3177.809331440112;3198.6001749781276;5497.532709719673;5498.312710911141;5508.146237333215;5567.972160139204;5574.554035677146;5402.405735369106;5499.587530935176;5518.33779946406;5540.722963851811;5584.581156413265;4954.554090131896;4967.403911530603;5104.055749686301;5166.61250406221;5212.582993360522;849.7039844360665;5021.221710634857;5102.515261050195;5127.820526281581;5162.483751624845;4974.925376119361;5015.32293140425;5017.899642007158;5025.321581586476;5060.822871199491;4986.825461108844;5016.448190699057;5029.899402011939;5036.043151801183;5043.974780126113;4988.625853061035;5014.974925125351;5036.546710796009;5040.747962601855;5087.414947281036;5465.6447330923365;5483.725813709299;5502.394736578973;5528.6406383585345;5570.805021824257;5765.682887441189;5805.3323867755325;5812.680302583356;5937.584369094165;5959.463648271676;5850;5939.643621382731;5941.762329506814;5955.880882382371;5968.552358573081;5534.667919924817;5535.197396377503;5535.778568857281;5545.611807173459;5548.056830338852;5881.9705901470215;5967.79112731061;5984.73068711909;6021.909671354933;6029.8191054268445;5802.622829516068;5822.272215973004;5828.5337173026055;5840.853978650568;5850.005499065169;5873.676947767914;5925.703714814242;5927.792527261525;5937.079752638348;5943.524518038546;5726.341470730836;5855.268091488564;5869.882602347929;5900.173975643327;5901.616394934315;5766.538676905838;5798.623089499169;5825.1844741736195;5894.557908156906;5931.258592675916;4444.7110937789585;4454.22051141049;4460.30865215892;4477.888052798641;4526.140033393644;3883.165119499321;3896.064944413377;3925;3970.285348637273;4003.679705623543;5581.832545023656;5587.580931430159;5599.804006859822;5601.63589366698;5648.49163575272;5834;5881.470667639933;5886.823395298148;5890.057590785539;5898.056310990221;5541.224228607998;5603.551715862803;5655.5475561954945;5702.800401985911;5710.029295019856;5130.769115389817;5143.382794064736;5164.948350516522;5165.302684137669;5177.275181474596;6207.96896015517;6234.594751341148;6246.4378205960775;6255.937440625536;6264.436200741955;5720.256366672389;5944.5838791284195;5954.851128721816;6012.819615411545;6035.78874739382;6180.646700871011;6219.440250377488;6237.12680224778;6242.875142497215;6250.062490626442;5671.262735844314;5898.056310990221;5927.492989791623;5937.614055086406;5974.701264936823;5797.072468405035;5866;5903.527717782653;5923.259592550931;5927.940720592739;5752.568557358131;5762.8847423050465;5777.74000169985;5803.970980145073;5825.70871456434;5645.096784514458;5769.884602308014;5776.768929242783;5778;5785.074388098053;5602.327720673546;5666.15007748841;5708.54331653475;5737.971310143423;5784.623999440023;5878.2358293421585;5908.911366329595;5912.113183022409;5929.140274660064;5930.96208163561;5601.495865372136;5604.663720176803;5767.9134812977;5768.596198266249;5781.739821708117 06:17:48 INFO - PROCESS | 30339 | |1;ext.html;585.7569108819837;618.5639124417286;626.2578844069777;645.7352485480952;646.437599288619;33590.328193436144;36556.451653225224;43625.78187109064;45035.324470132895;45129.54870451303;43532.12935741291;43756.56243437565;43923.56076439234;44029.7798511007;44141.7792911035;8501.659933602665;8595.914040859605;8599.914000859973;8681.95659021704;8696.739097827076;8628.482291062524;8765.211130998208;8804.955975220115;8823.426477278988;8862.911370886273;8873.600687969025;8874;8884.911150888505;8905.910940890606;8941.50821704806;8804.691835785748;8832.911670883273;8872.778180545505;8902.777430564223;8909.242714369286;8677.132286771272;8768.473891566526;8774.21032107107;8779.824403511959;8809;41630.375544366856;42022.15955680869;42080.00239977197;42160.57839421597;42226.788866055475;3530.6116327203986;3617.801020943847;3622.6920711739535;3626.4197728363333;3676.5771936227407;31554.526682099557;31601.20996975094;32047.679523204704;32105;32258.83870580632;4242.342436922282;4340.782960851945;4497.887552811206;4561.612262957653;4568.817247310104;297768;298145;299125;299696.99999999785;299897;59368.40631593715;60031;60084;60421.69789151026;60504;61976;62335.37664623296;62625.686871566264;62679;62964.370356296764;16499.422520211734;16678.58303542421;16680.416185433452;16684.416045438353;16699.582510437336;12279.508819647293;12297.877021229851;12298.938505307595;12326.691832704255;12377.381130943417;17496.825031749773;18350.35773747939;18525.44423667292;18526.16632251552;18578.349757758413;6016;6139.558107602047;6179.721912513947;6194.101855230966;6210.627362358273;940.4028441939417;1032.9690109296732;1060.6688605799673;1189.7085214122596;1202.3387137074574;32294.677053229636;33659.495107573406;33867.32265354679;34037.31925361479;34349.48475772866;1102.2449622008949;1134.756027454085;1137.294877176156;1187.6912002879315;1199.3703305764543;17327.25710059771;17944;17985.370512032016;18011.909940450478;18051.368202112862;535804;536688;539120.348380835;539154;541455;59375.406245937855;60802;60991;61057.38942610517;61087.38912610817;1356.8575299593401;1383.889288856889;1401.7266633006466;1415.9238978376509;1416.5891891351598;32399.67600324061;34132.82933585316;34411.82794086014;34862.82568587141;35202;51902.74048629733;52288.47711522836;52320.21519677284;52386.214206786164;52790.20814687706;407937;413165.6050318495;414483;417172;417460;45770.31344529901;45802;46954.76522617365;47300;47338.28992565183;49036.2644560339;49492.257616135066;49669.503304966485;55624;56191.43808561862;43106.56893431026;43748.56251437445;44102.33846492369;44123.77938110289;45439.77280113578;43381;43384.78307608568;44055.11889762251;45101.77449112865;45224;37753.62246377501;42961;43198;43504.129917402104;43827.78086109549;35535.822320888234;38030.619693802706;38088;38478.80760596179;38642.227155456174;29518.409631807674;29521.85239073791;29813.254668633457;29842.850785745934;29977.70022299749 06:17:48 INFO - PROCESS | 30339 | |2;jquery.html;372.8769506063001;377.939529675252;381.34789509938;386.7408836079826;394.77497826239056;18005.099745012747;19282.51793705158;19378.321758738446;19697.704534431996;20019.1992320307;17679.55801104973;17928.19323130459;17973.91013044933;18069.63860722788;19080.809191908076;5379.892402151974;5531.861703457415;5646.858828529299;5718.285214348207;5719.571032172583;5526.143447765603;5603.80386686466;5606.046972014747;5644.717764111799;5658.519025882805;5441.891162176774;5577.274954255941;5577.749001294931;5596.888062238773;5627.634203776742;5700.116481945305;5791.652500849962;5834.416558344153;5838.416158384149;5846.50304724099;5597.580181486404;5796.420357964212;5797.246357973437;5817.272840894888;5827.650340979555;13489.730205395936;13719.382627781773;17217.483475495756;22323.888380557994;22396.328110156723;2342.7422983471974;2400.6399040143942;2428.7449817769057;2481.392058945552;2806.5405988885664;9543.42739435636;9600.279979001532;9659.855102173473;9847.16299114576;9976.102150806462;1954.5895361974003;2001.989990050055;2004.7794742578305;2014.355406269994;2046.9692954605694;76484;78054;78376.60811695961;78462.21537784606;79415.20584794194;10293.176545876311;10443.94778026105;10715.678529644123;10721.088707459798;10766.407847568458;14964.102153870803;15000.774988375184;15098.320575573905;15110.093394396372;15149.545513634608;7962.442629015914;8022.358211343195;8025.719099831478;8239.176082391832;8283.710070147516;7843.568603726736;7853.057633083952;7855.685772569148;7921.207879212033;8069.193080691884;4692.859214223578;4697.8355757548325;4708.223143181405;4741.1465936131135;4758.9780489388795;2008.8493362997833;2011.7167015437292;2024.8076432738867;2032.8475364347732;2076.345951025422;973.8441849304078;989.9752506187259;1030.9484525773682;1060.7083052160563;1068.8183008888507;18301.7254741179;18878.1601386691;18983.9558824266;19158.71261931072;19330.516737081685;1024.1448390593937;1031.633770011635;1051.984220236697;1084.159776173456;1085.2403317677656;10361.274710770325;10713.83929241062;10826.133909287395;10828.296160749525;10860.402677852637;357594;357640;442060;444230;445778;75699;83508.16491835125;93503;93663;99301.50349248352;1025.477006726575;1042.2964498963322;1052.884182739898;1055.8680164979378;1059.2373491086405;17133.20270324311;17174.39889603858;17525.912370438575;17527.82472175262;17582.38461653836;37907;39107.2178556433;39315.410268846565;41942;43033;55655;57327.71336143293;60236.69881650564;60718.69640651769;60735.69632151811;8109.7161599343735;8353.832923341377;8376.874346884924;8422.705205317785;8754.693585724724;12599.307038112625;12612.55856045034;13121.540746073842;13352.799708004582;13458.663533411744;7041.859162816818;8651.351148664002;11238.83141752858;11557.30656160633;11694.88305116938;11383.715407114558;11463.770724585629;11585.710357241136;11805.350705711267;11817.409129543661;11575.594854180401;11615.477303521193;11824.586139485076;11829.290242585472;11854.348010859485;7530.6611202497115;7872.803179920548;8576.356773242156;8621.051684314594;8756.60595273227;11516.19386642927;11727.237729547893;11898.821517677068;11962.880371196525;12076.154669173073 06:17:48 INFO - PROCESS | 30339 | |3;mootools.html;1475.8819294456443;1522.4290890915906;1636.7299395599728;1772.592303770132;1772.725227589724;7786.766397008085;8385.413021088527;8499.915000850006;8889.555522223887;8906.1093890611;8695.826083478327;8737.213650771446;8751.606177722002;8813.338999575042;8817.823643527141;2314.1206341590214;2343.9765602343928;2347.6009078456705;2348.412896775806;2350.74141844397;2256.2216035467736;2262.298687406901;2304.8617082974993;2328.1269523928527;2332.2536788227776;2268.6823844661762;2307.4462129089065;2315.78000089992;2317.582835089683;2341.262502311775;2265.8413911026237;2268.7844654757773;2282.691836602054;2284.9314520564326;2293.7247530296386;2288.096202000217;2308.2613563659634;2314.2478694424212;2315.073970411832;2317.188983855654;8702.521361325125;8724.651013959434;8741.344399170088;8743.737687869374;8751.212390884788;4979.228219625964;5073.162928116856;5094.694318340911;5097.2608971699265;5098.133317336024;3187.8884239051754;3193.7445004399824;3316.4527852904243;3346.5147553604834;3354.1446931032674;1077.06833588945;1081.6971248050559;1087.4508373271526;1093.8906109389077;1108.0470795116194;12054.276743395425;12058.6382408527;12073.6377908662;12100.152989290753;12162.391880405945;4432.800523976364;4490.820367185342;4536.61438777701;4548.476925153584;4588.3805686231935;10204.23468239885;10257;10324.380537167644;10329.225308101923;10356.223283253636;5163.380394352702;5192.350956130484;5195.402528709171;5202.08963431398;5215.634905556574;4218.325067989168;4684.906301873943;4758.524147585283;4800.687955282895;4801.68789028712;3908.394198899175;4045.0494133878515;4087.8773636790943;4112.992316882383;4155.667546596265;1278.6803299175206;1284.190959695386;1295.3005377096263;1303.8305020347484;1306.5688322853437;765.8353454007415;848.1645579104577;909.7952960583948;910.0489987962595;928.331601247101;5382.973085134549;5532.917006244909;5567.610267281332;5633.971830140905;5805.535557155417;989.9653512127041;999.5402115027169;1031.9380837149795;1039.0907955538903;1054.7626783973544;3602.4776407420777;3632.582253040934;3724.0689827543115;3730.5709843367817;3767.434884767307;10629.25595208328;10814.243002989873;10892;10939.507722152523;10981.670549883516;10763.24657273999;10820.242583019113;10820.729481763019;10876;10883.401412922207;7780.416468764752;8194.959025204837;8276.462029968034;8347.582620868932;8359.373047021498;5625.774969001194;5659.122835960433;5753.741081651252;5764.711764411679;5912.379200183918;9577.712668619952;9866.408015519091;9906.554205060933;9908.752281193028;10076.345037572535;10029.598816047277;10125.038121378457;10130.392176469435;10142.54358553852;10172.28793984414;7040.401565866959;7442.1069471661585;7625.733099341496;7807.414443916842;7840.490368126054;8493.150684931457;8499.235068843835;8520.531370774666;8521.233089022018;8574.142585741376;7578.583177925267;7738.806529836799;7762.883556746766;7788.1433042366425;7868.881966770388;7382.151052629017;7417.072865891763;7496.662650180646;7595.962020189863;7619.161892191965;6824.624645644339;6863.828404289933;6896.310368963264;6904.861902761816;6914;4790.760461976957;4938.432080310667;4979.751012449436;5021.72380519075;5029.295898574275;4784.880377990578;4843.95156048435;4936.9259461107395;4970.055689418999;4989.301497790239 06:17:48 INFO - PROCESS | 30339 | |4;prototype.html;320.60245295833164;328.0764647517239;336.6734267760273;340.94544872820325;343.2294498850082;5629.915551266734;5633.324001119866;5662.263905692259;5717.885642287157;5719.342275638302;5516.91724624131;5539.473749993744;5574.275344205258;5603.859903502414;5650.124230744231;4135.2349815284115;4189.958100419002;4276.187524370375;4280.850170244042;4286.121345124242;4264.765437900915;4282.400463935051;4284.635805956497;4284.871453856389;4308.655307575402;4260.40234911908;4304.80628371724;4320.697551171419;4344.326629372453;4352.499462561798;4059.6955228357842;4301.526832048472;4307.203167414038;4313.741175529478;4333.328334108202;3716.349638813224;3738.2336620992633;3750.9062273443383;3751.81240937952;3759.642833930772;5439;5448.8477051564805;5449.373322067933;5465.289512363407;5478.643888147258;4820.421549414058;4865.41615006198;4914.926276105862;5004.2493625956395;5014.24786282057;5862.149988251722;5864.416607515946;5867.501262392701;5922.200502932135;5929.347771745104;4176.310908700061;4191.098913733532;4192.538820729717;4200.978995105035;4201.516825565038;5864.941350586482;6114.2968558615885;6135;6152.98475751496;6159.599626024294;4176.9582304177175;4180.310248808913;4183.707140500136;4191.371294305878;4192.098698779716;4259.467566554181;4262.2754131797665;4267.445232119804;4269.188854117708;4277.679174061957;4736.928946065812;4845.577211394303;4891.437484689235;4897.486985024713;4951.554360107536;5861.648301101947;5875.29496460419;5887.175795388649;5890.7938222162875;5894.970525147347;1463.9121652700871;1465.9706805863823;1467.7798330250548;1480.4300344367496;1483.199072500859;915.1123410292006;926.8841394825647;929.6049179098856;968.9612415503442;970.1608108985677;5650.886982260332;5665.575081868877;5676.403977582377;5679.886402271932;5686.289213848269;5961.850953726192;5968;6000.69996500182;6020.668863212565;6045.183900173508;5452.700101494456;5655.971720141373;5787.218725472091;5790.507806836382;5793.536517078624;3215.8070515769127;3237.8542965566608;3241.2059045533997;3257.951130733041;3262.4503360903855;6154.846128846814;6282.591631543935;6312.652804095819;6320.178376810985;6333.081703153017;6149.907751383733;6191.783287584913;6196.225471816023;6203.131561581382;6211.81364559064;6050.24371953497;6243.125962365272;6282.026285925689;6297.0089207626925;6307.738452309556;6047.699744554941;6070.696465176635;6083.756649733961;6126.417990290915;6129.264488261437;5991.310999234969;6040.154378386941;6048.879022419615;6064.151018857276;6070.878582428239;5909.704514774158;6197.287311959182;6271.306747178145;6281.71732272058;6296.590721603081;4223.676977662335;4232.597903199191;4267.231898258343;4273.124009578091;4276.3799249109325;5868.2077919480325;5904.822855314347;6068.48287928018;6115.694215289129;6118.60229085108;5800.970995144998;5801.82594522165;5833.387494313036;5839.678817665069;5850.970745146247;5789.739461724148;5844.370033484864;5851.824445266649;5855.092460668603;5857.47282744555;5550.334899530206;5688.971555142198;5694.629849059798;5709.25779648643;5726.198332233574;5822.970885145547;5859.970700146472;5909.8227053188475;5958.493528050164;5972.5520585955355;5381.27352807366;5787.263820853811;5790.826275211751;5796.101604251347;5848.298204215522 06:17:48 INFO - PROCESS | 30339 | |5;yui.html;759.1535437986646;773.5590713293421;794.9682012719492;804.2721337189842;839.0057781528889;13206.207627542353;15248.771268430968;15456.149911754848;15473.226338683076;15534.22328883557;13897.957653176027;13912.304384780746;13926.30368481577;13930.58208253754;13989.860101398983;674.1303718203511;799.1928152565906;814.8573999550084;815.8123631564744;816.8202995341045;794.086800179795;815.0830315894618;816.6733306677318;817.709713051867;819.2749416766175;857.5326447086353;871.363904349825;876.5967654878764;877.5392918717693;879.1647934462254;855.5080828523562;860.5912191708982;861.3066481482405;863.2748491267365;867.3278209387712;632.3929028132952;634.2515831319088;637.2575949019387;638.8722255548909;639.9424051835357;14025;14095.718085638333;14101.576952691436;14143.787843182361;14196.574102776933;13873.375698093509;14017.64955876101;14089.71820563583;14159.292035398188;14410.135391876522;10983.450827458675;11021.228514004022;11183.161262905314;11290.153238507062;11332.943335283353;3866.420036994445;3936.921261574781;3962.881113566598;4062.6140516651167;4068.4304197412384;57316.71341643307;57601.71199144019;57639.711801440724;58180.418195817925;58240;11015.311802619039;11270.436478176058;11293.661190164308;11428.828567571492;11722.413879306172;20372.592548148954;20406;20419.693704594443;20435.693464598044;20480;8381;8569.35729820266;8621.797586016224;8885.4668719877;8940.061293564082;4714.207405192577;4854.417469903634;4883.072216278967;4902.730349830722;5010.423801262901;3467.9653203468147;3550.0947258449446;3551.8579256829953;3554.644535546425;3564.1267889366754;598.1446531460053;604.6583680220662;618.2982315072425;619.4765423217374;625.0624063904144;665.1519312876025;766.6779952419997;767.1561282589107;809.2756982500629;836.193073683898;9032.909670903207;9047.366684332164;9108.954455227682;9170.587323570455;9179.954100229455;668.8963210702349;681.1757773094512;691.3052382355801;728.6393235348536;773.704045723411;4541.205289074399;4553.704009239389;4568.474625418053;4605.930911036337;4659.8136074557315;64547.35452645507;66450;66458.66770666116;67584.6620766893;67728;60898.39101609016;61465.38534614686;61549.69225153846;62368.37631623626;63014.36985630177;54505.45494545083;54949.725251373486;55831.16253256204;55964.44035559674;56502.43497564972;8775.254103401026;8820.603072861864;8860.3797734158;8881.73354799357;8990.775230619287;37177.07057323481;37196.62803371932;37585;37781;37876.43185352277;46066;50503.49496504988;50525.49474505355;50650.24024639707;51215.487845121075;11746.29522228669;11881.544420842185;11971;11984.64046078619;12064.215825971283;12755.93622031884;12994.80507792365;13146.60560183196;13175.341232938506;13201.735965280832;12070.818937715765;12162.817557736464;12340;12474.688132796753;12834.486620535074;11145.275557089088;11495.195336326711;11500.137489688139;11711.121665874924;12122.515099395925;11958.402079895797;12128.696782580506;12429.689257768629;12460.688482788002;12523.248605083723;9946.701598952042;10081.596736130472;10194.643187488402;10262.897371026194;10544.420056896945;10541.156707463231;10719.517621706886;10866.185036122164;10932.180086493387;10935.671929842118 06:17:48 INFO - PROCESS | 30339 | __end_tp_report 06:17:48 INFO - PROCESS | 30339 | __start_cc_report 06:17:48 INFO - PROCESS | 30339 | _x_x_mozilla_cycle_collect,350 06:17:48 INFO - PROCESS | 30339 | __end_cc_report 06:17:48 INFO - PROCESS | 30339 | __startTimestamp1464873468552__endTimestamp 06:17:48 INFO - PROCESS | 30339 | 06:17:48 INFO - PROCESS | 30339 | ------- Summary: start ------- 06:17:48 INFO - PROCESS | 30339 | Number of tests: 6 06:17:48 INFO - PROCESS | 30339 | 06:17:48 INFO - PROCESS | 30339 | [#0] dojo.html Cycles:165 Average:5471.94 Median:5726.34 stddev:733.91 (12.8%) stddev-sans-first:712.16 06:17:48 INFO - PROCESS | 30339 | Values: 3099.2 3157.6 3163.6 3177.8 3198.6 5497.5 5498.3 5508.1 5568.0 5574.6 5402.4 5499.6 5518.3 5540.7 5584.6 4954.6 4967.4 5104.1 5166.6 5212.6 849.7 5021.2 5102.5 5127.8 5162.5 4974.9 5015.3 5017.9 5025.3 5060.8 4986.8 5016.4 5029.9 5036.0 5044.0 4988.6 5015.0 5036.5 5040.7 5087.4 5465.6 5483.7 5502.4 5528.6 5570.8 5765.7 5805.3 5812.7 5937.6 5959.5 5850.0 5939.6 5941.8 5955.9 5968.6 5534.7 5535.2 5535.8 5545.6 5548.1 5882.0 5967.8 5984.7 6021.9 6029.8 5802.6 5822.3 5828.5 5840.9 5850.0 5873.7 5925.7 5927.8 5937.1 5943.5 5726.3 5855.3 5869.9 5900.2 5901.6 5766.5 5798.6 5825.2 5894.6 5931.3 4444.7 4454.2 4460.3 4477.9 4526.1 3883.2 3896.1 3925.0 3970.3 4003.7 5581.8 5587.6 5599.8 5601.6 5648.5 5834.0 5881.5 5886.8 5890.1 5898.1 5541.2 5603.6 5655.5 5702.8 5710.0 5130.8 5143.4 5164.9 5165.3 5177.3 6208.0 6234.6 6246.4 6255.9 6264.4 5720.3 5944.6 5954.9 6012.8 6035.8 6180.6 6219.4 6237.1 6242.9 6250.1 5671.3 5898.1 5927.5 5937.6 5974.7 5797.1 5866.0 5903.5 5923.3 5927.9 5752.6 5762.9 5777.7 5804.0 5825.7 5645.1 5769.9 5776.8 5778.0 5785.1 5602.3 5666.2 5708.5 5738.0 5784.6 5878.2 5908.9 5912.1 5929.1 5931.0 5601.5 5604.7 5767.9 5768.6 5781.7 06:17:48 INFO - PROCESS | 30339 | 06:17:48 INFO - PROCESS | 30339 | [#1] ext.html Cycles:180 Average:59379.62 Median:43578.96 stddev:113461.17 (260.4%) stddev-sans-first:113693.58 06:17:48 INFO - PROCESS | 30339 | Values: 585.8 618.6 626.3 645.7 646.4 33590.3 36556.5 43625.8 45035.3 45129.5 43532.1 43756.6 43923.6 44029.8 44141.8 8501.7 8595.9 8599.9 8682.0 8696.7 8628.5 8765.2 8805.0 8823.4 8862.9 8873.6 8874.0 8884.9 8905.9 8941.5 8804.7 8832.9 8872.8 8902.8 8909.2 8677.1 8768.5 8774.2 8779.8 8809.0 41630.4 42022.2 42080.0 42160.6 42226.8 3530.6 3617.8 3622.7 3626.4 3676.6 31554.5 31601.2 32047.7 32105.0 32258.8 4242.3 4340.8 4497.9 4561.6 4568.8 297768.0 298145.0 299125.0 299697.0 299897.0 59368.4 60031.0 60084.0 60421.7 60504.0 61976.0 62335.4 62625.7 62679.0 62964.4 16499.4 16678.6 16680.4 16684.4 16699.6 12279.5 12297.9 12298.9 12326.7 12377.4 17496.8 18350.4 18525.4 18526.2 18578.3 6016.0 6139.6 6179.7 6194.1 6210.6 940.4 1033.0 1060.7 1189.7 1202.3 32294.7 33659.5 33867.3 34037.3 34349.5 1102.2 1134.8 1137.3 1187.7 1199.4 17327.3 17944.0 17985.4 18011.9 18051.4 535804.0 536688.0 539120.3 539154.0 541455.0 59375.4 60802.0 60991.0 61057.4 61087.4 1356.9 1383.9 1401.7 1415.9 1416.6 32399.7 34132.8 34411.8 34862.8 35202.0 51902.7 52288.5 52320.2 52386.2 52790.2 407937.0 413165.6 414483.0 417172.0 417460.0 45770.3 45802.0 46954.8 47300.0 47338.3 49036.3 49492.3 49669.5 55624.0 56191.4 43106.6 43748.6 44102.3 44123.8 45439.8 43381.0 43384.8 44055.1 45101.8 45224.0 37753.6 42961.0 43198.0 43504.1 43827.8 35535.8 38030.6 38088.0 38478.8 38642.2 29518.4 29521.9 29813.3 29842.9 29977.7 06:17:48 INFO - PROCESS | 30339 | 06:17:48 INFO - PROCESS | 30339 | [#2] jquery.html Cycles:180 Average:26323.86 Median:180200.27 stddev:68326.49 (37.9%) stddev-sans-first:68490.38 06:17:48 INFO - PROCESS | 30339 | Values: 372.9 377.9 381.3 386.7 394.8 18005.1 19282.5 19378.3 19697.7 20019.2 17679.6 17928.2 17973.9 18069.6 19080.8 5379.9 5531.9 5646.9 5718.3 5719.6 5526.1 5603.8 5606.0 5644.7 5658.5 5441.9 5577.3 5577.7 5596.9 5627.6 5700.1 5791.7 5834.4 5838.4 5846.5 5597.6 5796.4 5797.2 5817.3 5827.7 13489.7 13719.4 17217.5 22323.9 22396.3 2342.7 2400.6 2428.7 2481.4 2806.5 9543.4 9600.3 9659.9 9847.2 9976.1 1954.6 2002.0 2004.8 2014.4 2047.0 76484.0 78054.0 78376.6 78462.2 79415.2 10293.2 10443.9 10715.7 10721.1 10766.4 14964.1 15000.8 15098.3 15110.1 15149.5 7962.4 8022.4 8025.7 8239.2 8283.7 7843.6 7853.1 7855.7 7921.2 8069.2 4692.9 4697.8 4708.2 4741.1 4759.0 2008.8 2011.7 2024.8 2032.8 2076.3 973.8 990.0 1030.9 1060.7 1068.8 18301.7 18878.2 18984.0 19158.7 19330.5 1024.1 1031.6 1052.0 1084.2 1085.2 10361.3 10713.8 10826.1 10828.3 10860.4 357594.0 357640.0 442060.0 444230.0 445778.0 75699.0 83508.2 93503.0 93663.0 99301.5 1025.5 1042.3 1052.9 1055.9 1059.2 17133.2 17174.4 17525.9 17527.8 17582.4 37907.0 39107.2 39315.4 41942.0 43033.0 55655.0 57327.7 60236.7 60718.7 60735.7 8109.7 8353.8 8376.9 8422.7 8754.7 12599.3 12612.6 13121.5 13352.8 13458.7 7041.9 8651.4 11238.8 11557.3 11694.9 11383.7 11463.8 11585.7 11805.4 11817.4 11575.6 11615.5 11824.6 11829.3 11854.3 7530.7 7872.8 8576.4 8621.1 8756.6 11516.2 11727.2 11898.8 11962.9 12076.2 06:17:48 INFO - PROCESS | 30339 | 06:17:48 INFO - PROCESS | 30339 | [#3] mootools.html Cycles:180 Average:5709.52 Median:4721.72 stddev:3266.09 (69.2%) stddev-sans-first:3259.76 06:17:48 INFO - PROCESS | 30339 | Values: 1475.9 1522.4 1636.7 1772.6 1772.7 7786.8 8385.4 8499.9 8889.6 8906.1 8695.8 8737.2 8751.6 8813.3 8817.8 2314.1 2344.0 2347.6 2348.4 2350.7 2256.2 2262.3 2304.9 2328.1 2332.3 2268.7 2307.4 2315.8 2317.6 2341.3 2265.8 2268.8 2282.7 2284.9 2293.7 2288.1 2308.3 2314.2 2315.1 2317.2 8702.5 8724.7 8741.3 8743.7 8751.2 4979.2 5073.2 5094.7 5097.3 5098.1 3187.9 3193.7 3316.5 3346.5 3354.1 1077.1 1081.7 1087.5 1093.9 1108.0 12054.3 12058.6 12073.6 12100.2 12162.4 4432.8 4490.8 4536.6 4548.5 4588.4 10204.2 10257.0 10324.4 10329.2 10356.2 5163.4 5192.4 5195.4 5202.1 5215.6 4218.3 4684.9 4758.5 4800.7 4801.7 3908.4 4045.0 4087.9 4113.0 4155.7 1278.7 1284.2 1295.3 1303.8 1306.6 765.8 848.2 909.8 910.0 928.3 5383.0 5532.9 5567.6 5634.0 5805.5 990.0 999.5 1031.9 1039.1 1054.8 3602.5 3632.6 3724.1 3730.6 3767.4 10629.3 10814.2 10892.0 10939.5 10981.7 10763.2 10820.2 10820.7 10876.0 10883.4 7780.4 8195.0 8276.5 8347.6 8359.4 5625.8 5659.1 5753.7 5764.7 5912.4 9577.7 9866.4 9906.6 9908.8 10076.3 10029.6 10125.0 10130.4 10142.5 10172.3 7040.4 7442.1 7625.7 7807.4 7840.5 8493.2 8499.2 8520.5 8521.2 8574.1 7578.6 7738.8 7762.9 7788.1 7868.9 7382.2 7417.1 7496.7 7596.0 7619.2 6824.6 6863.8 6896.3 6904.9 6914.0 4790.8 4938.4 4979.8 5021.7 5029.3 4784.9 4844.0 4936.9 4970.1 4989.3 06:17:48 INFO - PROCESS | 30339 | 06:17:48 INFO - PROCESS | 30339 | [#4] prototype.html Cycles:180 Average:4929.52 Median:5683.09 stddev:1476.35 (26.0%) stddev-sans-first:1439.39 06:17:48 INFO - PROCESS | 30339 | Values: 320.6 328.1 336.7 340.9 343.2 5629.9 5633.3 5662.3 5717.9 5719.3 5516.9 5539.5 5574.3 5603.9 5650.1 4135.2 4190.0 4276.2 4280.9 4286.1 4264.8 4282.4 4284.6 4284.9 4308.7 4260.4 4304.8 4320.7 4344.3 4352.5 4059.7 4301.5 4307.2 4313.7 4333.3 3716.3 3738.2 3750.9 3751.8 3759.6 5439.0 5448.8 5449.4 5465.3 5478.6 4820.4 4865.4 4914.9 5004.2 5014.2 5862.1 5864.4 5867.5 5922.2 5929.3 4176.3 4191.1 4192.5 4201.0 4201.5 5864.9 6114.3 6135.0 6153.0 6159.6 4177.0 4180.3 4183.7 4191.4 4192.1 4259.5 4262.3 4267.4 4269.2 4277.7 4736.9 4845.6 4891.4 4897.5 4951.6 5861.6 5875.3 5887.2 5890.8 5895.0 1463.9 1466.0 1467.8 1480.4 1483.2 915.1 926.9 929.6 969.0 970.2 5650.9 5665.6 5676.4 5679.9 5686.3 5961.9 5968.0 6000.7 6020.7 6045.2 5452.7 5656.0 5787.2 5790.5 5793.5 3215.8 3237.9 3241.2 3258.0 3262.5 6154.8 6282.6 6312.7 6320.2 6333.1 6149.9 6191.8 6196.2 6203.1 6211.8 6050.2 6243.1 6282.0 6297.0 6307.7 6047.7 6070.7 6083.8 6126.4 6129.3 5991.3 6040.2 6048.9 6064.2 6070.9 5909.7 6197.3 6271.3 6281.7 6296.6 4223.7 4232.6 4267.2 4273.1 4276.4 5868.2 5904.8 6068.5 6115.7 6118.6 5801.0 5801.8 5833.4 5839.7 5851.0 5789.7 5844.4 5851.8 5855.1 5857.5 5550.3 5689.0 5694.6 5709.3 5726.2 5823.0 5860.0 5909.8 5958.5 5972.6 5381.3 5787.3 5790.8 5796.1 5848.3 06:17:48 INFO - PROCESS | 30339 | 06:17:48 INFO - PROCESS | 30339 | [#5] yui.html Cycles:180 Average:15607.94 Median:4784.31 stddev:18747.06 (391.8%) stddev-sans-first:18766.49 06:17:48 INFO - PROCESS | 30339 | Values: 759.2 773.6 795.0 804.3 839.0 13206.2 15248.8 15456.1 15473.2 15534.2 13898.0 13912.3 13926.3 13930.6 13989.9 674.1 799.2 814.9 815.8 816.8 794.1 815.1 816.7 817.7 819.3 857.5 871.4 876.6 877.5 879.2 855.5 860.6 861.3 863.3 867.3 632.4 634.3 637.3 638.9 639.9 14025.0 14095.7 14101.6 14143.8 14196.6 13873.4 14017.6 14089.7 14159.3 14410.1 10983.5 11021.2 11183.2 11290.2 11332.9 3866.4 3936.9 3962.9 4062.6 4068.4 57316.7 57601.7 57639.7 58180.4 58240.0 11015.3 11270.4 11293.7 11428.8 11722.4 20372.6 20406.0 20419.7 20435.7 20480.0 8381.0 8569.4 8621.8 8885.5 8940.1 4714.2 4854.4 4883.1 4902.7 5010.4 3468.0 3550.1 3551.9 3554.6 3564.1 598.1 604.7 618.3 619.5 625.1 665.2 766.7 767.2 809.3 836.2 9032.9 9047.4 9109.0 9170.6 9180.0 668.9 681.2 691.3 728.6 773.7 4541.2 4553.7 4568.5 4605.9 4659.8 64547.4 66450.0 66458.7 67584.7 67728.0 60898.4 61465.4 61549.7 62368.4 63014.4 54505.5 54949.7 55831.2 55964.4 56502.4 8775.3 8820.6 8860.4 8881.7 8990.8 37177.1 37196.6 37585.0 37781.0 37876.4 46066.0 50503.5 50525.5 50650.2 51215.5 11746.3 11881.5 11971.0 11984.6 12064.2 12755.9 12994.8 13146.6 13175.3 13201.7 12070.8 12162.8 12340.0 12474.7 12834.5 11145.3 11495.2 11500.1 11711.1 12122.5 11958.4 12128.7 12429.7 12460.7 12523.2 9946.7 10081.6 10194.6 10262.9 10544.4 10541.2 10719.5 10866.2 10932.2 10935.7 06:17:48 INFO - PROCESS | 30339 | -------- Summary: end -------- 06:17:48 INFO - PROCESS | 30339 | 06:17:49 INFO - TEST-INFO | 30339: exit 0 06:17:49 INFO - TEST-OK | dromaeo_css | took 1110248ms 06:17:49 INFO - TEST-START | kraken 06:17:49 INFO - operating with platform_type : linux_ 06:17:49 INFO - Initialising browser for kraken test... 06:17:49 INFO - TEST-INFO | started process 30580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVlzcJl/profile http://localhost:39140/getInfo.html) 06:17:53 INFO - PROCESS | 30580 | __metrics Screen width/height:1600/1200 06:17:53 INFO - PROCESS | 30580 | colorDepth:24 06:17:53 INFO - PROCESS | 30580 | Browser inner width/height: 1024/697 06:17:53 INFO - PROCESS | 30580 | __metrics 06:17:54 ERROR - PROCESS | 30580 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:17:55 INFO - TEST-INFO | 30580: exit 0 06:17:55 INFO - Browser initialized. 06:17:55 INFO - Running cycle 1/1 for kraken test... 06:17:55 INFO - TEST-INFO | started process 30703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVlzcJl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:07 INFO - PROCESS | 30703 | RSS: Main: 166526976 06:18:07 INFO - PROCESS | 30703 | 06:18:09 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39140/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:10 INFO - PROCESS | 30703 | RSS: Main: 172015616 06:18:10 INFO - PROCESS | 30703 | 06:18:13 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39140/tests/kraken/driver.html?testName=audio-dft) 06:18:13 INFO - PROCESS | 30703 | RSS: Main: 171089920 06:18:13 INFO - PROCESS | 30703 | 06:18:16 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39140/tests/kraken/driver.html?testName=audio-fft) 06:18:17 INFO - PROCESS | 30703 | RSS: Main: 166277120 06:18:17 INFO - PROCESS | 30703 | 06:18:19 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39140/tests/kraken/driver.html?testName=audio-oscillator) 06:18:20 INFO - PROCESS | 30703 | RSS: Main: 166776832 06:18:20 INFO - PROCESS | 30703 | 06:18:22 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:22 INFO - PROCESS | 30703 | RSS: Main: 167358464 06:18:22 INFO - PROCESS | 30703 | 06:18:26 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39140/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:26 INFO - PROCESS | 30703 | RSS: Main: 167641088 06:18:26 INFO - PROCESS | 30703 | 06:18:30 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39140/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:30 INFO - PROCESS | 30703 | RSS: Main: 165138432 06:18:30 INFO - PROCESS | 30703 | 06:18:33 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39140/tests/kraken/driver.html?testName=json-parse-financial) 06:18:34 INFO - PROCESS | 30703 | RSS: Main: 166912000 06:18:34 INFO - PROCESS | 30703 | 06:18:35 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:36 INFO - PROCESS | 30703 | RSS: Main: 167075840 06:18:36 INFO - PROCESS | 30703 | 06:18:38 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39140/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:38 INFO - PROCESS | 30703 | RSS: Main: 167710720 06:18:38 INFO - PROCESS | 30703 | 06:18:40 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:41 INFO - PROCESS | 30703 | RSS: Main: 168226816 06:18:41 INFO - PROCESS | 30703 | 06:18:44 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:44 INFO - PROCESS | 30703 | RSS: Main: 168255488 06:18:44 INFO - PROCESS | 30703 | 06:18:47 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:48 INFO - PROCESS | 30703 | RSS: Main: 167825408 06:18:48 INFO - PROCESS | 30703 | 06:18:49 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39140/tests/kraken/driver.html?testName=ai-astar) 06:18:50 INFO - PROCESS | 30703 | RSS: Main: 168202240 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | __start_tp_report 06:18:50 INFO - PROCESS | 30703 | _x_x_mozilla_page_load 06:18:50 INFO - PROCESS | 30703 | _x_x_mozilla_page_load_details 06:18:50 INFO - PROCESS | 30703 | |i|pagename|runs| 06:18:50 INFO - PROCESS | 30703 | |0;ai-astar;112;105;110;110;110;112;113;109;111;111 06:18:50 INFO - PROCESS | 30703 | |1;audio-beat-detection;157;126;159;178;127;161;149;129;181;139 06:18:50 INFO - PROCESS | 30703 | |2;audio-dft;162;161;161;162;166;170;170;163;161;161 06:18:50 INFO - PROCESS | 30703 | |3;audio-fft;75;75;74;170;77;80;75;76;170;74 06:18:50 INFO - PROCESS | 30703 | |4;audio-oscillator;84;82;143;84;83;84;151;84;83;142 06:18:50 INFO - PROCESS | 30703 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;118;118 06:18:50 INFO - PROCESS | 30703 | |6;imaging-darkroom;146;148;147;147;148;147;147;147;146;147 06:18:50 INFO - PROCESS | 30703 | |7;imaging-desaturate;96;97;96;95;96;96;95;101;102;96 06:18:50 INFO - PROCESS | 30703 | |8;json-parse-financial;53;53;56;54;54;54;54;56;55;59 06:18:50 INFO - PROCESS | 30703 | |9;json-stringify-tinderbox;61;61;62;62;61;61;61;61;60;62 06:18:50 INFO - PROCESS | 30703 | |10;stanford-crypto-aes;81;78;80;79;86;80;86;82;118;81 06:18:50 INFO - PROCESS | 30703 | |11;stanford-crypto-ccm;131;141;122;125;139;129;121;133;126;128 06:18:50 INFO - PROCESS | 30703 | |12;stanford-crypto-pbkdf2;170;166;168;161;164;165;169;161;162;161 06:18:50 INFO - PROCESS | 30703 | |13;stanford-crypto-sha256-iterative;65;64;67;63;64;64;62;64;63;64 06:18:50 INFO - PROCESS | 30703 | __end_tp_report 06:18:50 INFO - PROCESS | 30703 | __start_cc_report 06:18:50 INFO - PROCESS | 30703 | _x_x_mozilla_cycle_collect,851 06:18:50 INFO - PROCESS | 30703 | __end_cc_report 06:18:50 INFO - PROCESS | 30703 | __startTimestamp1464873530163__endTimestamp 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | ------- Summary: start ------- 06:18:50 INFO - PROCESS | 30703 | Number of tests: 14 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.21 (2.0%) stddev-sans-first:2.26 06:18:50 INFO - PROCESS | 30703 | Values: 112.0 105.0 110.0 110.0 110.0 112.0 113.0 109.0 111.0 111.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:158.00 stddev:20.17 (12.8%) stddev-sans-first:21.26 06:18:50 INFO - PROCESS | 30703 | Values: 157.0 126.0 159.0 178.0 127.0 161.0 149.0 129.0 181.0 139.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#2] audio-dft Cycles:10 Average:163.70 Median:162.50 stddev:3.65 (2.2%) stddev-sans-first:3.82 06:18:50 INFO - PROCESS | 30703 | Values: 162.0 161.0 161.0 162.0 166.0 170.0 170.0 163.0 161.0 161.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:39.78 (53.0%) stddev-sans-first:41.55 06:18:50 INFO - PROCESS | 30703 | Values: 75.0 75.0 74.0 170.0 77.0 80.0 75.0 76.0 170.0 74.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:83.50 stddev:30.00 (35.9%) stddev-sans-first:31.10 06:18:50 INFO - PROCESS | 30703 | Values: 84.0 82.0 143.0 84.0 83.0 84.0 151.0 84.0 83.0 142.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:18:50 INFO - PROCESS | 30703 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 06:18:50 INFO - PROCESS | 30703 | Values: 146.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 146.0 147.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.45 (2.6%) stddev-sans-first:2.57 06:18:50 INFO - PROCESS | 30703 | Values: 96.0 97.0 96.0 95.0 96.0 96.0 95.0 101.0 102.0 96.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:1.81 (3.3%) stddev-sans-first:1.80 06:18:50 INFO - PROCESS | 30703 | Values: 53.0 53.0 56.0 54.0 54.0 54.0 54.0 56.0 55.0 59.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:18:50 INFO - PROCESS | 30703 | Values: 61.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 60.0 62.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:81.00 stddev:11.86 (14.6%) stddev-sans-first:12.49 06:18:50 INFO - PROCESS | 30703 | Values: 81.0 78.0 80.0 79.0 86.0 80.0 86.0 82.0 118.0 81.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:130.00 stddev:6.67 (5.1%) stddev-sans-first:7.05 06:18:50 INFO - PROCESS | 30703 | Values: 131.0 141.0 122.0 125.0 139.0 129.0 121.0 133.0 126.0 128.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:3.47 (2.1%) stddev-sans-first:3.10 06:18:50 INFO - PROCESS | 30703 | Values: 170.0 166.0 168.0 161.0 164.0 165.0 169.0 161.0 162.0 161.0 06:18:50 INFO - PROCESS | 30703 | 06:18:50 INFO - PROCESS | 30703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 06:18:50 INFO - PROCESS | 30703 | Values: 65.0 64.0 67.0 63.0 64.0 64.0 62.0 64.0 63.0 64.0 06:18:50 INFO - PROCESS | 30703 | -------- Summary: end -------- 06:18:50 INFO - PROCESS | 30703 | 06:18:51 INFO - TEST-INFO | 30703: exit 0 06:18:51 INFO - TEST-OK | kraken | took 61841ms 06:18:51 INFO - SUITE-END | took 1172s 06:18:51 INFO - Completed test suite (00:19:32) 06:18:51 INFO - javascript benchmark 06:18:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7215.719576020731, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.2251937015744, 3157.6210854697433, 3163.557102005718, 3177.809331440112, 3198.6001749781276, 5497.532709719673, 5498.312710911141, 5508.146237333215, 5567.972160139204, 5574.554035677146, 5402.405735369106, 5499.587530935176, 5518.33779946406, 5540.722963851811, 5584.581156413265, 4954.554090131896, 4967.403911530603, 5104.055749686301, 5166.61250406221, 5212.582993360522, 849.7039844360665, 5021.221710634857, 5102.515261050195, 5127.820526281581, 5162.483751624845, 4974.925376119361, 5015.32293140425, 5017.899642007158, 5025.321581586476, 5060.822871199491, 4986.825461108844, 5016.448190699057, 5029.899402011939, 5036.043151801183, 5043.974780126113, 4988.625853061035, 5014.974925125351, 5036.546710796009, 5040.747962601855, 5087.414947281036, 5465.6447330923365, 5483.725813709299, 5502.394736578973, 5528.6406383585345, 5570.805021824257, 5765.682887441189, 5805.3323867755325, 5812.680302583356, 5937.584369094165, 5959.463648271676, 5850.0, 5939.643621382731, 5941.762329506814, 5955.880882382371, 5968.552358573081, 5534.667919924817, 5535.197396377503, 5535.778568857281, 5545.611807173459, 5548.056830338852, 5881.9705901470215, 5967.79112731061, 5984.73068711909, 6021.909671354933, 6029.8191054268445, 5802.622829516068, 5822.272215973004, 5828.5337173026055, 5840.853978650568, 5850.005499065169, 5873.676947767914, 5925.703714814242, 5927.792527261525, 5937.079752638348, 5943.524518038546, 5726.341470730836, 5855.268091488564, 5869.882602347929, 5900.173975643327, 5901.616394934315, 5766.538676905838, 5798.623089499169, 5825.1844741736195, 5894.557908156906, 5931.258592675916, 4444.7110937789585, 4454.22051141049, 4460.30865215892, 4477.888052798641, 4526.140033393644, 3883.165119499321, 3896.064944413377, 3925.0, 3970.285348637273, 4003.679705623543, 5581.832545023656, 5587.580931430159, 5599.804006859822, 5601.63589366698, 5648.49163575272, 5834.0, 5881.470667639933, 5886.823395298148, 5890.057590785539, 5898.056310990221, 5541.224228607998, 5603.551715862803, 5655.5475561954945, 5702.800401985911, 5710.029295019856, 5130.769115389817, 5143.382794064736, 5164.948350516522, 5165.302684137669, 5177.275181474596, 6207.96896015517, 6234.594751341148, 6246.4378205960775, 6255.937440625536, 6264.436200741955, 5720.256366672389, 5944.5838791284195, 5954.851128721816, 6012.819615411545, 6035.78874739382, 6180.646700871011, 6219.440250377488, 6237.12680224778, 6242.875142497215, 6250.062490626442, 5671.262735844314, 5898.056310990221, 5927.492989791623, 5937.614055086406, 5974.701264936823, 5797.072468405035, 5866.0, 5903.527717782653, 5923.259592550931, 5927.940720592739, 5752.568557358131, 5762.8847423050465, 5777.74000169985, 5803.970980145073, 5825.70871456434, 5645.096784514458, 5769.884602308014, 5776.768929242783, 5778.0, 5785.074388098053, 5602.327720673546, 5666.15007748841, 5708.54331653475, 5737.971310143423, 5784.623999440023, 5878.2358293421585, 5908.911366329595, 5912.113183022409, 5929.140274660064, 5930.96208163561, 5601.495865372136, 5604.663720176803, 5767.9134812977, 5768.596198266249, 5781.739821708117], "value": 5423.113317715406, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.7569108819837, 618.5639124417286, 626.2578844069777, 645.7352485480952, 646.437599288619, 33590.328193436144, 36556.451653225224, 43625.78187109064, 45035.324470132895, 45129.54870451303, 43532.12935741291, 43756.56243437565, 43923.56076439234, 44029.7798511007, 44141.7792911035, 8501.659933602665, 8595.914040859605, 8599.914000859973, 8681.95659021704, 8696.739097827076, 8628.482291062524, 8765.211130998208, 8804.955975220115, 8823.426477278988, 8862.911370886273, 8873.600687969025, 8874.0, 8884.911150888505, 8905.910940890606, 8941.50821704806, 8804.691835785748, 8832.911670883273, 8872.778180545505, 8902.777430564223, 8909.242714369286, 8677.132286771272, 8768.473891566526, 8774.21032107107, 8779.824403511959, 8809.0, 41630.375544366856, 42022.15955680869, 42080.00239977197, 42160.57839421597, 42226.788866055475, 3530.6116327203986, 3617.801020943847, 3622.6920711739535, 3626.4197728363333, 3676.5771936227407, 31554.526682099557, 31601.20996975094, 32047.679523204704, 32105.0, 32258.83870580632, 4242.342436922282, 4340.782960851945, 4497.887552811206, 4561.612262957653, 4568.817247310104, 297768.0, 298145.0, 299125.0, 299696.99999999785, 299897.0, 59368.40631593715, 60031.0, 60084.0, 60421.69789151026, 60504.0, 61976.0, 62335.37664623296, 62625.686871566264, 62679.0, 62964.370356296764, 16499.422520211734, 16678.58303542421, 16680.416185433452, 16684.416045438353, 16699.582510437336, 12279.508819647293, 12297.877021229851, 12298.938505307595, 12326.691832704255, 12377.381130943417, 17496.825031749773, 18350.35773747939, 18525.44423667292, 18526.16632251552, 18578.349757758413, 6016.0, 6139.558107602047, 6179.721912513947, 6194.101855230966, 6210.627362358273, 940.4028441939417, 1032.9690109296732, 1060.6688605799673, 1189.7085214122596, 1202.3387137074574, 32294.677053229636, 33659.495107573406, 33867.32265354679, 34037.31925361479, 34349.48475772866, 1102.2449622008949, 1134.756027454085, 1137.294877176156, 1187.6912002879315, 1199.3703305764543, 17327.25710059771, 17944.0, 17985.370512032016, 18011.909940450478, 18051.368202112862, 535804.0, 536688.0, 539120.348380835, 539154.0, 541455.0, 59375.406245937855, 60802.0, 60991.0, 61057.38942610517, 61087.38912610817, 1356.8575299593401, 1383.889288856889, 1401.7266633006466, 1415.9238978376509, 1416.5891891351598, 32399.67600324061, 34132.82933585316, 34411.82794086014, 34862.82568587141, 35202.0, 51902.74048629733, 52288.47711522836, 52320.21519677284, 52386.214206786164, 52790.20814687706, 407937.0, 413165.6050318495, 414483.0, 417172.0, 417460.0, 45770.31344529901, 45802.0, 46954.76522617365, 47300.0, 47338.28992565183, 49036.2644560339, 49492.257616135066, 49669.503304966485, 55624.0, 56191.43808561862, 43106.56893431026, 43748.56251437445, 44102.33846492369, 44123.77938110289, 45439.77280113578, 43381.0, 43384.78307608568, 44055.11889762251, 45101.77449112865, 45224.0, 37753.62246377501, 42961.0, 43198.0, 43504.129917402104, 43827.78086109549, 35535.822320888234, 38030.619693802706, 38088.0, 38478.80760596179, 38642.227155456174, 29518.409631807674, 29521.85239073791, 29813.254668633457, 29842.850785745934, 29977.70022299749], "value": 20561.600686896432, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8769506063001, 377.939529675252, 381.34789509938, 386.7408836079826, 394.77497826239056, 18005.099745012747, 19282.51793705158, 19378.321758738446, 19697.704534431996, 20019.1992320307, 17679.55801104973, 17928.19323130459, 17973.91013044933, 18069.63860722788, 19080.809191908076, 5379.892402151974, 5531.861703457415, 5646.858828529299, 5718.285214348207, 5719.571032172583, 5526.143447765603, 5603.80386686466, 5606.046972014747, 5644.717764111799, 5658.519025882805, 5441.891162176774, 5577.274954255941, 5577.749001294931, 5596.888062238773, 5627.634203776742, 5700.116481945305, 5791.652500849962, 5834.416558344153, 5838.416158384149, 5846.50304724099, 5597.580181486404, 5796.420357964212, 5797.246357973437, 5817.272840894888, 5827.650340979555, 13489.730205395936, 13719.382627781773, 17217.483475495756, 22323.888380557994, 22396.328110156723, 2342.7422983471974, 2400.6399040143942, 2428.7449817769057, 2481.392058945552, 2806.5405988885664, 9543.42739435636, 9600.279979001532, 9659.855102173473, 9847.16299114576, 9976.102150806462, 1954.5895361974003, 2001.989990050055, 2004.7794742578305, 2014.355406269994, 2046.9692954605694, 76484.0, 78054.0, 78376.60811695961, 78462.21537784606, 79415.20584794194, 10293.176545876311, 10443.94778026105, 10715.678529644123, 10721.088707459798, 10766.407847568458, 14964.102153870803, 15000.774988375184, 15098.320575573905, 15110.093394396372, 15149.545513634608, 7962.442629015914, 8022.358211343195, 8025.719099831478, 8239.176082391832, 8283.710070147516, 7843.568603726736, 7853.057633083952, 7855.685772569148, 7921.207879212033, 8069.193080691884, 4692.859214223578, 4697.8355757548325, 4708.223143181405, 4741.1465936131135, 4758.9780489388795, 2008.8493362997833, 2011.7167015437292, 2024.8076432738867, 2032.8475364347732, 2076.345951025422, 973.8441849304078, 989.9752506187259, 1030.9484525773682, 1060.7083052160563, 1068.8183008888507, 18301.7254741179, 18878.1601386691, 18983.9558824266, 19158.71261931072, 19330.516737081685, 1024.1448390593937, 1031.633770011635, 1051.984220236697, 1084.159776173456, 1085.2403317677656, 10361.274710770325, 10713.83929241062, 10826.133909287395, 10828.296160749525, 10860.402677852637, 357594.0, 357640.0, 442060.0, 444230.0, 445778.0, 75699.0, 83508.16491835125, 93503.0, 93663.0, 99301.50349248352, 1025.477006726575, 1042.2964498963322, 1052.884182739898, 1055.8680164979378, 1059.2373491086405, 17133.20270324311, 17174.39889603858, 17525.912370438575, 17527.82472175262, 17582.38461653836, 37907.0, 39107.2178556433, 39315.410268846565, 41942.0, 43033.0, 55655.0, 57327.71336143293, 60236.69881650564, 60718.69640651769, 60735.69632151811, 8109.7161599343735, 8353.832923341377, 8376.874346884924, 8422.705205317785, 8754.693585724724, 12599.307038112625, 12612.55856045034, 13121.540746073842, 13352.799708004582, 13458.663533411744, 7041.859162816818, 8651.351148664002, 11238.83141752858, 11557.30656160633, 11694.88305116938, 11383.715407114558, 11463.770724585629, 11585.710357241136, 11805.350705711267, 11817.409129543661, 11575.594854180401, 11615.477303521193, 11824.586139485076, 11829.290242585472, 11854.348010859485, 7530.6611202497115, 7872.803179920548, 8576.356773242156, 8621.051684314594, 8756.60595273227, 11516.19386642927, 11727.237729547893, 11898.821517677068, 11962.880371196525, 12076.154669173073], "value": 9040.797582595274, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.8819294456443, 1522.4290890915906, 1636.7299395599728, 1772.592303770132, 1772.725227589724, 7786.766397008085, 8385.413021088527, 8499.915000850006, 8889.555522223887, 8906.1093890611, 8695.826083478327, 8737.213650771446, 8751.606177722002, 8813.338999575042, 8817.823643527141, 2314.1206341590214, 2343.9765602343928, 2347.6009078456705, 2348.412896775806, 2350.74141844397, 2256.2216035467736, 2262.298687406901, 2304.8617082974993, 2328.1269523928527, 2332.2536788227776, 2268.6823844661762, 2307.4462129089065, 2315.78000089992, 2317.582835089683, 2341.262502311775, 2265.8413911026237, 2268.7844654757773, 2282.691836602054, 2284.9314520564326, 2293.7247530296386, 2288.096202000217, 2308.2613563659634, 2314.2478694424212, 2315.073970411832, 2317.188983855654, 8702.521361325125, 8724.651013959434, 8741.344399170088, 8743.737687869374, 8751.212390884788, 4979.228219625964, 5073.162928116856, 5094.694318340911, 5097.2608971699265, 5098.133317336024, 3187.8884239051754, 3193.7445004399824, 3316.4527852904243, 3346.5147553604834, 3354.1446931032674, 1077.06833588945, 1081.6971248050559, 1087.4508373271526, 1093.8906109389077, 1108.0470795116194, 12054.276743395425, 12058.6382408527, 12073.6377908662, 12100.152989290753, 12162.391880405945, 4432.800523976364, 4490.820367185342, 4536.61438777701, 4548.476925153584, 4588.3805686231935, 10204.23468239885, 10257.0, 10324.380537167644, 10329.225308101923, 10356.223283253636, 5163.380394352702, 5192.350956130484, 5195.402528709171, 5202.08963431398, 5215.634905556574, 4218.325067989168, 4684.906301873943, 4758.524147585283, 4800.687955282895, 4801.68789028712, 3908.394198899175, 4045.0494133878515, 4087.8773636790943, 4112.992316882383, 4155.667546596265, 1278.6803299175206, 1284.190959695386, 1295.3005377096263, 1303.8305020347484, 1306.5688322853437, 765.8353454007415, 848.1645579104577, 909.7952960583948, 910.0489987962595, 928.331601247101, 5382.973085134549, 5532.917006244909, 5567.610267281332, 5633.971830140905, 5805.535557155417, 989.9653512127041, 999.5402115027169, 1031.9380837149795, 1039.0907955538903, 1054.7626783973544, 3602.4776407420777, 3632.582253040934, 3724.0689827543115, 3730.5709843367817, 3767.434884767307, 10629.25595208328, 10814.243002989873, 10892.0, 10939.507722152523, 10981.670549883516, 10763.24657273999, 10820.242583019113, 10820.729481763019, 10876.0, 10883.401412922207, 7780.416468764752, 8194.959025204837, 8276.462029968034, 8347.582620868932, 8359.373047021498, 5625.774969001194, 5659.122835960433, 5753.741081651252, 5764.711764411679, 5912.379200183918, 9577.712668619952, 9866.408015519091, 9906.554205060933, 9908.752281193028, 10076.345037572535, 10029.598816047277, 10125.038121378457, 10130.392176469435, 10142.54358553852, 10172.28793984414, 7040.401565866959, 7442.1069471661585, 7625.733099341496, 7807.414443916842, 7840.490368126054, 8493.150684931457, 8499.235068843835, 8520.531370774666, 8521.233089022018, 8574.142585741376, 7578.583177925267, 7738.806529836799, 7762.883556746766, 7788.1433042366425, 7868.881966770388, 7382.151052629017, 7417.072865891763, 7496.662650180646, 7595.962020189863, 7619.161892191965, 6824.624645644339, 6863.828404289933, 6896.310368963264, 6904.861902761816, 6914.0, 4790.760461976957, 4938.432080310667, 4979.751012449436, 5021.72380519075, 5029.295898574275, 4784.880377990578, 4843.95156048435, 4936.9259461107395, 4970.055689418999, 4989.301497790239], "value": 4570.283836404258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.60245295833164, 328.0764647517239, 336.6734267760273, 340.94544872820325, 343.2294498850082, 5629.915551266734, 5633.324001119866, 5662.263905692259, 5717.885642287157, 5719.342275638302, 5516.91724624131, 5539.473749993744, 5574.275344205258, 5603.859903502414, 5650.124230744231, 4135.2349815284115, 4189.958100419002, 4276.187524370375, 4280.850170244042, 4286.121345124242, 4264.765437900915, 4282.400463935051, 4284.635805956497, 4284.871453856389, 4308.655307575402, 4260.40234911908, 4304.80628371724, 4320.697551171419, 4344.326629372453, 4352.499462561798, 4059.6955228357842, 4301.526832048472, 4307.203167414038, 4313.741175529478, 4333.328334108202, 3716.349638813224, 3738.2336620992633, 3750.9062273443383, 3751.81240937952, 3759.642833930772, 5439.0, 5448.8477051564805, 5449.373322067933, 5465.289512363407, 5478.643888147258, 4820.421549414058, 4865.41615006198, 4914.926276105862, 5004.2493625956395, 5014.24786282057, 5862.149988251722, 5864.416607515946, 5867.501262392701, 5922.200502932135, 5929.347771745104, 4176.310908700061, 4191.098913733532, 4192.538820729717, 4200.978995105035, 4201.516825565038, 5864.941350586482, 6114.2968558615885, 6135.0, 6152.98475751496, 6159.599626024294, 4176.9582304177175, 4180.310248808913, 4183.707140500136, 4191.371294305878, 4192.098698779716, 4259.467566554181, 4262.2754131797665, 4267.445232119804, 4269.188854117708, 4277.679174061957, 4736.928946065812, 4845.577211394303, 4891.437484689235, 4897.486985024713, 4951.554360107536, 5861.648301101947, 5875.29496460419, 5887.175795388649, 5890.7938222162875, 5894.970525147347, 1463.9121652700871, 1465.9706805863823, 1467.7798330250548, 1480.4300344367496, 1483.199072500859, 915.1123410292006, 926.8841394825647, 929.6049179098856, 968.9612415503442, 970.1608108985677, 5650.886982260332, 5665.575081868877, 5676.403977582377, 5679.886402271932, 5686.289213848269, 5961.850953726192, 5968.0, 6000.69996500182, 6020.668863212565, 6045.183900173508, 5452.700101494456, 5655.971720141373, 5787.218725472091, 5790.507806836382, 5793.536517078624, 3215.8070515769127, 3237.8542965566608, 3241.2059045533997, 3257.951130733041, 3262.4503360903855, 6154.846128846814, 6282.591631543935, 6312.652804095819, 6320.178376810985, 6333.081703153017, 6149.907751383733, 6191.783287584913, 6196.225471816023, 6203.131561581382, 6211.81364559064, 6050.24371953497, 6243.125962365272, 6282.026285925689, 6297.0089207626925, 6307.738452309556, 6047.699744554941, 6070.696465176635, 6083.756649733961, 6126.417990290915, 6129.264488261437, 5991.310999234969, 6040.154378386941, 6048.879022419615, 6064.151018857276, 6070.878582428239, 5909.704514774158, 6197.287311959182, 6271.306747178145, 6281.71732272058, 6296.590721603081, 4223.676977662335, 4232.597903199191, 4267.231898258343, 4273.124009578091, 4276.3799249109325, 5868.2077919480325, 5904.822855314347, 6068.48287928018, 6115.694215289129, 6118.60229085108, 5800.970995144998, 5801.82594522165, 5833.387494313036, 5839.678817665069, 5850.970745146247, 5789.739461724148, 5844.370033484864, 5851.824445266649, 5855.092460668603, 5857.47282744555, 5550.334899530206, 5688.971555142198, 5694.629849059798, 5709.25779648643, 5726.198332233574, 5822.970885145547, 5859.970700146472, 5909.8227053188475, 5958.493528050164, 5972.5520585955355, 5381.27352807366, 5787.263820853811, 5790.826275211751, 5796.101604251347, 5848.298204215522], "value": 4450.168799917621, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.1535437986646, 773.5590713293421, 794.9682012719492, 804.2721337189842, 839.0057781528889, 13206.207627542353, 15248.771268430968, 15456.149911754848, 15473.226338683076, 15534.22328883557, 13897.957653176027, 13912.304384780746, 13926.30368481577, 13930.58208253754, 13989.860101398983, 674.1303718203511, 799.1928152565906, 814.8573999550084, 815.8123631564744, 816.8202995341045, 794.086800179795, 815.0830315894618, 816.6733306677318, 817.709713051867, 819.2749416766175, 857.5326447086353, 871.363904349825, 876.5967654878764, 877.5392918717693, 879.1647934462254, 855.5080828523562, 860.5912191708982, 861.3066481482405, 863.2748491267365, 867.3278209387712, 632.3929028132952, 634.2515831319088, 637.2575949019387, 638.8722255548909, 639.9424051835357, 14025.0, 14095.718085638333, 14101.576952691436, 14143.787843182361, 14196.574102776933, 13873.375698093509, 14017.64955876101, 14089.71820563583, 14159.292035398188, 14410.135391876522, 10983.450827458675, 11021.228514004022, 11183.161262905314, 11290.153238507062, 11332.943335283353, 3866.420036994445, 3936.921261574781, 3962.881113566598, 4062.6140516651167, 4068.4304197412384, 57316.71341643307, 57601.71199144019, 57639.711801440724, 58180.418195817925, 58240.0, 11015.311802619039, 11270.436478176058, 11293.661190164308, 11428.828567571492, 11722.413879306172, 20372.592548148954, 20406.0, 20419.693704594443, 20435.693464598044, 20480.0, 8381.0, 8569.35729820266, 8621.797586016224, 8885.4668719877, 8940.061293564082, 4714.207405192577, 4854.417469903634, 4883.072216278967, 4902.730349830722, 5010.423801262901, 3467.9653203468147, 3550.0947258449446, 3551.8579256829953, 3554.644535546425, 3564.1267889366754, 598.1446531460053, 604.6583680220662, 618.2982315072425, 619.4765423217374, 625.0624063904144, 665.1519312876025, 766.6779952419997, 767.1561282589107, 809.2756982500629, 836.193073683898, 9032.909670903207, 9047.366684332164, 9108.954455227682, 9170.587323570455, 9179.954100229455, 668.8963210702349, 681.1757773094512, 691.3052382355801, 728.6393235348536, 773.704045723411, 4541.205289074399, 4553.704009239389, 4568.474625418053, 4605.930911036337, 4659.8136074557315, 64547.35452645507, 66450.0, 66458.66770666116, 67584.6620766893, 67728.0, 60898.39101609016, 61465.38534614686, 61549.69225153846, 62368.37631623626, 63014.36985630177, 54505.45494545083, 54949.725251373486, 55831.16253256204, 55964.44035559674, 56502.43497564972, 8775.254103401026, 8820.603072861864, 8860.3797734158, 8881.73354799357, 8990.775230619287, 37177.07057323481, 37196.62803371932, 37585.0, 37781.0, 37876.43185352277, 46066.0, 50503.49496504988, 50525.49474505355, 50650.24024639707, 51215.487845121075, 11746.29522228669, 11881.544420842185, 11971.0, 11984.64046078619, 12064.215825971283, 12755.93622031884, 12994.80507792365, 13146.60560183196, 13175.341232938506, 13201.735965280832, 12070.818937715765, 12162.817557736464, 12340.0, 12474.688132796753, 12834.486620535074, 11145.275557089088, 11495.195336326711, 11500.137489688139, 11711.121665874924, 12122.515099395925, 11958.402079895797, 12128.696782580506, 12429.689257768629, 12460.688482788002, 12523.248605083723, 9946.701598952042, 10081.596736130472, 10194.643187488402, 10262.897371026194, 10544.420056896945, 10541.156707463231, 10719.517621706886, 10866.185036122164, 10932.180086493387, 10935.671929842118], "value": 6883.385032335037, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 110.0, 110.0, 112.0, 113.0, 109.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 159.0, 178.0, 127.0, 161.0, 149.0, 129.0, 181.0, 139.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 166.0, 170.0, 170.0, 163.0, 161.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 170.0, 77.0, 80.0, 75.0, 76.0, 170.0, 74.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 143.0, 84.0, 83.0, 84.0, 151.0, 84.0, 83.0, 142.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 101.0, 102.0, 96.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 56.0, 54.0, 54.0, 54.0, 54.0, 56.0, 55.0, 59.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 60.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 80.0, 79.0, 86.0, 80.0, 86.0, 82.0, 118.0, 81.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 141.0, 122.0, 125.0, 139.0, 129.0, 121.0, 133.0, 126.0, 128.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 168.0, 161.0, 164.0, 165.0, 169.0, 161.0, 162.0, 161.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 63.0, 64.0, 64.0, 62.0, 64.0, 63.0, 64.0], "value": 64.0, "unit": "score"}]}]} 06:18:51 INFO - Return code: 0 06:18:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:18:51 ERROR - # TBPL SUCCESS # 06:18:51 INFO - Running post-action listener: _resource_record_post_action 06:18:51 INFO - ##### 06:18:51 INFO - ##### Finished run-tests step (success) 06:18:51 INFO - ##### 06:18:51 INFO - Running post-run listener: _resource_record_post_run 06:18:51 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540979200; Read time: 12; Write time: 417904 06:18:51 INFO - TinderboxPrint: CPU usage
13.5% 06:18:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:18:51 INFO - TinderboxPrint: I/O write bytes / time
540,979,200 / 417,904 06:18:51 INFO - TinderboxPrint: CPU idle
8,215.0 (86.5%) 06:18:51 INFO - TinderboxPrint: CPU user
1,225.9 (12.9%) 06:18:51 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247799808; Read time: 0; Write time: 225032 06:18:51 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293179392; Read time: 12; Write time: 192872 06:18:52 INFO - Running post-run listener: _upload_blobber_files 06:18:52 INFO - Blob upload gear active. 06:18:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:52 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:56 INFO - (blobuploader) - INFO - Done attempting. 06:18:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:18:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:18:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:57 INFO - (blobuploader) - INFO - Done attempting. 06:18:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:18:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:18:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:58 INFO - (blobuploader) - INFO - Done attempting. 06:18:58 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:58 INFO - Return code: 0 06:18:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd9598504cb82cddabf84529b6bd40fcd02b467e84fcf62a12be6dd91038fa6afe956b9f488d4e01095778ccccd637bce9117bc922b92c177179013d5d9ca5a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff58e0c022a5f4b84a8ff1e73a7f367203e3ac5372dface4f3e30ce15900263e1b32535f8d98b6a764003740ac4a0c8b6db8e49557b407774afbe7761891a3c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09dc8cad8e38486bae25452dfe75d33a6c63bc281c7b857d9fb57182438813d6e7c4ae32f9702529e7dd562063caeadae901deb3eabcdd449f82c3ecb789e1d4"} 06:18:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:58 INFO - Contents: 06:18:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd9598504cb82cddabf84529b6bd40fcd02b467e84fcf62a12be6dd91038fa6afe956b9f488d4e01095778ccccd637bce9117bc922b92c177179013d5d9ca5a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff58e0c022a5f4b84a8ff1e73a7f367203e3ac5372dface4f3e30ce15900263e1b32535f8d98b6a764003740ac4a0c8b6db8e49557b407774afbe7761891a3c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09dc8cad8e38486bae25452dfe75d33a6c63bc281c7b857d9fb57182438813d6e7c4ae32f9702529e7dd562063caeadae901deb3eabcdd449f82c3ecb789e1d4"} 06:18:58 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:58 INFO - Copying logs to upload dir... 06:18:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.224443 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-02 06:18:58.205263) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 06:18:58.209320) ========= 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=1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769 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/bd9598504cb82cddabf84529b6bd40fcd02b467e84fcf62a12be6dd91038fa6afe956b9f488d4e01095778ccccd637bce9117bc922b92c177179013d5d9ca5a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff58e0c022a5f4b84a8ff1e73a7f367203e3ac5372dface4f3e30ce15900263e1b32535f8d98b6a764003740ac4a0c8b6db8e49557b407774afbe7761891a3c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09dc8cad8e38486bae25452dfe75d33a6c63bc281c7b857d9fb57182438813d6e7c4ae32f9702529e7dd562063caeadae901deb3eabcdd449f82c3ecb789e1d4"} build_url:https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/B_VRb1PLQjGHwNTwoQapMA/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/bd9598504cb82cddabf84529b6bd40fcd02b467e84fcf62a12be6dd91038fa6afe956b9f488d4e01095778ccccd637bce9117bc922b92c177179013d5d9ca5a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff58e0c022a5f4b84a8ff1e73a7f367203e3ac5372dface4f3e30ce15900263e1b32535f8d98b6a764003740ac4a0c8b6db8e49557b407774afbe7761891a3c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09dc8cad8e38486bae25452dfe75d33a6c63bc281c7b857d9fb57182438813d6e7c4ae32f9702529e7dd562063caeadae901deb3eabcdd449f82c3ecb789e1d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 06:18:58.237858) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:18:58.238378) ========= 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=1f5564757af27664ca02d71f000001b0-1464872303.15987-680434769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:18:58.320701) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 06:18:58.321010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 06:18:58.321296) ========= ========= Total master_lag: 0.18 =========