builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1464285094.76 results: success (0) buildid: 20160526101640 builduid: 53eb18a6aec343d78f29428ecea580c8 revision: 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:34.760095) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:34.760607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:34.760975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:34.778172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:34.778663) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 10:51:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 906K=0.01s 2016-05-26 10:51:35 (906 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174794 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:35.022013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:35.022339) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017043 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:35.052371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 10:51:35.052741) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 --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 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 10:51:35,646 truncating revision to first 12 chars 2016-05-26 10:51:35,646 Setting DEBUG logging. 2016-05-26 10:51:35,646 attempt 1/10 2016-05-26 10:51:35,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7b2fc29e5d9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 10:51:35,978 unpacking tar archive at: fx-team-7b2fc29e5d9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.074550 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 10:51:36.140917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:36.141278) ========= script_repo_revision: 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:36.142039) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:36.142375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 10:51:36.167815) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-05-26 10:51:36.168125) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:51:36 INFO - MultiFileLogger online at 20160526 10:51:36 in /builds/slave/test 10:51:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:51:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:51:36 INFO - {'append_to_log': False, 10:51:36 INFO - 'base_work_dir': '/builds/slave/test', 10:51:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:51:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:51:36 INFO - 'branch': 'Fx-Team-Non-PGO', 10:51:36 INFO - 'buildbot_json_path': 'buildprops.json', 10:51:36 INFO - 'config_files': ('talos/linux_config.py',), 10:51:36 INFO - 'default_actions': ('clobber', 10:51:36 INFO - 'read-buildbot-config', 10:51:36 INFO - 'download-and-extract', 10:51:36 INFO - 'populate-webroot', 10:51:36 INFO - 'create-virtualenv', 10:51:36 INFO - 'install', 10:51:36 INFO - 'run-tests'), 10:51:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:51:36 INFO - 'download_minidump_stackwalk': True, 10:51:36 INFO - 'download_symbols': 'ondemand', 10:51:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:51:36 INFO - 'tooltool.py': '/tools/tooltool.py', 10:51:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:51:36 INFO - '/tools/misc-python/virtualenv.py')}, 10:51:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:51:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:51:36 INFO - 'installer_path': 'installer.exe', 10:51:36 INFO - 'log_level': 'info', 10:51:36 INFO - 'log_name': 'talos', 10:51:36 INFO - 'log_to_console': True, 10:51:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:51:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:51:36 INFO - 'opt_config_files': (), 10:51:36 INFO - 'pip_index': False, 10:51:36 INFO - 'sps_profile': False, 10:51:36 INFO - 'sps_profile_interval': 0, 10:51:36 INFO - 'suite': 'dromaeojs', 10:51:36 INFO - 'system_bits': '32', 10:51:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:51:36 INFO - 'title': 'talos-linux64-ix-019', 10:51:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:51:36 INFO - 'use_talos_json': True, 10:51:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:51:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:51:36 INFO - 'work_dir': 'build'} 10:51:36 INFO - ##### 10:51:36 INFO - ##### Running clobber step. 10:51:36 INFO - ##### 10:51:36 INFO - Running pre-action listener: _resource_record_pre_action 10:51:36 INFO - Running main action method: clobber 10:51:36 INFO - rmtree: /builds/slave/test/build 10:51:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:51:37 INFO - Running post-action listener: _resource_record_post_action 10:51:37 INFO - ##### 10:51:37 INFO - ##### Finished clobber step (success) 10:51:37 INFO - ##### 10:51:37 INFO - ##### 10:51:37 INFO - ##### Running read-buildbot-config step. 10:51:37 INFO - ##### 10:51:37 INFO - Running pre-action listener: _resource_record_pre_action 10:51:37 INFO - Running main action method: read_buildbot_config 10:51:37 INFO - Using buildbot properties: 10:51:37 INFO - { 10:51:37 INFO - "project": "", 10:51:37 INFO - "product": "firefox", 10:51:37 INFO - "script_repo_revision": "production", 10:51:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:51:37 INFO - "repository": "", 10:51:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:51:37 INFO - "buildid": "20160526101640", 10:51:37 INFO - "pgo_build": "False", 10:51:37 INFO - "basedir": "/builds/slave/test", 10:51:37 INFO - "buildnumber": 1727, 10:51:37 INFO - "slavename": "talos-linux64-ix-019", 10:51:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:51:37 INFO - "platform": "ubuntu64_hw", 10:51:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:51:37 INFO - "branch": "fx-team", 10:51:37 INFO - "repo_path": "integration/fx-team", 10:51:37 INFO - "revision": "7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6", 10:51:37 INFO - "stage_platform": "linux64", 10:51:37 INFO - "builduid": "53eb18a6aec343d78f29428ecea580c8", 10:51:37 INFO - "slavebuilddir": "test" 10:51:37 INFO - } 10:51:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:51:37 INFO - Running post-action listener: _resource_record_post_action 10:51:37 INFO - ##### 10:51:37 INFO - ##### Finished read-buildbot-config step (success) 10:51:37 INFO - ##### 10:51:37 INFO - ##### 10:51:37 INFO - ##### Running download-and-extract step. 10:51:37 INFO - ##### 10:51:37 INFO - Running pre-action listener: _resource_record_pre_action 10:51:37 INFO - Running main action method: download_and_extract 10:51:37 INFO - mkdir: /builds/slave/test/build/tests 10:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:37 INFO - https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:51:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:51:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:51:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:51:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:51:44 INFO - Downloaded 1361 bytes. 10:51:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:51:44 INFO - Using the following test package requirements: 10:51:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:51:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:51:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:51:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:44 INFO - u'jsshell-linux-x86_64.zip'], 10:51:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:51:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:51:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:51:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:51:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:51:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:51:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:51: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')]} 10:51:44 INFO - https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:51:53 INFO - Downloaded 22835570 bytes. 10:51:53 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'] 10:51:53 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 10:51:54 INFO - Return code: 0 10:51:54 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 10:51: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')]} 10:51:54 INFO - https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:51:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:51:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:51:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:52:03 INFO - Downloaded 22835570 bytes. 10:52:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:52:05 INFO - Return code: 0 10:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:05 INFO - https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:52:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:52:07 INFO - Downloaded 10834034 bytes. 10:52:07 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'] 10:52:07 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 10:52:07 INFO - Return code: 0 10:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:07 INFO - https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:52:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:52:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:52:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dkD7dNa5SCyqcu-IoRgCsA/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 10:52:12 INFO - Downloaded 54829432 bytes. 10:52:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:52:12 INFO - mkdir: /builds/slave/test/properties 10:52:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:12 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:12 INFO - Contents: 10:52:12 INFO - build_url:https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:52:13 INFO - Running post-action listener: _resource_record_post_action 10:52:13 INFO - Running post-action listener: set_extra_try_arguments 10:52:13 INFO - ##### 10:52:13 INFO - ##### Finished download-and-extract step (success) 10:52:13 INFO - ##### 10:52:13 INFO - ##### 10:52:13 INFO - ##### Running populate-webroot step. 10:52:13 INFO - ##### 10:52:13 INFO - Running pre-action listener: _resource_record_pre_action 10:52:13 INFO - Running main action method: populate_webroot 10:52:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:13 INFO - '--tppagecycles', 10:52:13 INFO - '7'], 10:52:13 INFO - 'tests': ['tsvgm']}}, 10:52:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:52:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:13 INFO - 'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:13 INFO - 'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['damp', 'tps']}, 10:52:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:13 INFO - 'tests': ['damp', 'tps']}, 10:52:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['dromaeo_dom']}, 10:52:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['a11yr', 10:52:13 INFO - 'ts_paint', 10:52:13 INFO - 'tpaint', 10:52:13 INFO - 'sessionrestore', 10:52:13 INFO - 'sessionrestore_no_auto_restore', 10:52:13 INFO - 'tabpaint']}, 10:52:13 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:13 INFO - 'ts_paint', 10:52:13 INFO - 'tpaint', 10:52:13 INFO - 'sessionrestore', 10:52:13 INFO - 'sessionrestore_no_auto_restore', 10:52:13 INFO - 'tabpaint']}, 10:52:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:52:13 INFO - 'ts_paint', 10:52:13 INFO - 'tpaint', 10:52:13 INFO - 'sessionrestore', 10:52:13 INFO - 'sessionrestore_no_auto_restore', 10:52:13 INFO - 'tabpaint']}, 10:52:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:52:13 INFO - 'ts_paint', 10:52:13 INFO - 'tpaint', 10:52:13 INFO - 'sessionrestore', 10:52:13 INFO - 'sessionrestore_no_auto_restore', 10:52:13 INFO - 'tabpaint']}, 10:52:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['a11yr', 10:52:13 INFO - 'ts_paint', 10:52:13 INFO - 'tpaint', 10:52:13 INFO - 'sessionrestore', 10:52:13 INFO - 'sessionrestore_no_auto_restore', 10:52:13 INFO - 'tabpaint']}, 10:52:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['a11yr', 10:52:13 INFO - 'ts_paint', 10:52:13 INFO - 'tpaint', 10:52:13 INFO - 'sessionrestore', 10:52:13 INFO - 'sessionrestore_no_auto_restore', 10:52:13 INFO - 'tabpaint']}, 10:52:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['tsvgx', 10:52:13 INFO - 'tsvgr_opacity', 10:52:13 INFO - 'tart', 10:52:13 INFO - 'tscrollx', 10:52:13 INFO - 'cart']}, 10:52:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:13 INFO - 'tsvgr_opacity', 10:52:13 INFO - 'tart', 10:52:13 INFO - 'tscrollx', 10:52:13 INFO - 'cart']}, 10:52:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:13 INFO - 'talos_options': ['--disable-e10s'], 10:52:13 INFO - 'tests': ['tp5o']}, 10:52:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:13 INFO - 'tests': ['tp5o']}, 10:52:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:13 INFO - 'talos_options': ['--disable-e10s', 10:52:13 INFO - '--xperf_path', 10:52:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:13 INFO - 'tests': ['tp5n']}, 10:52:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:13 INFO - 'talos_options': ['--xperf_path', 10:52:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:13 INFO - 'tests': ['tp5n']}}, 10:52:13 INFO - 'talos.zip': {'path': '', 10:52:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:13 INFO - Running post-action listener: _resource_record_post_action 10:52:13 INFO - ##### 10:52:13 INFO - ##### Finished populate-webroot step (success) 10:52:13 INFO - ##### 10:52:13 INFO - ##### 10:52:13 INFO - ##### Running create-virtualenv step. 10:52:13 INFO - ##### 10:52:13 INFO - Running pre-action listener: _resource_record_pre_action 10:52:13 INFO - Running main action method: create_virtualenv 10:52:13 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:52:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:13 INFO - Using real prefix '/usr' 10:52:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:14 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:16 INFO - Installing pip.................done. 10:52:16 INFO - Return code: 0 10:52:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:16 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 0x7fad30412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2112770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:52:16 INFO - Using env: {'DISPLAY': ':0', 10:52:16 INFO - 'HOME': '/home/cltbld', 10:52:16 INFO - 'LANG': 'en_US.UTF-8', 10:52:16 INFO - 'LANGUAGE': 'en_US:en', 10:52:16 INFO - 'LOGNAME': 'cltbld', 10:52:16 INFO - 'MAIL': '/var/mail/cltbld', 10:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:16 INFO - 'MOZ_NO_REMOTE': '1', 10:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:16 INFO - 'NO_EM_RESTART': '1', 10:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:16 INFO - 'PWD': '/builds/slave/test', 10:52:16 INFO - 'SHELL': '/bin/bash', 10:52:16 INFO - 'SHLVL': '1', 10:52:16 INFO - 'TERM': 'linux', 10:52:16 INFO - 'TMOUT': '86400', 10:52:16 INFO - 'USER': 'cltbld', 10:52:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:16 INFO - '_': '/tools/buildbot/bin/python'} 10:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:52:16 INFO - Cleaning up... 10:52:16 INFO - Return code: 0 10:52:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:16 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 0x7fad30412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2112770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:16 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 10:52:16 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 10:52:16 INFO - Using env: {'DISPLAY': ':0', 10:52:16 INFO - 'HOME': '/home/cltbld', 10:52:16 INFO - 'LANG': 'en_US.UTF-8', 10:52:16 INFO - 'LANGUAGE': 'en_US:en', 10:52:16 INFO - 'LOGNAME': 'cltbld', 10:52:16 INFO - 'MAIL': '/var/mail/cltbld', 10:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:16 INFO - 'MOZ_NO_REMOTE': '1', 10:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:16 INFO - 'NO_EM_RESTART': '1', 10:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:16 INFO - 'PWD': '/builds/slave/test', 10:52:16 INFO - 'SHELL': '/bin/bash', 10:52:16 INFO - 'SHLVL': '1', 10:52:16 INFO - 'TERM': 'linux', 10:52:16 INFO - 'TMOUT': '86400', 10:52:16 INFO - 'USER': 'cltbld', 10:52:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:16 INFO - '_': '/tools/buildbot/bin/python'} 10:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:16 INFO - Downloading/unpacking psutil>=3.1.1 10:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:18 INFO - Installing collected packages: psutil 10:52:18 INFO - Running setup.py install for psutil 10:52:18 INFO - building 'psutil._psutil_linux' extension 10:52:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:52:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:52:18 INFO - building 'psutil._psutil_posix' extension 10:52:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:52:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:52:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:19 INFO - Successfully installed psutil 10:52:19 INFO - Cleaning up... 10:52:19 INFO - Return code: 0 10:52:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad30412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2112770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:52:19 INFO - Using env: {'DISPLAY': ':0', 10:52:19 INFO - 'HOME': '/home/cltbld', 10:52:19 INFO - 'LANG': 'en_US.UTF-8', 10:52:19 INFO - 'LANGUAGE': 'en_US:en', 10:52:19 INFO - 'LOGNAME': 'cltbld', 10:52:19 INFO - 'MAIL': '/var/mail/cltbld', 10:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:19 INFO - 'MOZ_NO_REMOTE': '1', 10:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:19 INFO - 'NO_EM_RESTART': '1', 10:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:19 INFO - 'PWD': '/builds/slave/test', 10:52:19 INFO - 'SHELL': '/bin/bash', 10:52:19 INFO - 'SHLVL': '1', 10:52:19 INFO - 'TERM': 'linux', 10:52:19 INFO - 'TMOUT': '86400', 10:52:19 INFO - 'USER': 'cltbld', 10:52:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:19 INFO - '_': '/tools/buildbot/bin/python'} 10:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:52:21 INFO - Installing collected packages: mozsystemmonitor 10:52:21 INFO - Running setup.py install for mozsystemmonitor 10:52:21 INFO - Successfully installed mozsystemmonitor 10:52:21 INFO - Cleaning up... 10:52:21 INFO - Return code: 0 10:52:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:21 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 0x7fad30412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2112770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:52:21 INFO - Using env: {'DISPLAY': ':0', 10:52:21 INFO - 'HOME': '/home/cltbld', 10:52:21 INFO - 'LANG': 'en_US.UTF-8', 10:52:21 INFO - 'LANGUAGE': 'en_US:en', 10:52:21 INFO - 'LOGNAME': 'cltbld', 10:52:21 INFO - 'MAIL': '/var/mail/cltbld', 10:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:21 INFO - 'MOZ_NO_REMOTE': '1', 10:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:21 INFO - 'NO_EM_RESTART': '1', 10:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:21 INFO - 'PWD': '/builds/slave/test', 10:52:21 INFO - 'SHELL': '/bin/bash', 10:52:21 INFO - 'SHLVL': '1', 10:52:21 INFO - 'TERM': 'linux', 10:52:21 INFO - 'TMOUT': '86400', 10:52:21 INFO - 'USER': 'cltbld', 10:52:21 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:21 INFO - '_': '/tools/buildbot/bin/python'} 10:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:21 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:23 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:24 INFO - Downloading docopt-0.6.1.tar.gz 10:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:24 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:24 INFO - Running setup.py install for blobuploader 10:52:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:24 INFO - Running setup.py install for requests 10:52:24 INFO - Running setup.py install for docopt 10:52:24 INFO - Successfully installed blobuploader requests docopt 10:52:24 INFO - Cleaning up... 10:52:24 INFO - Return code: 0 10:52:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:24 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 0x7fad30412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2112770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:24 INFO - Using env: {'DISPLAY': ':0', 10:52:24 INFO - 'HOME': '/home/cltbld', 10:52:24 INFO - 'LANG': 'en_US.UTF-8', 10:52:24 INFO - 'LANGUAGE': 'en_US:en', 10:52:24 INFO - 'LOGNAME': 'cltbld', 10:52:24 INFO - 'MAIL': '/var/mail/cltbld', 10:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:24 INFO - 'MOZ_NO_REMOTE': '1', 10:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:24 INFO - 'NO_EM_RESTART': '1', 10:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:24 INFO - 'PWD': '/builds/slave/test', 10:52:24 INFO - 'SHELL': '/bin/bash', 10:52:24 INFO - 'SHLVL': '1', 10:52:24 INFO - 'TERM': 'linux', 10:52:24 INFO - 'TMOUT': '86400', 10:52:24 INFO - 'USER': 'cltbld', 10:52:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:24 INFO - '_': '/tools/buildbot/bin/python'} 10:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:25 INFO - Running setup.py (path:/tmp/pip-aySexy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:25 INFO - Running setup.py (path:/tmp/pip-XUg3zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:25 INFO - Running setup.py (path:/tmp/pip-UjISow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:25 INFO - Running setup.py (path:/tmp/pip-Xr_TKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:25 INFO - Running setup.py (path:/tmp/pip-6ppY84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:25 INFO - Running setup.py (path:/tmp/pip-5fmAHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:25 INFO - Running setup.py (path:/tmp/pip-VYQFJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:25 INFO - Running setup.py (path:/tmp/pip-BFT1Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:25 INFO - Running setup.py (path:/tmp/pip-uLOwkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:25 INFO - Running setup.py (path:/tmp/pip-Q_vpx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:25 INFO - Running setup.py (path:/tmp/pip-pV1qSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:25 INFO - Running setup.py (path:/tmp/pip-lR89SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:26 INFO - Running setup.py (path:/tmp/pip-sn_QeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:26 INFO - Running setup.py (path:/tmp/pip-X9TjxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:26 INFO - Running setup.py (path:/tmp/pip-PyazL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:26 INFO - Running setup.py (path:/tmp/pip-K5MlxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:26 INFO - Running setup.py (path:/tmp/pip-V_tPEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:26 INFO - Running setup.py install for manifestparser 10:52:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:26 INFO - Running setup.py install for mozcrash 10:52:26 INFO - Running setup.py install for mozdebug 10:52:26 INFO - Running setup.py install for mozdevice 10:52:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:52:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:26 INFO - Running setup.py install for mozfile 10:52:26 INFO - Running setup.py install for mozhttpd 10:52:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Running setup.py install for mozinfo 10:52:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Running setup.py install for mozInstall 10:52:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Running setup.py install for mozleak 10:52:27 INFO - Running setup.py install for mozlog 10:52:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Running setup.py install for moznetwork 10:52:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Running setup.py install for mozprocess 10:52:27 INFO - Running setup.py install for mozprofile 10:52:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Running setup.py install for mozrunner 10:52:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:27 INFO - Running setup.py install for mozscreenshot 10:52:27 INFO - Running setup.py install for moztest 10:52:28 INFO - Running setup.py install for mozversion 10:52:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:28 INFO - Cleaning up... 10:52:28 INFO - Return code: 0 10:52:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:28 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 0x7fad30412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2112770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:28 INFO - Using env: {'DISPLAY': ':0', 10:52:28 INFO - 'HOME': '/home/cltbld', 10:52:28 INFO - 'LANG': 'en_US.UTF-8', 10:52:28 INFO - 'LANGUAGE': 'en_US:en', 10:52:28 INFO - 'LOGNAME': 'cltbld', 10:52:28 INFO - 'MAIL': '/var/mail/cltbld', 10:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:28 INFO - 'MOZ_NO_REMOTE': '1', 10:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:28 INFO - 'NO_EM_RESTART': '1', 10:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:28 INFO - 'PWD': '/builds/slave/test', 10:52:28 INFO - 'SHELL': '/bin/bash', 10:52:28 INFO - 'SHLVL': '1', 10:52:28 INFO - 'TERM': 'linux', 10:52:28 INFO - 'TMOUT': '86400', 10:52:28 INFO - 'USER': 'cltbld', 10:52:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:28 INFO - '_': '/tools/buildbot/bin/python'} 10:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:28 INFO - Running setup.py (path:/tmp/pip-WVmCPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:28 INFO - Running setup.py (path:/tmp/pip-y_bQAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:28 INFO - Running setup.py (path:/tmp/pip-4pul6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:28 INFO - Running setup.py (path:/tmp/pip-8PlKeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:28 INFO - Running setup.py (path:/tmp/pip-bBSAyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:28 INFO - Running setup.py (path:/tmp/pip-3ji2zX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:28 INFO - Running setup.py (path:/tmp/pip-IVyJsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:28 INFO - Running setup.py (path:/tmp/pip-gxwyd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:28 INFO - Running setup.py (path:/tmp/pip-zNkR5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:29 INFO - Running setup.py (path:/tmp/pip-hhDOdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:29 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)) 10:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:29 INFO - Running setup.py (path:/tmp/pip-vssTHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:29 INFO - Running setup.py (path:/tmp/pip-4aomgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:29 INFO - Running setup.py (path:/tmp/pip-3sq32I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:29 INFO - Running setup.py (path:/tmp/pip-_K1PgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:29 INFO - Running setup.py (path:/tmp/pip-VGgEbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:29 INFO - Running setup.py (path:/tmp/pip-jRfzWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:29 INFO - Running setup.py (path:/tmp/pip-5koox0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:31 INFO - Downloading blessings-1.6.tar.gz 10:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:31 INFO - Installing collected packages: blessings 10:52:31 INFO - Running setup.py install for blessings 10:52:31 INFO - Successfully installed blessings 10:52:31 INFO - Cleaning up... 10:52:31 INFO - Return code: 0 10:52:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:31 INFO - Reading from file tmpfile_stdout 10:52:31 INFO - Current package versions: 10:52:31 INFO - argparse == 1.2.1 10:52:31 INFO - blessings == 1.6 10:52:32 INFO - blobuploader == 1.2.4 10:52:32 INFO - docopt == 0.6.1 10:52:32 INFO - manifestparser == 1.1 10:52:32 INFO - mozInstall == 1.12 10:52:32 INFO - mozcrash == 0.17 10:52:32 INFO - mozdebug == 0.1 10:52:32 INFO - mozdevice == 0.48 10:52:32 INFO - mozfile == 1.2 10:52:32 INFO - mozhttpd == 0.7 10:52:32 INFO - mozinfo == 0.9 10:52:32 INFO - mozleak == 0.1 10:52:32 INFO - mozlog == 3.2 10:52:32 INFO - moznetwork == 0.27 10:52:32 INFO - mozprocess == 0.22 10:52:32 INFO - mozprofile == 0.28 10:52:32 INFO - mozrunner == 6.11 10:52:32 INFO - mozscreenshot == 0.1 10:52:32 INFO - mozsystemmonitor == 0.3 10:52:32 INFO - moztest == 0.7 10:52:32 INFO - mozversion == 1.4 10:52:32 INFO - psutil == 3.1.1 10:52:32 INFO - requests == 1.2.3 10:52:32 INFO - wsgiref == 0.1.2 10:52:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:32 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 0x7fad30412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2112770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:32 INFO - Using env: {'DISPLAY': ':0', 10:52:32 INFO - 'HOME': '/home/cltbld', 10:52:32 INFO - 'LANG': 'en_US.UTF-8', 10:52:32 INFO - 'LANGUAGE': 'en_US:en', 10:52:32 INFO - 'LOGNAME': 'cltbld', 10:52:32 INFO - 'MAIL': '/var/mail/cltbld', 10:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:32 INFO - 'MOZ_NO_REMOTE': '1', 10:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:32 INFO - 'NO_EM_RESTART': '1', 10:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:32 INFO - 'PWD': '/builds/slave/test', 10:52:32 INFO - 'SHELL': '/bin/bash', 10:52:32 INFO - 'SHLVL': '1', 10:52:32 INFO - 'TERM': 'linux', 10:52:32 INFO - 'TMOUT': '86400', 10:52:32 INFO - 'USER': 'cltbld', 10:52:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:32 INFO - '_': '/tools/buildbot/bin/python'} 10:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:32 INFO - Cleaning up... 10:52:32 INFO - Return code: 0 10:52:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:32 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 0x7fad30412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2112770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:52:32 INFO - Using env: {'DISPLAY': ':0', 10:52:32 INFO - 'HOME': '/home/cltbld', 10:52:32 INFO - 'LANG': 'en_US.UTF-8', 10:52:32 INFO - 'LANGUAGE': 'en_US:en', 10:52:32 INFO - 'LOGNAME': 'cltbld', 10:52:32 INFO - 'MAIL': '/var/mail/cltbld', 10:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:32 INFO - 'MOZ_NO_REMOTE': '1', 10:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:32 INFO - 'NO_EM_RESTART': '1', 10:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:32 INFO - 'PWD': '/builds/slave/test', 10:52:32 INFO - 'SHELL': '/bin/bash', 10:52:32 INFO - 'SHLVL': '1', 10:52:32 INFO - 'TERM': 'linux', 10:52:32 INFO - 'TMOUT': '86400', 10:52:32 INFO - 'USER': 'cltbld', 10:52:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:32 INFO - '_': '/tools/buildbot/bin/python'} 10:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:32 INFO - Downloading/unpacking jsonschema 10:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:34 INFO - Downloading/unpacking functools32 (from jsonschema) 10:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:34 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:34 INFO - warning: no files found matching '*.txt' 10:52:34 INFO - no previously-included directories found matching 'build' 10:52:34 INFO - no previously-included directories found matching 'dist' 10:52:34 INFO - no previously-included directories found matching '.git*' 10:52:34 INFO - Installing collected packages: jsonschema, functools32 10:52:34 INFO - Running setup.py install for functools32 10:52:34 INFO - warning: no files found matching '*.txt' 10:52:34 INFO - no previously-included directories found matching 'build' 10:52:34 INFO - no previously-included directories found matching 'dist' 10:52:34 INFO - no previously-included directories found matching '.git*' 10:52:34 INFO - Successfully installed jsonschema functools32 10:52:34 INFO - Cleaning up... 10:52:34 INFO - Return code: 0 10:52:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:34 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 0x7fad30412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2112770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:52:34 INFO - Using env: {'DISPLAY': ':0', 10:52:34 INFO - 'HOME': '/home/cltbld', 10:52:34 INFO - 'LANG': 'en_US.UTF-8', 10:52:34 INFO - 'LANGUAGE': 'en_US:en', 10:52:34 INFO - 'LOGNAME': 'cltbld', 10:52:34 INFO - 'MAIL': '/var/mail/cltbld', 10:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:34 INFO - 'MOZ_NO_REMOTE': '1', 10:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:34 INFO - 'NO_EM_RESTART': '1', 10:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:34 INFO - 'PWD': '/builds/slave/test', 10:52:34 INFO - 'SHELL': '/bin/bash', 10:52:34 INFO - 'SHLVL': '1', 10:52:34 INFO - 'TERM': 'linux', 10:52:34 INFO - 'TMOUT': '86400', 10:52:34 INFO - 'USER': 'cltbld', 10:52:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:34 INFO - '_': '/tools/buildbot/bin/python'} 10:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:35 INFO - Downloading/unpacking flake8 10:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:52:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:52:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:52:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:37 INFO - no previously-included directories found matching 'docs/_build' 10:52:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:52:37 INFO - Running setup.py install for pep8 10:52:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:37 INFO - no previously-included directories found matching 'docs/_build' 10:52:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:52:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:52:37 INFO - Cleaning up... 10:52:37 INFO - Return code: 0 10:52:37 INFO - Running post-action listener: _resource_record_post_action 10:52:37 INFO - Running post-action listener: _start_resource_monitoring 10:52:37 INFO - Starting resource monitoring. 10:52:37 INFO - ##### 10:52:37 INFO - ##### Finished create-virtualenv step (success) 10:52:37 INFO - ##### 10:52:37 INFO - ##### 10:52:37 INFO - ##### Running install step. 10:52:37 INFO - ##### 10:52:37 INFO - Running pre-action listener: _resource_record_pre_action 10:52:37 INFO - Running main action method: install 10:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:38 INFO - Reading from file tmpfile_stdout 10:52:38 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:38 INFO - Reading from file tmpfile_stdout 10:52:38 INFO - Output received: 10:52:38 INFO - Usage: mozinstall [options] installer 10:52:38 INFO - Options: 10:52:38 INFO - -h, --help show this help message and exit 10:52:38 INFO - -d DEST, --destination=DEST 10:52:38 INFO - Directory to install application into. [default: 10:52:38 INFO - "/builds/slave/test"] 10:52:38 INFO - --app=APP Application being installed. [default: firefox] 10:52:38 INFO - mkdir: /builds/slave/test/build/application 10:52:38 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'] 10:52:38 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 10:52:54 INFO - Reading from file tmpfile_stdout 10:52:54 INFO - Output received: 10:52:54 INFO - /builds/slave/test/build/application/firefox/firefox 10:52:54 INFO - Running post-action listener: _resource_record_post_action 10:52:54 INFO - ##### 10:52:54 INFO - ##### Finished install step (success) 10:52:54 INFO - ##### 10:52:54 INFO - ##### 10:52:54 INFO - ##### Running run-tests step. 10:52:54 INFO - ##### 10:52:54 INFO - Running pre-action listener: _resource_record_pre_action 10:52:54 INFO - Running main action method: run_tests 10:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:54 INFO - Python 2.7.3 10:52:54 INFO - Return code: 0 10:52:54 INFO - grabbing minidump binary from tooltool 10:52: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')]} 10:52:54 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 0x21a19c0>, '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 0x21a28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:52:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:52:54 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 10:52:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:54 INFO - Return code: 0 10:52:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:52:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:52:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:52:55 INFO - Return code: 0 10:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:52:55 INFO - Using env: {'DISPLAY': ':0', 10:52:55 INFO - 'HOME': '/home/cltbld', 10:52:55 INFO - 'LANG': 'en_US.UTF-8', 10:52:55 INFO - 'LANGUAGE': 'en_US:en', 10:52:55 INFO - 'LOGNAME': 'cltbld', 10:52:55 INFO - 'MAIL': '/var/mail/cltbld', 10:52:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:55 INFO - 'MOZ_NO_REMOTE': '1', 10:52:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:55 INFO - 'NO_EM_RESTART': '1', 10:52:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:55 INFO - 'PWD': '/builds/slave/test', 10:52:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:55 INFO - 'SHELL': '/bin/bash', 10:52:55 INFO - 'SHLVL': '1', 10:52:55 INFO - 'TERM': 'linux', 10:52:55 INFO - 'TMOUT': '86400', 10:52:55 INFO - 'USER': 'cltbld', 10:52:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142', 10:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:55 INFO - '_': '/tools/buildbot/bin/python'} 10:52:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:52:55 INFO - mozversion application_buildid: 20160526101640 10:52:55 INFO - mozversion application_changeset: 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 10:52:55 INFO - mozversion application_display_name: Nightly 10:52:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:55 INFO - mozversion application_name: Firefox 10:52:55 INFO - mozversion application_remotingname: firefox 10:52:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:52:55 INFO - mozversion application_vendor: Mozilla 10:52:55 INFO - mozversion application_version: 49.0a1 10:52:55 INFO - mozversion platform_buildid: 20160526101640 10:52:55 INFO - mozversion platform_changeset: 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 10:52:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:52:55 INFO - mozversion platform_version: 49.0a1 10:52:55 INFO - using testdate: 1464285175 10:52:55 INFO - actual date: 1464285175 10:52:55 INFO - starting webserver on 'localhost:37267' 10:52:55 INFO - SUITE-START | Running 2 tests 10:52:55 INFO - TEST-START | dromaeo_css 10:52:55 INFO - operating with platform_type : linux_ 10:52:55 INFO - Initialising browser for dromaeo_css test... 10:52:55 INFO - TEST-INFO | started process 15688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUcs4k1/profile http://localhost:37267/getInfo.html) 10:52:59 INFO - PROCESS | 15688 | __metrics Screen width/height:1600/1200 10:52:59 INFO - PROCESS | 15688 | colorDepth:24 10:52:59 INFO - PROCESS | 15688 | Browser inner width/height: 1024/697 10:52:59 INFO - PROCESS | 15688 | __metrics 10:53:00 ERROR - PROCESS | 15688 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:53:01 INFO - TEST-INFO | 15688: exit 0 10:53:01 INFO - Browser initialized. 10:53:01 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:01 INFO - TEST-INFO | started process 15768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUcs4k1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:13 INFO - PROCESS | 15768 | RSS: Main: 156377088 10:53:13 INFO - PROCESS | 15768 | 10:54:05 INFO - PROCESS | 15768 | 1464285245386 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:56:17 INFO - PROCESS | 15768 | Cycle 1(1): loaded http://localhost:37267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37267/tests/dromaeo/cssquery-ext.html) 10:56:18 INFO - PROCESS | 15768 | RSS: Main: 232849408 10:56:18 INFO - PROCESS | 15768 | 10:59:20 INFO - PROCESS | 15768 | Cycle 1(1): loaded http://localhost:37267/tests/dromaeo/cssquery-ext.html (next: http://localhost:37267/tests/dromaeo/cssquery-jquery.html) 10:59:21 INFO - PROCESS | 15768 | RSS: Main: 240590848 10:59:21 INFO - PROCESS | 15768 | 11:02:23 INFO - PROCESS | 15768 | Cycle 1(1): loaded http://localhost:37267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37267/tests/dromaeo/cssquery-mootools.html) 11:02:24 INFO - PROCESS | 15768 | RSS: Main: 239853568 11:02:24 INFO - PROCESS | 15768 | 11:05:26 INFO - PROCESS | 15768 | Cycle 1(1): loaded http://localhost:37267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37267/tests/dromaeo/cssquery-prototype.html) 11:05:27 INFO - PROCESS | 15768 | RSS: Main: 239890432 11:05:27 INFO - PROCESS | 15768 | 11:08:30 INFO - PROCESS | 15768 | Cycle 1(1): loaded http://localhost:37267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37267/tests/dromaeo/cssquery-yui.html) 11:08:30 INFO - PROCESS | 15768 | RSS: Main: 210886656 11:08:30 INFO - PROCESS | 15768 | 11:11:33 INFO - PROCESS | 15768 | Cycle 1(1): loaded http://localhost:37267/tests/dromaeo/cssquery-yui.html (next: http://localhost:37267/tests/dromaeo/cssquery-dojo.html) 11:11:33 INFO - PROCESS | 15768 | RSS: Main: 271876096 11:11:33 INFO - PROCESS | 15768 | 11:11:33 INFO - PROCESS | 15768 | __start_tp_report 11:11:33 INFO - PROCESS | 15768 | _x_x_mozilla_page_load 11:11:33 INFO - PROCESS | 15768 | _x_x_mozilla_page_load_details 11:11:33 INFO - PROCESS | 15768 | |i|pagename|runs| 11:11:33 INFO - PROCESS | 15768 | |0;dojo.html;2686.194141757473;2699.838009719416;2719.892083635183;2725.7274272572745;2757.9862100689493;4671.346011558385;4749.857504274869;4764.285357196422;4858.295547145666;4880.951190488094;4722.622190224783;4736.076465089301;4760.5239476052375;4794.856154315376;4801.183798754211;4312.417823593814;4402.7358358498595;4408.360787685784;4439.889002774924;4576.244919588264;4502.212112880249;4528.864134075967;4532.342810292505;4552.112338094073;4595.241785105471;4297.892552686177;4349.891252718676;4351.390805287262;4356.215881141393;4434.866953991385;4380.5838445347645;4383.8684839454545;4395.208862404766;4403.691741578091;4426.933595996063;4399.428074350346;4401.713888597263;4409.779511024468;4429.291313389842;4444.911101777979;4553.704009239389;4640.95359046412;4694.81220751173;4708.599769019604;4818.469968303484;5107.157319042353;5167.302414174113;5179.067767801795;5183.637145399824;5190;5125.359330083739;5184.818531351422;5191.6625419348;5207.0887594670785;5210.609204309692;4669.906601867943;4742.620590352763;4780.80876764929;4790.856274311776;4806.062817750575;5346.224797404355;5366.248725178478;5366.6243362964215;5368.382635996911;5371.113766228606;5130.204818253177;5142.61430392722;5145.665531740425;5150.175971844487;5154.974225128851;4984.651074424828;5068.265101560253;5117.437081920985;5126.6923984561045;5143.537081662668;5046.066477701637;5076.289319495274;5085.160948443466;5090.898182036339;5139.100657384943;4959.355283813081;5053.67151135175;5069.6451248413;5071.87320316995;5074.264231686385;4361.890952726208;4382.802773875183;4398.296272596369;4408.625266852289;4419.602235798793;3802.4106263529197;3821.7515861468914;3829.100161462054;3869.8839034829;3875.8643447479203;4309.461317335333;4413.196859783352;4414.9558504414545;4466;4471.8658440246845;5036.949630503721;5104.412992505835;5125.1287281162295;5193.68837869729;5199.376074870964;4425.601695847389;4442.355858400579;4445.666575006888;4446.599806017474;4473.038296766211;4539.886502837456;4649.883752906137;4685.835995740201;4691.437027556715;4728.834490792806;4835.6131509478455;4862.930155365814;4881.170201065898;4882.804687812448;4930.876728081683;5177.145770947902;5212.348456442945;5217.452167522356;5224.869378265574;5266.420693723764;4692.202325604587;4728.479867214535;4839.782209800638;4865.489123642108;4867.172580661367;4987.10232158215;5018.84943451697;5027.673201241908;5053.620978426559;5086.0845047891735;5105.030044291572;5118;5123.180291153398;5128.205128205134;5166.689998600096;4861.6596838220985;4869.488703686062;4889.657723959289;4908.680935739166;4940.950590494049;4906.215005599087;4910.803567857246;4936.481669424658;4952.331435256195;4957.529034741694;4831.4685384608365;4844.370231869834;4892.046051020017;4911.705297682151;4920.434150072644;4838.637102217418;5007.524285192901;5024.171011783015;5045.192769156917;5076.466970967996;4976.353074100489;4994.825181118644;5003.54968052877;5003.899922001612;5066.214736715815 11:11:33 INFO - PROCESS | 15768 | |1;ext.html;550.4880461171109;596.8209537138857;601.7472661482177;602.3554796367886;608.1728848765679;38953.610463895355;39587.80206098973;40320;40458;40481;37413.625863741356;42133.733283339585;42162.578374216246;42169.789151054276;42269.78865105678;7400.740974065909;7811.726589569366;8030.638621262057;8048.074471435772;10060;9796.167325777318;10303.48482575872;10305;10308.278420510567;10312.432816195143;10273.280870339042;10345;10354.689359319233;10355.844662330072;10358.378497290149;10260.589576416935;10320.79358412835;10325.58697652093;10329.793404131875;10333.58665653373;10132.088112069949;10259.487025648688;10262.435566043865;10263.79472410555;10272.486375681186;38774;38985.22029559393;39173.216535669126;39228.21543569141;39235;3038.1341317724564;3119.734822540087;3234.3854667613314;3325.7671962962604;3731.440283957401;29296.121116366543;29568.26079348012;29581.852090739623;29823.25441863949;30410;3195.3289809139874;3245.6592057833823;3252.8373581321075;3350.5760051977813;3351.4805205193234;268704;270728;271313;271775;272126.63936680387;55715.16427253594;55804.44195558074;56276;56315;56329;59726;59796;59830.40169598335;59850.70074649599;59919.700401497714;13857.930710346585;14045.929770351082;14049.367778449994;14058;14059;8536.786580335542;10002.49987500622;10424.061834434937;10433.478326083665;10601.522931468102;17995.190216440293;18420.81579184218;18914.148863301183;19025.714614280798;19261.422157335302;6717.731290748413;7015.789526314219;7052.823679407953;7101.82245443868;7119.71521139159;849.9235068843834;872.4634349874781;879.824035192964;921.5991043895926;984.5963155106372;26517.46965060688;28052.579211311848;28258.85870570634;28417.147485575464;28480.71519284822;900.8513595256841;931.2875650127658;931.380631879806;942.5475771629519;997.6308765756717;14944.402223910922;15079.095254284777;15168.620784480256;15261.465848695243;15410.460633877761;387745;392463;398976;399117.0794628497;599619;50643.74678126586;51044;51158.23262651063;51238.48761512412;51485.48514514807;1118.5078565431184;1204.2894692131683;1204.5543149034913;1210.7215340471564;1230.390956476532;24497.725218363885;28318.433631326847;28649.713502864706;28782.424351513273;28937.42125157443;42473.78763106165;42755.35866961936;43047.354289685056;43126.568734312255;43129.56870431256;311254;312257;313366;314330;314345;22243.332700019026;24294.392640184138;25173.24480265595;25335.36661583475;25648.48703025892;41394.79302603468;41401.1719765609;42010;42267;42381.576184239;35591;35811;36200.81899590591;36479.635203647624;36766.63233367632;35270.47094293639;35369.469457958665;35455;35480.645193548764;36118.63881361153;35364.823175883954;35583.46624800682;35794.64205358017;35911.82044089763;36934;32321;33687.326253474304;33705.325893482484;33777.822187804646;33939.321213576084;25716.614250786628;25756.742432576182;25782.226533204033;25928.351791205372;26390.472190556466 11:11:33 INFO - PROCESS | 15768 | |2;jquery.html;368.75846320659963;370.1505045919614;370.88502564205083;385.91509867829075;398.95810939851316;15890.364385424584;16920.57698557535;17009.74485382717;17176.312947482118;17187.91406042971;15709.450169244079;16088.356465741386;17133.400330988417;17171.570710732205;17177.398791042317;5010.423801262856;5125.820596279131;5132.255822905677;5187.922181167267;5188.688678679272;3752.9061773455746;3914.745541539805;5080.263361812535;5587.329520457531;5872.530197584204;5998.25021872266;6001.099835024759;6010.699465026753;6019.969900150515;6028.788992385267;5802.82591522255;5848.824535263949;5927.051671732545;5936.6734829584575;5976.760929562813;3393.490976353542;4862.610991120702;5170.45710200431;5170.97414512925;5197.66215196011;19492.610147797106;20009.8999505003;20179;20381.286654967153;20434.386968390972;1951.9947227178016;2006.6889632107047;2021.6563184258712;2048.9180432782673;2076.7404074490687;12829;12922;12982.545610903668;13039.41322640474;13537.255450950193;1757.903315317657;1788.5260405992422;1794.6410717856481;1820.954476138094;1864.8787828791085;40078.799606002074;40569.1886162278;51312;64636;65759.67120164368;9243.815123697488;9300.162985331353;9406.905930940604;9572.76068098303;9786.217102631772;13165.736685266433;13271;13273.269970151541;13278.136921100098;13316;7012.228654847962;7059.752908648173;7067.469939754539;7285.089363829521;7292.088488938883;6752.426043786333;6836.726530938707;6925.168979722465;6953.721851126;6963.09479767627;5965.164876917235;6089.939100608937;6099.719058997572;6123.632582045091;6145.96927015371;1620.627255731165;1708.8205738397537;1736.574539237895;1741.4862615528195;1751.833575810296;732.9926700732924;826.5123577089546;846.8899043124354;892.808046270055;968.6561270748923;16089.839101609068;16341.428050018192;16581.91709041447;16758.916205418896;17044.659106818042;796.2515235678444;816.6284340625001;826.4627991805254;864.394923553515;875.65411662393;9397.107274808883;9690.51547422626;9732.270079744048;9738.90261097394;9866.703998880044;352039;364564;386258;390786;391110;63829.36170638234;64958.675206623666;65095.67452162709;65154.674226628566;65359.67320163369;882.8896387951506;893.5353616119581;911.7264820553808;913.4291068082448;963.393062370702;14850.40598376053;15118.395264189308;15227.923860380628;15279.345513390457;15342.232888355315;26319.86840065864;27504.724952750217;31069.689303107585;31249.8437507811;33033;39743.60256397399;40170.39744403895;40319.79840100781;40833.79583102065;40835.79582102071;7003.684834182576;7059.470539709439;7077.256888026683;7335.835928401241;7511.887321690069;10821.9458902705;10916.617918372818;11048.779024419628;11153.832692509457;11268.323900565993;9117.36178467501;9124.863127052966;9347.906520934976;9351.859722104038;9756.317057805885;9339.159475646953;9408.76478088026;9521;9673.564689588844;9851.507424628884;8438.789030274293;9233.445993240428;9581.520923953634;9596.9040309596;9638.759031024281;7316.414686825147;7357.2642735726;7418.96290518544;7506.849863002819;7612.391008719178;8191.549464779494;8890.64437422496;9032.683856065007;9200.585973631336;9436.669716559887 11:11:33 INFO - PROCESS | 15768 | |3;mootools.html;1145.7651181507792;1430.3992323224245;1460.364741337518;1532.6551525906666;1759.067694122115;6888.20785609655;7799.688012479501;8017.118117007125;8022.3582113431;8231.341492680585;7877.842443151134;8095.797605059876;8104.3921705872;8108;8112.391570632197;1837.604914943287;2071.9171233150655;2178.215842296772;2185.366243789299;2214.269291133922;2151.8278537716947;2194.0565556810566;2198.274569392097;2198.582269368823;2199.1533259694975;2154.644483660194;2175.5213852952406;2185.650295952648;2186.967195492069;2191.057845126595;1803.3417802502058;1859.9349022784272;2054.239931225456;2113.5455876986366;2126.723525941625;2116.968245476319;2136.75427325858;2141.2184552638173;2142.3680014395636;2142.882141482218;7899.684012639487;7941.523508589503;7947.443678942476;7955.363570914313;7956;4535.863924082283;4692.835750748707;4693.6010439112715;4695.483496815347;4698.459677137139;2815.1132393296252;2865.982576185445;3021.078571035833;3050.8932187373334;3052.6336839579394;985.6550207427415;991.6777047459533;992.2012779712401;998.7802683409639;1011.9949400253025;10965.56137754489;11139.164562657752;11172.329660220414;11176.664700059093;11210.607628732956;4259.829606815692;4282.250606143974;4374.737515749065;4401.559844015573;4409.933850992237;9391.389559678599;9408.341416100944;9431.717048488556;9437.716868493957;9438.716838494856;4678.672492925462;4682.765861706901;4683.95316046842;4689.273162659793;4690.366800481891;3536.6993805526304;4156.4388807510595;4319.503257125408;4324.221640104812;4391.231534481453;3790.981045094757;3832.1186127190904;3893.1045859452483;3920.666743326792;3951.940720889189;1211.3277131192096;1218.2507757728933;1219.268438936631;1229.674136353867;1240.1257113734796;620.652434636605;697.8046147078826;723.598402886403;724.1491247783833;729.1032030602389;4860.902781944341;4977;5005.324281221989;5042.294078828967;5087.058894104529;424.8576726796496;895.1898531828706;906.1796694526197;908.8364094462928;909.2998391238709;3282.40916635008;3331.3337332533592;3331.450310698756;3380.8816691416173;3389.9491507627404;9501.667441639509;9638.710838674851;9754.268429867789;9763.511824408894;9777.462239576891;9636.084571965652;9708.223342132613;9710.223182145412;9734.756631084138;9739.366941148803;7489.400847932152;7509.399248060142;7545.660445279976;7586;7638.618069096523;4856.417229932431;4895.951040489549;4902.509749025212;4956.10790057793;4973.47778483254;9067.319951003834;9167.679131230376;9240.584173712065;9342.065793420603;9370.765730856783;9372.765680858032;9419.670311539063;9446.38598491096;9477.052294770469;9502.239820814457;5543.695096769717;6289.496840252677;6484.254310754135;6509.804705858832;6623.138991931018;7529.88705169412;7574.166841647304;7597.886031709419;7631.198724133886;7639.388848892187;6613.272540020497;6739;6785.966070169815;6793.150856142982;6850.520463567503;6885.173779146535;6895.586264824126;6981.232064473005;7016.824579385556;7059.223485416703;6258.624482531062;6303.117563541016;6312.968435157794;6324.146240257506;6429.9678501607195;4146.813393397365;4260.488741351058;4325.24308246062;4399.934000990052;4411.691181617256;4262.275413179705;4334.848280310174;4369.584889435499;4417.469903611587;4467.30756732707 11:11:33 INFO - PROCESS | 15768 | |4;prototype.html;301.1312363830349;307.15072823642635;307.6385247334382;309.4939773470378;313.68788055884386;4836.879078023051;4858.24697171938;4872.7076375417455;4918.778654960526;4946.950530494694;4788.114198873211;4840.903181936368;4856.6357523185725;4863.294822250771;4875.804967801284;3576.910577235577;3702.1670124222105;3768.453574231735;3794.4498047783054;3844.2503711776217;3787.507624008875;3822.75152115113;3827.6363745444137;3834.8466061357512;3857.209272099227;3794.5067141271734;3811.942820857689;3812.8856134316015;3816.0459885028745;3818.6754125899333;3600.3339382214376;3628.818559072049;3693.8364415209394;3741.906452338686;3772.622992607706;3306.454435018219;3330.3672302262494;3334.3831391192707;3337.766356355056;3338.4825352070466;4606;4612.700174488681;4628.490866004737;4630.699004564726;4674.158651442739;4214.831406743727;4277.786110694484;4283.91432171358;4301;4338.58783415575;5031.22016087507;5085.644004919657;5108.106081435771;5112.284280200738;5120.308758317654;3623.3477973964677;3628.2743451309843;3630.1287690954246;3637.0907273181706;3640.6177351378255;5206.869828254324;5221.877296381258;5308.52223299901;5334.946650533484;5347.812826551052;3673.559172899269;3676.852925882988;3684.5578530576504;3688.483612294281;3697.75964562308;3742.214135031619;3745.5879853216125;3747.138158223624;3751.7748935063983;3753.8310776015146;4241.34259189826;4264.658827293809;4270.50889147752;4296.400677590075;4298.634616057608;4809.44691360498;5097.898042039213;5114.207297868837;5115.7953681852305;5121.667091639106;1261.892739117167;1275.7576060548465;1283.666246775845;1287.1440492072854;1289.1040726695044;802.8233788566506;820.971266005687;836.8576892541759;844.8817165596821;851.5401683091185;4435.26818075014;4444.177827101997;4445.5776701213335;4458.821647134143;4580.541945805459;5211.895762084737;5232.843014709565;5259.4477579853565;5266.499682530153;5285.392179899284;4328.156009578165;4523.95476045242;4527.320901864681;4540.070470050216;4563.657725670588;2762.516559602102;2788.2053614719707;2793.399419124898;2800.9579856301766;2808.8595570221405;4927.743425426494;4936.234883593049;4937.802487900443;4955.4301255356095;4981.302617633534;5124.7950081996305;5342.2253773202665;5357.973210133924;5365.382980957162;5374.435684253097;4888.780004899859;4899.387576552931;4931.619146638946;4936.407631084293;4938.654294199371;5216.304700972123;5216.347956505437;5232.4505926878655;5255.973720131375;5266.762995665281;5003.299538064601;5132.384113906355;5157.484251574812;5162.535371816554;5167.509086636764;4885.609151267819;4909.386326709161;4938.975305123451;4950.861301900511;4966.602671786321;3651.64888991075;3665.87169449068;3674.3202507536193;3675.9816200918826;3685.70514358856;4981.427135879276;5190.351206099238;5259.921716048278;5303.310569625924;5305.204219367126;5006.849794506171;5026.3214466048075;5028;5048.485454363749;5059.721715305546;5029.390595009561;5035.345405097314;5047.697138171721;5065.974670126626;5073.644844860824;4744.78648460827;5002.149634562206;5009.674371165863;5017.974910125426;5037.571806396498;4881.219004959189;4959.900801984012;5080.695158290514;5099.719515426687;5108.846734597968;5019.347484826949;5025.793809485624;5026.095302845523;5030.9245361320345;5035.899282014412 11:11:33 INFO - PROCESS | 15768 | |5;yui.html;646.9385408386202;683.9760608378708;690.1683471416943;716.4805516000897;729.5476804381284;11939.76120477591;12685.794849489295;12811.935940320285;12822.230666160038;12844.871551284485;12548;12641;12645;12658.493660253602;12690.175138615983;645.7675236914707;786.1038416205502;809.1423091523004;822.8313195794848;823.3413269384498;818.1613845808035;822.6380392627254;823.0658202939646;823.3372135430976;823.4400607586839;838.4801423117675;846.2003406780594;847.5550336073549;848.4315508609216;849;668.2682462703332;836.1137194573711;841.4614646626164;843.9915600843974;861.8750281209252;627.7928283666379;628.0485065126337;628.1049504456178;628.1833616298793;628.7893555658814;12453.75092498154;12457.875421245762;12491;12497.687557811036;12540.498380064877;11623.651290461215;11878.287302761775;12012.159148859584;12034.81947770784;12363.676220748626;10861.837072443841;10921.836172457419;10938.289011214245;11017.889821101766;11029.503672334764;3957.327254366736;4010.4786377770993;4027.252834692654;4066.044479547304;4111.691623128248;44381;44877.32684009743;44890.32664510035;44913.775431122966;45060.549394505964;9712.55008142906;9995.400275983464;10028.197744180448;10117.747056323651;10444.529996150191;17328.268218729227;18120.728189077174;18176.727349089775;18376.54058648518;18378.63242735138;6581.967090164519;6682.799516014527;6695.263521012685;6748.325167483213;6831.2144103428745;3753.7935413551972;3766.642168993941;3796.6393192646656;3805.7335986481235;3830;2754.132448278786;2842.8294302341924;2847.985760071186;2850.586664933573;2851.3584443500044;491.31216297184227;502.813958835226;510.10476613542994;511.02649452791746;516.4422423782306;447.8745951133688;459.11391015340047;462.3180808307719;465.2114665641705;474.95250474952917;6685.665716714145;6794.4904132189295;6854.074699915547;6884.586924784529;6887.5178737487895;420.7811937792331;433.3261777935278;447.17496219475015;465.54841803450597;478.9736564488917;3232.7090561849077;3266.1997810536573;3354.8993530194134;3431.5367425397753;3454.4818277258614;59141;61483.69258153681;61600;61618;61667.38332616706;44394.33408498875;46178.307325390146;48358.27462588064;50641;50737.74631126821;45870.77064614656;45893;46452.767736161106;46758.53241467542;47532;7669.8466030677955;7870.331021862977;7891.802704932193;8068.556229407204;8130.918690813016;31765.36469270648;31801.8409907949;32191.51712724264;32315.838420807744;32344.35311293808;37861.43207851939;41655.37516937309;41758.791206043774;42125.578744212165;42268.577314227696;10179.796404072025;10249.180065594883;10587;10590.682279531318;10813.189010824062;11825;11840.467178977138;11991;12369.257844529357;12486.377860649001;9086.63653453881;9728.124468797841;9922.206223502248;10019.348742331726;10234;11527.942360288145;11655.417229138679;12037.518499260283;12042.096842736655;12227.388630568257;9901.55443005052;10185.032421919906;10286.794264114826;10380.792384152426;10474.423906685206;9267.258619310574;9460.905390946002;9723.562439690373;10334.793304133726;10484.528196231035;8603.09667484905;8787.736367908972;8815.294776417742;9066.909330906607;9088.182063614306 11:11:33 INFO - PROCESS | 15768 | __end_tp_report 11:11:33 INFO - PROCESS | 15768 | __start_cc_report 11:11:33 INFO - PROCESS | 15768 | _x_x_mozilla_cycle_collect,1092 11:11:33 INFO - PROCESS | 15768 | __end_cc_report 11:11:33 INFO - PROCESS | 15768 | __startTimestamp1464286293861__endTimestamp 11:11:33 INFO - PROCESS | 15768 | 11:11:33 INFO - PROCESS | 15768 | ------- Summary: start ------- 11:11:33 INFO - PROCESS | 15768 | Number of tests: 6 11:11:33 INFO - PROCESS | 15768 | 11:11:33 INFO - PROCESS | 15768 | [#0] dojo.html Cycles:165 Average:4745.17 Median:4862.93 stddev:491.50 (10.1%) stddev-sans-first:465.71 11:11:33 INFO - PROCESS | 15768 | Values: 2686.2 2699.8 2719.9 2725.7 2758.0 4671.3 4749.9 4764.3 4858.3 4881.0 4722.6 4736.1 4760.5 4794.9 4801.2 4312.4 4402.7 4408.4 4439.9 4576.2 4502.2 4528.9 4532.3 4552.1 4595.2 4297.9 4349.9 4351.4 4356.2 4434.9 4380.6 4383.9 4395.2 4403.7 4426.9 4399.4 4401.7 4409.8 4429.3 4444.9 4553.7 4641.0 4694.8 4708.6 4818.5 5107.2 5167.3 5179.1 5183.6 5190.0 5125.4 5184.8 5191.7 5207.1 5210.6 4669.9 4742.6 4780.8 4790.9 4806.1 5346.2 5366.2 5366.6 5368.4 5371.1 5130.2 5142.6 5145.7 5150.2 5155.0 4984.7 5068.3 5117.4 5126.7 5143.5 5046.1 5076.3 5085.2 5090.9 5139.1 4959.4 5053.7 5069.6 5071.9 5074.3 4361.9 4382.8 4398.3 4408.6 4419.6 3802.4 3821.8 3829.1 3869.9 3875.9 4309.5 4413.2 4415.0 4466.0 4471.9 5036.9 5104.4 5125.1 5193.7 5199.4 4425.6 4442.4 4445.7 4446.6 4473.0 4539.9 4649.9 4685.8 4691.4 4728.8 4835.6 4862.9 4881.2 4882.8 4930.9 5177.1 5212.3 5217.5 5224.9 5266.4 4692.2 4728.5 4839.8 4865.5 4867.2 4987.1 5018.8 5027.7 5053.6 5086.1 5105.0 5118.0 5123.2 5128.2 5166.7 4861.7 4869.5 4889.7 4908.7 4941.0 4906.2 4910.8 4936.5 4952.3 4957.5 4831.5 4844.4 4892.0 4911.7 4920.4 4838.6 5007.5 5024.2 5045.2 5076.5 4976.4 4994.8 5003.5 5003.9 5066.2 11:11:33 INFO - PROCESS | 15768 | 11:11:33 INFO - PROCESS | 15768 | [#1] ext.html Cycles:180 Average:49813.20 Median:33741.57 stddev:92528.30 (274.2%) stddev-sans-first:92713.94 11:11:33 INFO - PROCESS | 15768 | Values: 550.5 596.8 601.7 602.4 608.2 38953.6 39587.8 40320.0 40458.0 40481.0 37413.6 42133.7 42162.6 42169.8 42269.8 7400.7 7811.7 8030.6 8048.1 10060.0 9796.2 10303.5 10305.0 10308.3 10312.4 10273.3 10345.0 10354.7 10355.8 10358.4 10260.6 10320.8 10325.6 10329.8 10333.6 10132.1 10259.5 10262.4 10263.8 10272.5 38774.0 38985.2 39173.2 39228.2 39235.0 3038.1 3119.7 3234.4 3325.8 3731.4 29296.1 29568.3 29581.9 29823.3 30410.0 3195.3 3245.7 3252.8 3350.6 3351.5 268704.0 270728.0 271313.0 271775.0 272126.6 55715.2 55804.4 56276.0 56315.0 56329.0 59726.0 59796.0 59830.4 59850.7 59919.7 13857.9 14045.9 14049.4 14058.0 14059.0 8536.8 10002.5 10424.1 10433.5 10601.5 17995.2 18420.8 18914.1 19025.7 19261.4 6717.7 7015.8 7052.8 7101.8 7119.7 849.9 872.5 879.8 921.6 984.6 26517.5 28052.6 28258.9 28417.1 28480.7 900.9 931.3 931.4 942.5 997.6 14944.4 15079.1 15168.6 15261.5 15410.5 387745.0 392463.0 398976.0 399117.1 599619.0 50643.7 51044.0 51158.2 51238.5 51485.5 1118.5 1204.3 1204.6 1210.7 1230.4 24497.7 28318.4 28649.7 28782.4 28937.4 42473.8 42755.4 43047.4 43126.6 43129.6 311254.0 312257.0 313366.0 314330.0 314345.0 22243.3 24294.4 25173.2 25335.4 25648.5 41394.8 41401.2 42010.0 42267.0 42381.6 35591.0 35811.0 36200.8 36479.6 36766.6 35270.5 35369.5 35455.0 35480.6 36118.6 35364.8 35583.5 35794.6 35911.8 36934.0 32321.0 33687.3 33705.3 33777.8 33939.3 25716.6 25756.7 25782.2 25928.4 26390.5 11:11:33 INFO - PROCESS | 15768 | 11:11:33 INFO - PROCESS | 15768 | [#2] jquery.html Cycles:180 Average:22594.73 Median:5392.50 stddev:61736.05 (1144.9%) stddev-sans-first:61886.68 11:11:33 INFO - PROCESS | 15768 | Values: 368.8 370.2 370.9 385.9 399.0 15890.4 16920.6 17009.7 17176.3 17187.9 15709.5 16088.4 17133.4 17171.6 17177.4 5010.4 5125.8 5132.3 5187.9 5188.7 3752.9 3914.7 5080.3 5587.3 5872.5 5998.3 6001.1 6010.7 6020.0 6028.8 5802.8 5848.8 5927.1 5936.7 5976.8 3393.5 4862.6 5170.5 5171.0 5197.7 19492.6 20009.9 20179.0 20381.3 20434.4 1952.0 2006.7 2021.7 2048.9 2076.7 12829.0 12922.0 12982.5 13039.4 13537.3 1757.9 1788.5 1794.6 1821.0 1864.9 40078.8 40569.2 51312.0 64636.0 65759.7 9243.8 9300.2 9406.9 9572.8 9786.2 13165.7 13271.0 13273.3 13278.1 13316.0 7012.2 7059.8 7067.5 7285.1 7292.1 6752.4 6836.7 6925.2 6953.7 6963.1 5965.2 6089.9 6099.7 6123.6 6146.0 1620.6 1708.8 1736.6 1741.5 1751.8 733.0 826.5 846.9 892.8 968.7 16089.8 16341.4 16581.9 16758.9 17044.7 796.3 816.6 826.5 864.4 875.7 9397.1 9690.5 9732.3 9738.9 9866.7 352039.0 364564.0 386258.0 390786.0 391110.0 63829.4 64958.7 65095.7 65154.7 65359.7 882.9 893.5 911.7 913.4 963.4 14850.4 15118.4 15227.9 15279.3 15342.2 26319.9 27504.7 31069.7 31249.8 33033.0 39743.6 40170.4 40319.8 40833.8 40835.8 7003.7 7059.5 7077.3 7335.8 7511.9 10821.9 10916.6 11048.8 11153.8 11268.3 9117.4 9124.9 9347.9 9351.9 9756.3 9339.2 9408.8 9521.0 9673.6 9851.5 8438.8 9233.4 9581.5 9596.9 9638.8 7316.4 7357.3 7419.0 7506.8 7612.4 8191.5 8890.6 9032.7 9200.6 9436.7 11:11:33 INFO - PROCESS | 15768 | 11:11:33 INFO - PROCESS | 15768 | [#3] mootools.html Cycles:180 Average:5175.17 Median:4929.31 stddev:2984.14 (60.5%) stddev-sans-first:2977.15 11:11:33 INFO - PROCESS | 15768 | Values: 1145.8 1430.4 1460.4 1532.7 1759.1 6888.2 7799.7 8017.1 8022.4 8231.3 7877.8 8095.8 8104.4 8108.0 8112.4 1837.6 2071.9 2178.2 2185.4 2214.3 2151.8 2194.1 2198.3 2198.6 2199.2 2154.6 2175.5 2185.7 2187.0 2191.1 1803.3 1859.9 2054.2 2113.5 2126.7 2117.0 2136.8 2141.2 2142.4 2142.9 7899.7 7941.5 7947.4 7955.4 7956.0 4535.9 4692.8 4693.6 4695.5 4698.5 2815.1 2866.0 3021.1 3050.9 3052.6 985.7 991.7 992.2 998.8 1012.0 10965.6 11139.2 11172.3 11176.7 11210.6 4259.8 4282.3 4374.7 4401.6 4409.9 9391.4 9408.3 9431.7 9437.7 9438.7 4678.7 4682.8 4684.0 4689.3 4690.4 3536.7 4156.4 4319.5 4324.2 4391.2 3791.0 3832.1 3893.1 3920.7 3951.9 1211.3 1218.3 1219.3 1229.7 1240.1 620.7 697.8 723.6 724.1 729.1 4860.9 4977.0 5005.3 5042.3 5087.1 424.9 895.2 906.2 908.8 909.3 3282.4 3331.3 3331.5 3380.9 3389.9 9501.7 9638.7 9754.3 9763.5 9777.5 9636.1 9708.2 9710.2 9734.8 9739.4 7489.4 7509.4 7545.7 7586.0 7638.6 4856.4 4896.0 4902.5 4956.1 4973.5 9067.3 9167.7 9240.6 9342.1 9370.8 9372.8 9419.7 9446.4 9477.1 9502.2 5543.7 6289.5 6484.3 6509.8 6623.1 7529.9 7574.2 7597.9 7631.2 7639.4 6613.3 6739.0 6786.0 6793.2 6850.5 6885.2 6895.6 6981.2 7016.8 7059.2 6258.6 6303.1 6313.0 6324.1 6430.0 4146.8 4260.5 4325.2 4399.9 4411.7 4262.3 4334.8 4369.6 4417.5 4467.3 11:11:33 INFO - PROCESS | 15768 | 11:11:33 INFO - PROCESS | 15768 | [#4] prototype.html Cycles:180 Average:4213.44 Median:4857.44 stddev:1227.19 (25.3%) stddev-sans-first:1194.99 11:11:33 INFO - PROCESS | 15768 | Values: 301.1 307.2 307.6 309.5 313.7 4836.9 4858.2 4872.7 4918.8 4947.0 4788.1 4840.9 4856.6 4863.3 4875.8 3576.9 3702.2 3768.5 3794.4 3844.3 3787.5 3822.8 3827.6 3834.8 3857.2 3794.5 3811.9 3812.9 3816.0 3818.7 3600.3 3628.8 3693.8 3741.9 3772.6 3306.5 3330.4 3334.4 3337.8 3338.5 4606.0 4612.7 4628.5 4630.7 4674.2 4214.8 4277.8 4283.9 4301.0 4338.6 5031.2 5085.6 5108.1 5112.3 5120.3 3623.3 3628.3 3630.1 3637.1 3640.6 5206.9 5221.9 5308.5 5334.9 5347.8 3673.6 3676.9 3684.6 3688.5 3697.8 3742.2 3745.6 3747.1 3751.8 3753.8 4241.3 4264.7 4270.5 4296.4 4298.6 4809.4 5097.9 5114.2 5115.8 5121.7 1261.9 1275.8 1283.7 1287.1 1289.1 802.8 821.0 836.9 844.9 851.5 4435.3 4444.2 4445.6 4458.8 4580.5 5211.9 5232.8 5259.4 5266.5 5285.4 4328.2 4524.0 4527.3 4540.1 4563.7 2762.5 2788.2 2793.4 2801.0 2808.9 4927.7 4936.2 4937.8 4955.4 4981.3 5124.8 5342.2 5358.0 5365.4 5374.4 4888.8 4899.4 4931.6 4936.4 4938.7 5216.3 5216.3 5232.5 5256.0 5266.8 5003.3 5132.4 5157.5 5162.5 5167.5 4885.6 4909.4 4939.0 4950.9 4966.6 3651.6 3665.9 3674.3 3676.0 3685.7 4981.4 5190.4 5259.9 5303.3 5305.2 5006.8 5026.3 5028.0 5048.5 5059.7 5029.4 5035.3 5047.7 5066.0 5073.6 4744.8 5002.1 5009.7 5018.0 5037.6 4881.2 4959.9 5080.7 5099.7 5108.8 5019.3 5025.8 5026.1 5030.9 5035.9 11:11:33 INFO - PROCESS | 15768 | 11:11:33 INFO - PROCESS | 15768 | [#5] yui.html Cycles:180 Average:13256.47 Median:447.52 stddev:15652.52 (3497.6%) stddev-sans-first:15667.78 11:11:33 INFO - PROCESS | 15768 | Values: 646.9 684.0 690.2 716.5 729.5 11939.8 12685.8 12811.9 12822.2 12844.9 12548.0 12641.0 12645.0 12658.5 12690.2 645.8 786.1 809.1 822.8 823.3 818.2 822.6 823.1 823.3 823.4 838.5 846.2 847.6 848.4 849.0 668.3 836.1 841.5 844.0 861.9 627.8 628.0 628.1 628.2 628.8 12453.8 12457.9 12491.0 12497.7 12540.5 11623.7 11878.3 12012.2 12034.8 12363.7 10861.8 10921.8 10938.3 11017.9 11029.5 3957.3 4010.5 4027.3 4066.0 4111.7 44381.0 44877.3 44890.3 44913.8 45060.5 9712.6 9995.4 10028.2 10117.7 10444.5 17328.3 18120.7 18176.7 18376.5 18378.6 6582.0 6682.8 6695.3 6748.3 6831.2 3753.8 3766.6 3796.6 3805.7 3830.0 2754.1 2842.8 2848.0 2850.6 2851.4 491.3 502.8 510.1 511.0 516.4 447.9 459.1 462.3 465.2 475.0 6685.7 6794.5 6854.1 6884.6 6887.5 420.8 433.3 447.2 465.5 479.0 3232.7 3266.2 3354.9 3431.5 3454.5 59141.0 61483.7 61600.0 61618.0 61667.4 44394.3 46178.3 48358.3 50641.0 50737.7 45870.8 45893.0 46452.8 46758.5 47532.0 7669.8 7870.3 7891.8 8068.6 8130.9 31765.4 31801.8 32191.5 32315.8 32344.4 37861.4 41655.4 41758.8 42125.6 42268.6 10179.8 10249.2 10587.0 10590.7 10813.2 11825.0 11840.5 11991.0 12369.3 12486.4 9086.6 9728.1 9922.2 10019.3 10234.0 11527.9 11655.4 12037.5 12042.1 12227.4 9901.6 10185.0 10286.8 10380.8 10474.4 9267.3 9460.9 9723.6 10334.8 10484.5 8603.1 8787.7 8815.3 9066.9 9088.2 11:11:33 INFO - PROCESS | 15768 | -------- Summary: end -------- 11:11:33 INFO - PROCESS | 15768 | 11:11:34 INFO - TEST-INFO | 15768: exit 0 11:11:34 INFO - TEST-OK | dromaeo_css | took 1119365ms 11:11:34 INFO - TEST-START | kraken 11:11:34 INFO - operating with platform_type : linux_ 11:11:34 INFO - Initialising browser for kraken test... 11:11:34 INFO - TEST-INFO | started process 15946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT0vSdM/profile http://localhost:37267/getInfo.html) 11:11:39 INFO - PROCESS | 15946 | __metrics Screen width/height:1600/1200 11:11:39 INFO - PROCESS | 15946 | colorDepth:24 11:11:39 INFO - PROCESS | 15946 | Browser inner width/height: 1024/697 11:11:39 INFO - PROCESS | 15946 | __metrics 11:11:40 ERROR - PROCESS | 15946 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:11:41 INFO - TEST-INFO | 15946: exit 0 11:11:41 INFO - Browser initialized. 11:11:41 INFO - Running cycle 1/1 for kraken test... 11:11:41 INFO - TEST-INFO | started process 16027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT0vSdM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:52 INFO - PROCESS | 16027 | RSS: Main: 156733440 11:11:53 INFO - PROCESS | 16027 | 11:11:55 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37267/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:56 INFO - PROCESS | 16027 | RSS: Main: 211955712 11:11:56 INFO - PROCESS | 16027 | 11:11:59 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37267/tests/kraken/driver.html?testName=audio-dft) 11:12:00 INFO - PROCESS | 16027 | RSS: Main: 200298496 11:12:00 INFO - PROCESS | 16027 | 11:12:03 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37267/tests/kraken/driver.html?testName=audio-fft) 11:12:03 INFO - PROCESS | 16027 | RSS: Main: 269225984 11:12:03 INFO - PROCESS | 16027 | 11:12:06 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37267/tests/kraken/driver.html?testName=audio-oscillator) 11:12:06 INFO - PROCESS | 16027 | RSS: Main: 178896896 11:12:06 INFO - PROCESS | 16027 | 11:12:08 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:09 INFO - PROCESS | 16027 | RSS: Main: 182837248 11:12:09 INFO - PROCESS | 16027 | 11:12:12 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37267/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:13 INFO - PROCESS | 16027 | RSS: Main: 218288128 11:12:13 INFO - PROCESS | 16027 | 11:12:16 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37267/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:17 INFO - PROCESS | 16027 | RSS: Main: 219807744 11:12:17 INFO - PROCESS | 16027 | 11:12:20 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37267/tests/kraken/driver.html?testName=json-parse-financial) 11:12:20 INFO - PROCESS | 16027 | RSS: Main: 219676672 11:12:20 INFO - PROCESS | 16027 | 11:12:22 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:23 INFO - PROCESS | 16027 | RSS: Main: 206581760 11:12:23 INFO - PROCESS | 16027 | 11:12:25 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37267/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:25 INFO - PROCESS | 16027 | RSS: Main: 211030016 11:12:25 INFO - PROCESS | 16027 | 11:12:27 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:28 INFO - PROCESS | 16027 | RSS: Main: 222777344 11:12:28 INFO - PROCESS | 16027 | 11:12:31 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:31 INFO - PROCESS | 16027 | RSS: Main: 226529280 11:12:31 INFO - PROCESS | 16027 | 11:12:34 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:35 INFO - PROCESS | 16027 | RSS: Main: 222285824 11:12:35 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | Cycle 1(1): loaded http://localhost:37267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37267/tests/kraken/driver.html?testName=ai-astar) 11:12:37 INFO - PROCESS | 16027 | RSS: Main: 267689984 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | __start_tp_report 11:12:37 INFO - PROCESS | 16027 | _x_x_mozilla_page_load 11:12:37 INFO - PROCESS | 16027 | _x_x_mozilla_page_load_details 11:12:37 INFO - PROCESS | 16027 | |i|pagename|runs| 11:12:37 INFO - PROCESS | 16027 | |0;ai-astar;115;109;114;114;113;113;113;113;114;113 11:12:37 INFO - PROCESS | 16027 | |1;audio-beat-detection;158;133;131;185;133;134;164;129;169;129 11:12:37 INFO - PROCESS | 16027 | |2;audio-dft;162;165;161;169;162;162;164;163;162;161 11:12:37 INFO - PROCESS | 16027 | |3;audio-fft;77;75;74;120;76;77;76;75;115;75 11:12:37 INFO - PROCESS | 16027 | |4;audio-oscillator;84;86;124;84;85;85;120;84;84;123 11:12:37 INFO - PROCESS | 16027 | |5;imaging-gaussian-blur;117;117;117;117;118;116;117;117;116;117 11:12:37 INFO - PROCESS | 16027 | |6;imaging-darkroom;146;147;146;146;146;146;146;147;147;146 11:12:37 INFO - PROCESS | 16027 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;94;95 11:12:37 INFO - PROCESS | 16027 | |8;json-parse-financial;66;65;66;65;66;66;66;92;63;64 11:12:37 INFO - PROCESS | 16027 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;65;65 11:12:37 INFO - PROCESS | 16027 | |10;stanford-crypto-aes;81;82;82;81;83;84;90;89;84;82 11:12:37 INFO - PROCESS | 16027 | |11;stanford-crypto-ccm;139;130;141;139;141;130;135;125;167;130 11:12:37 INFO - PROCESS | 16027 | |12;stanford-crypto-pbkdf2;176;173;169;174;169;171;174;170;176;184 11:12:37 INFO - PROCESS | 16027 | |13;stanford-crypto-sha256-iterative;68;67;69;71;68;66;66;65;66;66 11:12:37 INFO - PROCESS | 16027 | __end_tp_report 11:12:37 INFO - PROCESS | 16027 | __start_cc_report 11:12:37 INFO - PROCESS | 16027 | _x_x_mozilla_cycle_collect,1883 11:12:37 INFO - PROCESS | 16027 | __end_cc_report 11:12:37 INFO - PROCESS | 16027 | __startTimestamp1464286357451__endTimestamp 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | ------- Summary: start ------- 11:12:37 INFO - PROCESS | 16027 | Number of tests: 14 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:1.60 (1.4%) stddev-sans-first:1.54 11:12:37 INFO - PROCESS | 16027 | Values: 115.0 109.0 114.0 114.0 113.0 113.0 113.0 113.0 114.0 113.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:146.00 stddev:20.55 (14.1%) stddev-sans-first:21.37 11:12:37 INFO - PROCESS | 16027 | Values: 158.0 133.0 131.0 185.0 133.0 134.0 164.0 129.0 169.0 129.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:2.42 (1.5%) stddev-sans-first:2.54 11:12:37 INFO - PROCESS | 16027 | Values: 162.0 165.0 161.0 169.0 162.0 162.0 164.0 163.0 162.0 161.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.50 stddev:17.72 (23.5%) stddev-sans-first:18.61 11:12:37 INFO - PROCESS | 16027 | Values: 77.0 75.0 74.0 120.0 76.0 77.0 76.0 75.0 115.0 75.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:84.00 stddev:18.28 (21.8%) stddev-sans-first:18.87 11:12:37 INFO - PROCESS | 16027 | Values: 84.0 86.0 124.0 84.0 85.0 85.0 120.0 84.0 84.0 123.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:12:37 INFO - PROCESS | 16027 | Values: 117.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 116.0 117.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:12:37 INFO - PROCESS | 16027 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:12:37 INFO - PROCESS | 16027 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:66.00 stddev:8.53 (12.9%) stddev-sans-first:9.02 11:12:37 INFO - PROCESS | 16027 | Values: 66.0 65.0 66.0 65.0 66.0 66.0 66.0 92.0 63.0 64.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:12:37 INFO - PROCESS | 16027 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:3.19 (3.8%) stddev-sans-first:3.22 11:12:37 INFO - PROCESS | 16027 | Values: 81.0 82.0 82.0 81.0 83.0 84.0 90.0 89.0 84.0 82.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:139.00 stddev:11.69 (8.4%) stddev-sans-first:12.39 11:12:37 INFO - PROCESS | 16027 | Values: 139.0 130.0 141.0 139.0 141.0 130.0 135.0 125.0 167.0 130.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:4.50 (2.6%) stddev-sans-first:4.69 11:12:37 INFO - PROCESS | 16027 | Values: 176.0 173.0 169.0 174.0 169.0 171.0 174.0 170.0 176.0 184.0 11:12:37 INFO - PROCESS | 16027 | 11:12:37 INFO - PROCESS | 16027 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.81 (2.7%) stddev-sans-first:1.90 11:12:37 INFO - PROCESS | 16027 | Values: 68.0 67.0 69.0 71.0 68.0 66.0 66.0 65.0 66.0 66.0 11:12:37 INFO - PROCESS | 16027 | -------- Summary: end -------- 11:12:37 INFO - PROCESS | 16027 | 11:12:38 INFO - TEST-INFO | 16027: exit 0 11:12:38 INFO - TEST-OK | kraken | took 63886ms 11:12:38 INFO - SUITE-END | took 1183s 11:12:38 INFO - Completed test suite (00:19:43) 11:12:38 INFO - javascript benchmark 11:12:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.194141757473, 2699.838009719416, 2719.892083635183, 2725.7274272572745, 2757.9862100689493, 4671.346011558385, 4749.857504274869, 4764.285357196422, 4858.295547145666, 4880.951190488094, 4722.622190224783, 4736.076465089301, 4760.5239476052375, 4794.856154315376, 4801.183798754211, 4312.417823593814, 4402.7358358498595, 4408.360787685784, 4439.889002774924, 4576.244919588264, 4502.212112880249, 4528.864134075967, 4532.342810292505, 4552.112338094073, 4595.241785105471, 4297.892552686177, 4349.891252718676, 4351.390805287262, 4356.215881141393, 4434.866953991385, 4380.5838445347645, 4383.8684839454545, 4395.208862404766, 4403.691741578091, 4426.933595996063, 4399.428074350346, 4401.713888597263, 4409.779511024468, 4429.291313389842, 4444.911101777979, 4553.704009239389, 4640.95359046412, 4694.81220751173, 4708.599769019604, 4818.469968303484, 5107.157319042353, 5167.302414174113, 5179.067767801795, 5183.637145399824, 5190.0, 5125.359330083739, 5184.818531351422, 5191.6625419348, 5207.0887594670785, 5210.609204309692, 4669.906601867943, 4742.620590352763, 4780.80876764929, 4790.856274311776, 4806.062817750575, 5346.224797404355, 5366.248725178478, 5366.6243362964215, 5368.382635996911, 5371.113766228606, 5130.204818253177, 5142.61430392722, 5145.665531740425, 5150.175971844487, 5154.974225128851, 4984.651074424828, 5068.265101560253, 5117.437081920985, 5126.6923984561045, 5143.537081662668, 5046.066477701637, 5076.289319495274, 5085.160948443466, 5090.898182036339, 5139.100657384943, 4959.355283813081, 5053.67151135175, 5069.6451248413, 5071.87320316995, 5074.264231686385, 4361.890952726208, 4382.802773875183, 4398.296272596369, 4408.625266852289, 4419.602235798793, 3802.4106263529197, 3821.7515861468914, 3829.100161462054, 3869.8839034829, 3875.8643447479203, 4309.461317335333, 4413.196859783352, 4414.9558504414545, 4466.0, 4471.8658440246845, 5036.949630503721, 5104.412992505835, 5125.1287281162295, 5193.68837869729, 5199.376074870964, 4425.601695847389, 4442.355858400579, 4445.666575006888, 4446.599806017474, 4473.038296766211, 4539.886502837456, 4649.883752906137, 4685.835995740201, 4691.437027556715, 4728.834490792806, 4835.6131509478455, 4862.930155365814, 4881.170201065898, 4882.804687812448, 4930.876728081683, 5177.145770947902, 5212.348456442945, 5217.452167522356, 5224.869378265574, 5266.420693723764, 4692.202325604587, 4728.479867214535, 4839.782209800638, 4865.489123642108, 4867.172580661367, 4987.10232158215, 5018.84943451697, 5027.673201241908, 5053.620978426559, 5086.0845047891735, 5105.030044291572, 5118.0, 5123.180291153398, 5128.205128205134, 5166.689998600096, 4861.6596838220985, 4869.488703686062, 4889.657723959289, 4908.680935739166, 4940.950590494049, 4906.215005599087, 4910.803567857246, 4936.481669424658, 4952.331435256195, 4957.529034741694, 4831.4685384608365, 4844.370231869834, 4892.046051020017, 4911.705297682151, 4920.434150072644, 4838.637102217418, 5007.524285192901, 5024.171011783015, 5045.192769156917, 5076.466970967996, 4976.353074100489, 4994.825181118644, 5003.54968052877, 5003.899922001612, 5066.214736715815], "value": 4714.455007227054, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4880461171109, 596.8209537138857, 601.7472661482177, 602.3554796367886, 608.1728848765679, 38953.610463895355, 39587.80206098973, 40320.0, 40458.0, 40481.0, 37413.625863741356, 42133.733283339585, 42162.578374216246, 42169.789151054276, 42269.78865105678, 7400.740974065909, 7811.726589569366, 8030.638621262057, 8048.074471435772, 10060.0, 9796.167325777318, 10303.48482575872, 10305.0, 10308.278420510567, 10312.432816195143, 10273.280870339042, 10345.0, 10354.689359319233, 10355.844662330072, 10358.378497290149, 10260.589576416935, 10320.79358412835, 10325.58697652093, 10329.793404131875, 10333.58665653373, 10132.088112069949, 10259.487025648688, 10262.435566043865, 10263.79472410555, 10272.486375681186, 38774.0, 38985.22029559393, 39173.216535669126, 39228.21543569141, 39235.0, 3038.1341317724564, 3119.734822540087, 3234.3854667613314, 3325.7671962962604, 3731.440283957401, 29296.121116366543, 29568.26079348012, 29581.852090739623, 29823.25441863949, 30410.0, 3195.3289809139874, 3245.6592057833823, 3252.8373581321075, 3350.5760051977813, 3351.4805205193234, 268704.0, 270728.0, 271313.0, 271775.0, 272126.63936680387, 55715.16427253594, 55804.44195558074, 56276.0, 56315.0, 56329.0, 59726.0, 59796.0, 59830.40169598335, 59850.70074649599, 59919.700401497714, 13857.930710346585, 14045.929770351082, 14049.367778449994, 14058.0, 14059.0, 8536.786580335542, 10002.49987500622, 10424.061834434937, 10433.478326083665, 10601.522931468102, 17995.190216440293, 18420.81579184218, 18914.148863301183, 19025.714614280798, 19261.422157335302, 6717.731290748413, 7015.789526314219, 7052.823679407953, 7101.82245443868, 7119.71521139159, 849.9235068843834, 872.4634349874781, 879.824035192964, 921.5991043895926, 984.5963155106372, 26517.46965060688, 28052.579211311848, 28258.85870570634, 28417.147485575464, 28480.71519284822, 900.8513595256841, 931.2875650127658, 931.380631879806, 942.5475771629519, 997.6308765756717, 14944.402223910922, 15079.095254284777, 15168.620784480256, 15261.465848695243, 15410.460633877761, 387745.0, 392463.0, 398976.0, 399117.0794628497, 599619.0, 50643.74678126586, 51044.0, 51158.23262651063, 51238.48761512412, 51485.48514514807, 1118.5078565431184, 1204.2894692131683, 1204.5543149034913, 1210.7215340471564, 1230.390956476532, 24497.725218363885, 28318.433631326847, 28649.713502864706, 28782.424351513273, 28937.42125157443, 42473.78763106165, 42755.35866961936, 43047.354289685056, 43126.568734312255, 43129.56870431256, 311254.0, 312257.0, 313366.0, 314330.0, 314345.0, 22243.332700019026, 24294.392640184138, 25173.24480265595, 25335.36661583475, 25648.48703025892, 41394.79302603468, 41401.1719765609, 42010.0, 42267.0, 42381.576184239, 35591.0, 35811.0, 36200.81899590591, 36479.635203647624, 36766.63233367632, 35270.47094293639, 35369.469457958665, 35455.0, 35480.645193548764, 36118.63881361153, 35364.823175883954, 35583.46624800682, 35794.64205358017, 35911.82044089763, 36934.0, 32321.0, 33687.326253474304, 33705.325893482484, 33777.822187804646, 33939.321213576084, 25716.614250786628, 25756.742432576182, 25782.226533204033, 25928.351791205372, 26390.472190556466], "value": 18295.587537211166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.75846320659963, 370.1505045919614, 370.88502564205083, 385.91509867829075, 398.95810939851316, 15890.364385424584, 16920.57698557535, 17009.74485382717, 17176.312947482118, 17187.91406042971, 15709.450169244079, 16088.356465741386, 17133.400330988417, 17171.570710732205, 17177.398791042317, 5010.423801262856, 5125.820596279131, 5132.255822905677, 5187.922181167267, 5188.688678679272, 3752.9061773455746, 3914.745541539805, 5080.263361812535, 5587.329520457531, 5872.530197584204, 5998.25021872266, 6001.099835024759, 6010.699465026753, 6019.969900150515, 6028.788992385267, 5802.82591522255, 5848.824535263949, 5927.051671732545, 5936.6734829584575, 5976.760929562813, 3393.490976353542, 4862.610991120702, 5170.45710200431, 5170.97414512925, 5197.66215196011, 19492.610147797106, 20009.8999505003, 20179.0, 20381.286654967153, 20434.386968390972, 1951.9947227178016, 2006.6889632107047, 2021.6563184258712, 2048.9180432782673, 2076.7404074490687, 12829.0, 12922.0, 12982.545610903668, 13039.41322640474, 13537.255450950193, 1757.903315317657, 1788.5260405992422, 1794.6410717856481, 1820.954476138094, 1864.8787828791085, 40078.799606002074, 40569.1886162278, 51312.0, 64636.0, 65759.67120164368, 9243.815123697488, 9300.162985331353, 9406.905930940604, 9572.76068098303, 9786.217102631772, 13165.736685266433, 13271.0, 13273.269970151541, 13278.136921100098, 13316.0, 7012.228654847962, 7059.752908648173, 7067.469939754539, 7285.089363829521, 7292.088488938883, 6752.426043786333, 6836.726530938707, 6925.168979722465, 6953.721851126, 6963.09479767627, 5965.164876917235, 6089.939100608937, 6099.719058997572, 6123.632582045091, 6145.96927015371, 1620.627255731165, 1708.8205738397537, 1736.574539237895, 1741.4862615528195, 1751.833575810296, 732.9926700732924, 826.5123577089546, 846.8899043124354, 892.808046270055, 968.6561270748923, 16089.839101609068, 16341.428050018192, 16581.91709041447, 16758.916205418896, 17044.659106818042, 796.2515235678444, 816.6284340625001, 826.4627991805254, 864.394923553515, 875.65411662393, 9397.107274808883, 9690.51547422626, 9732.270079744048, 9738.90261097394, 9866.703998880044, 352039.0, 364564.0, 386258.0, 390786.0, 391110.0, 63829.36170638234, 64958.675206623666, 65095.67452162709, 65154.674226628566, 65359.67320163369, 882.8896387951506, 893.5353616119581, 911.7264820553808, 913.4291068082448, 963.393062370702, 14850.40598376053, 15118.395264189308, 15227.923860380628, 15279.345513390457, 15342.232888355315, 26319.86840065864, 27504.724952750217, 31069.689303107585, 31249.8437507811, 33033.0, 39743.60256397399, 40170.39744403895, 40319.79840100781, 40833.79583102065, 40835.79582102071, 7003.684834182576, 7059.470539709439, 7077.256888026683, 7335.835928401241, 7511.887321690069, 10821.9458902705, 10916.617918372818, 11048.779024419628, 11153.832692509457, 11268.323900565993, 9117.36178467501, 9124.863127052966, 9347.906520934976, 9351.859722104038, 9756.317057805885, 9339.159475646953, 9408.76478088026, 9521.0, 9673.564689588844, 9851.507424628884, 8438.789030274293, 9233.445993240428, 9581.520923953634, 9596.9040309596, 9638.759031024281, 7316.414686825147, 7357.2642735726, 7418.96290518544, 7506.849863002819, 7612.391008719178, 8191.549464779494, 8890.64437422496, 9032.683856065007, 9200.585973631336, 9436.669716559887], "value": 7980.4145938616275, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1145.7651181507792, 1430.3992323224245, 1460.364741337518, 1532.6551525906666, 1759.067694122115, 6888.20785609655, 7799.688012479501, 8017.118117007125, 8022.3582113431, 8231.341492680585, 7877.842443151134, 8095.797605059876, 8104.3921705872, 8108.0, 8112.391570632197, 1837.604914943287, 2071.9171233150655, 2178.215842296772, 2185.366243789299, 2214.269291133922, 2151.8278537716947, 2194.0565556810566, 2198.274569392097, 2198.582269368823, 2199.1533259694975, 2154.644483660194, 2175.5213852952406, 2185.650295952648, 2186.967195492069, 2191.057845126595, 1803.3417802502058, 1859.9349022784272, 2054.239931225456, 2113.5455876986366, 2126.723525941625, 2116.968245476319, 2136.75427325858, 2141.2184552638173, 2142.3680014395636, 2142.882141482218, 7899.684012639487, 7941.523508589503, 7947.443678942476, 7955.363570914313, 7956.0, 4535.863924082283, 4692.835750748707, 4693.6010439112715, 4695.483496815347, 4698.459677137139, 2815.1132393296252, 2865.982576185445, 3021.078571035833, 3050.8932187373334, 3052.6336839579394, 985.6550207427415, 991.6777047459533, 992.2012779712401, 998.7802683409639, 1011.9949400253025, 10965.56137754489, 11139.164562657752, 11172.329660220414, 11176.664700059093, 11210.607628732956, 4259.829606815692, 4282.250606143974, 4374.737515749065, 4401.559844015573, 4409.933850992237, 9391.389559678599, 9408.341416100944, 9431.717048488556, 9437.716868493957, 9438.716838494856, 4678.672492925462, 4682.765861706901, 4683.95316046842, 4689.273162659793, 4690.366800481891, 3536.6993805526304, 4156.4388807510595, 4319.503257125408, 4324.221640104812, 4391.231534481453, 3790.981045094757, 3832.1186127190904, 3893.1045859452483, 3920.666743326792, 3951.940720889189, 1211.3277131192096, 1218.2507757728933, 1219.268438936631, 1229.674136353867, 1240.1257113734796, 620.652434636605, 697.8046147078826, 723.598402886403, 724.1491247783833, 729.1032030602389, 4860.902781944341, 4977.0, 5005.324281221989, 5042.294078828967, 5087.058894104529, 424.8576726796496, 895.1898531828706, 906.1796694526197, 908.8364094462928, 909.2998391238709, 3282.40916635008, 3331.3337332533592, 3331.450310698756, 3380.8816691416173, 3389.9491507627404, 9501.667441639509, 9638.710838674851, 9754.268429867789, 9763.511824408894, 9777.462239576891, 9636.084571965652, 9708.223342132613, 9710.223182145412, 9734.756631084138, 9739.366941148803, 7489.400847932152, 7509.399248060142, 7545.660445279976, 7586.0, 7638.618069096523, 4856.417229932431, 4895.951040489549, 4902.509749025212, 4956.10790057793, 4973.47778483254, 9067.319951003834, 9167.679131230376, 9240.584173712065, 9342.065793420603, 9370.765730856783, 9372.765680858032, 9419.670311539063, 9446.38598491096, 9477.052294770469, 9502.239820814457, 5543.695096769717, 6289.496840252677, 6484.254310754135, 6509.804705858832, 6623.138991931018, 7529.88705169412, 7574.166841647304, 7597.886031709419, 7631.198724133886, 7639.388848892187, 6613.272540020497, 6739.0, 6785.966070169815, 6793.150856142982, 6850.520463567503, 6885.173779146535, 6895.586264824126, 6981.232064473005, 7016.824579385556, 7059.223485416703, 6258.624482531062, 6303.117563541016, 6312.968435157794, 6324.146240257506, 6429.9678501607195, 4146.813393397365, 4260.488741351058, 4325.24308246062, 4399.934000990052, 4411.691181617256, 4262.275413179705, 4334.848280310174, 4369.584889435499, 4417.469903611587, 4467.30756732707], "value": 4121.670069746429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.1312363830349, 307.15072823642635, 307.6385247334382, 309.4939773470378, 313.68788055884386, 4836.879078023051, 4858.24697171938, 4872.7076375417455, 4918.778654960526, 4946.950530494694, 4788.114198873211, 4840.903181936368, 4856.6357523185725, 4863.294822250771, 4875.804967801284, 3576.910577235577, 3702.1670124222105, 3768.453574231735, 3794.4498047783054, 3844.2503711776217, 3787.507624008875, 3822.75152115113, 3827.6363745444137, 3834.8466061357512, 3857.209272099227, 3794.5067141271734, 3811.942820857689, 3812.8856134316015, 3816.0459885028745, 3818.6754125899333, 3600.3339382214376, 3628.818559072049, 3693.8364415209394, 3741.906452338686, 3772.622992607706, 3306.454435018219, 3330.3672302262494, 3334.3831391192707, 3337.766356355056, 3338.4825352070466, 4606.0, 4612.700174488681, 4628.490866004737, 4630.699004564726, 4674.158651442739, 4214.831406743727, 4277.786110694484, 4283.91432171358, 4301.0, 4338.58783415575, 5031.22016087507, 5085.644004919657, 5108.106081435771, 5112.284280200738, 5120.308758317654, 3623.3477973964677, 3628.2743451309843, 3630.1287690954246, 3637.0907273181706, 3640.6177351378255, 5206.869828254324, 5221.877296381258, 5308.52223299901, 5334.946650533484, 5347.812826551052, 3673.559172899269, 3676.852925882988, 3684.5578530576504, 3688.483612294281, 3697.75964562308, 3742.214135031619, 3745.5879853216125, 3747.138158223624, 3751.7748935063983, 3753.8310776015146, 4241.34259189826, 4264.658827293809, 4270.50889147752, 4296.400677590075, 4298.634616057608, 4809.44691360498, 5097.898042039213, 5114.207297868837, 5115.7953681852305, 5121.667091639106, 1261.892739117167, 1275.7576060548465, 1283.666246775845, 1287.1440492072854, 1289.1040726695044, 802.8233788566506, 820.971266005687, 836.8576892541759, 844.8817165596821, 851.5401683091185, 4435.26818075014, 4444.177827101997, 4445.5776701213335, 4458.821647134143, 4580.541945805459, 5211.895762084737, 5232.843014709565, 5259.4477579853565, 5266.499682530153, 5285.392179899284, 4328.156009578165, 4523.95476045242, 4527.320901864681, 4540.070470050216, 4563.657725670588, 2762.516559602102, 2788.2053614719707, 2793.399419124898, 2800.9579856301766, 2808.8595570221405, 4927.743425426494, 4936.234883593049, 4937.802487900443, 4955.4301255356095, 4981.302617633534, 5124.7950081996305, 5342.2253773202665, 5357.973210133924, 5365.382980957162, 5374.435684253097, 4888.780004899859, 4899.387576552931, 4931.619146638946, 4936.407631084293, 4938.654294199371, 5216.304700972123, 5216.347956505437, 5232.4505926878655, 5255.973720131375, 5266.762995665281, 5003.299538064601, 5132.384113906355, 5157.484251574812, 5162.535371816554, 5167.509086636764, 4885.609151267819, 4909.386326709161, 4938.975305123451, 4950.861301900511, 4966.602671786321, 3651.64888991075, 3665.87169449068, 3674.3202507536193, 3675.9816200918826, 3685.70514358856, 4981.427135879276, 5190.351206099238, 5259.921716048278, 5303.310569625924, 5305.204219367126, 5006.849794506171, 5026.3214466048075, 5028.0, 5048.485454363749, 5059.721715305546, 5029.390595009561, 5035.345405097314, 5047.697138171721, 5065.974670126626, 5073.644844860824, 4744.78648460827, 5002.149634562206, 5009.674371165863, 5017.974910125426, 5037.571806396498, 4881.219004959189, 4959.900801984012, 5080.695158290514, 5099.719515426687, 5108.846734597968, 5019.347484826949, 5025.793809485624, 5026.095302845523, 5030.9245361320345, 5035.899282014412], "value": 3822.8176736124706, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.9385408386202, 683.9760608378708, 690.1683471416943, 716.4805516000897, 729.5476804381284, 11939.76120477591, 12685.794849489295, 12811.935940320285, 12822.230666160038, 12844.871551284485, 12548.0, 12641.0, 12645.0, 12658.493660253602, 12690.175138615983, 645.7675236914707, 786.1038416205502, 809.1423091523004, 822.8313195794848, 823.3413269384498, 818.1613845808035, 822.6380392627254, 823.0658202939646, 823.3372135430976, 823.4400607586839, 838.4801423117675, 846.2003406780594, 847.5550336073549, 848.4315508609216, 849.0, 668.2682462703332, 836.1137194573711, 841.4614646626164, 843.9915600843974, 861.8750281209252, 627.7928283666379, 628.0485065126337, 628.1049504456178, 628.1833616298793, 628.7893555658814, 12453.75092498154, 12457.875421245762, 12491.0, 12497.687557811036, 12540.498380064877, 11623.651290461215, 11878.287302761775, 12012.159148859584, 12034.81947770784, 12363.676220748626, 10861.837072443841, 10921.836172457419, 10938.289011214245, 11017.889821101766, 11029.503672334764, 3957.327254366736, 4010.4786377770993, 4027.252834692654, 4066.044479547304, 4111.691623128248, 44381.0, 44877.32684009743, 44890.32664510035, 44913.775431122966, 45060.549394505964, 9712.55008142906, 9995.400275983464, 10028.197744180448, 10117.747056323651, 10444.529996150191, 17328.268218729227, 18120.728189077174, 18176.727349089775, 18376.54058648518, 18378.63242735138, 6581.967090164519, 6682.799516014527, 6695.263521012685, 6748.325167483213, 6831.2144103428745, 3753.7935413551972, 3766.642168993941, 3796.6393192646656, 3805.7335986481235, 3830.0, 2754.132448278786, 2842.8294302341924, 2847.985760071186, 2850.586664933573, 2851.3584443500044, 491.31216297184227, 502.813958835226, 510.10476613542994, 511.02649452791746, 516.4422423782306, 447.8745951133688, 459.11391015340047, 462.3180808307719, 465.2114665641705, 474.95250474952917, 6685.665716714145, 6794.4904132189295, 6854.074699915547, 6884.586924784529, 6887.5178737487895, 420.7811937792331, 433.3261777935278, 447.17496219475015, 465.54841803450597, 478.9736564488917, 3232.7090561849077, 3266.1997810536573, 3354.8993530194134, 3431.5367425397753, 3454.4818277258614, 59141.0, 61483.69258153681, 61600.0, 61618.0, 61667.38332616706, 44394.33408498875, 46178.307325390146, 48358.27462588064, 50641.0, 50737.74631126821, 45870.77064614656, 45893.0, 46452.767736161106, 46758.53241467542, 47532.0, 7669.8466030677955, 7870.331021862977, 7891.802704932193, 8068.556229407204, 8130.918690813016, 31765.36469270648, 31801.8409907949, 32191.51712724264, 32315.838420807744, 32344.35311293808, 37861.43207851939, 41655.37516937309, 41758.791206043774, 42125.578744212165, 42268.577314227696, 10179.796404072025, 10249.180065594883, 10587.0, 10590.682279531318, 10813.189010824062, 11825.0, 11840.467178977138, 11991.0, 12369.257844529357, 12486.377860649001, 9086.63653453881, 9728.124468797841, 9922.206223502248, 10019.348742331726, 10234.0, 11527.942360288145, 11655.417229138679, 12037.518499260283, 12042.096842736655, 12227.388630568257, 9901.55443005052, 10185.032421919906, 10286.794264114826, 10380.792384152426, 10474.423906685206, 9267.258619310574, 9460.905390946002, 9723.562439690373, 10334.793304133726, 10484.528196231035, 8603.09667484905, 8787.736367908972, 8815.294776417742, 9066.909330906607, 9088.182063614306], "value": 5893.7063783110125, "unit": "score"}], "name": "dromaeo_css", "value": 6323.389145594854, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 133.0, 131.0, 185.0, 133.0, 134.0, 164.0, 129.0, 169.0, 129.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 161.0, 169.0, 162.0, 162.0, 164.0, 163.0, 162.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 120.0, 76.0, 77.0, 76.0, 75.0, 115.0, 75.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 124.0, 84.0, 85.0, 85.0, 120.0, 84.0, 84.0, 123.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 92.0, 63.0, 64.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 81.0, 83.0, 84.0, 90.0, 89.0, 84.0, 82.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 130.0, 141.0, 139.0, 141.0, 130.0, 135.0, 125.0, 167.0, 130.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 169.0, 174.0, 169.0, 171.0, 174.0, 170.0, 176.0, 184.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 71.0, 68.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1555.8, "alertThreshold": 2.0}]} 11:12:38 INFO - Return code: 0 11:12:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:12:38 ERROR - # TBPL SUCCESS # 11:12:38 INFO - Running post-action listener: _resource_record_post_action 11:12:38 INFO - ##### 11:12:38 INFO - ##### Finished run-tests step (success) 11:12:38 INFO - ##### 11:12:38 INFO - Running post-run listener: _resource_record_post_run 11:12:38 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 395427840; Read time: 216; Write time: 421312 11:12:38 INFO - TinderboxPrint: CPU usage
13.1% 11:12:38 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 216 11:12:38 INFO - TinderboxPrint: I/O write bytes / time
395,427,840 / 421,312 11:12:38 INFO - TinderboxPrint: CPU idle
8,321.8 (86.9%) 11:12:38 INFO - TinderboxPrint: CPU user
1,212.8 (12.7%) 11:12:38 INFO - TinderboxPrint: Swap in / out
0 / 0 11:12:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116445184; Read time: 0; Write time: 112272 11:12:38 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 278982656; Read time: 216; Write time: 309040 11:12:39 INFO - Running post-run listener: _upload_blobber_files 11:12:39 INFO - Blob upload gear active. 11:12:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:39 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 11:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:12:39 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:12:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:40 INFO - (blobuploader) - INFO - Done attempting. 11:12:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:12:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:12:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:41 INFO - (blobuploader) - INFO - Done attempting. 11:12:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:12:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:12:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:45 INFO - (blobuploader) - INFO - Done attempting. 11:12:45 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:45 INFO - Return code: 0 11:12:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e926a7ff671063996bea7c86845dd5e2e715c39b8a56a44c3c201ace2e35ad8a210513a7155eee94b17b5dacf8d0a4614e19c0379fd52c67c1942ec9cd3c735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98d5cb7c30a7ce264f1647244164610c142aac9e2a2f231fe3ebda918e09e55ee125aa7d49ddf83552fb8422fc09a087705dfd3608a02a6a9975f01493c64367", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/814b4fbb7be7c6597ca456c69e1c5b25b69e432eb3cd44c92b1ae6349af7e029fb35a4b92a589934be9919fd1984b8d4d2c455211dcaf40b1b95a69f52a42465"} 11:12:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:45 INFO - Contents: 11:12:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e926a7ff671063996bea7c86845dd5e2e715c39b8a56a44c3c201ace2e35ad8a210513a7155eee94b17b5dacf8d0a4614e19c0379fd52c67c1942ec9cd3c735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98d5cb7c30a7ce264f1647244164610c142aac9e2a2f231fe3ebda918e09e55ee125aa7d49ddf83552fb8422fc09a087705dfd3608a02a6a9975f01493c64367", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/814b4fbb7be7c6597ca456c69e1c5b25b69e432eb3cd44c92b1ae6349af7e029fb35a4b92a589934be9919fd1984b8d4d2c455211dcaf40b1b95a69f52a42465"} 11:12:45 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:45 INFO - Copying logs to upload dir... 11:12:45 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.819881 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-05-26 11:12:45.012599) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 11:12:45.015980) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e926a7ff671063996bea7c86845dd5e2e715c39b8a56a44c3c201ace2e35ad8a210513a7155eee94b17b5dacf8d0a4614e19c0379fd52c67c1942ec9cd3c735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98d5cb7c30a7ce264f1647244164610c142aac9e2a2f231fe3ebda918e09e55ee125aa7d49ddf83552fb8422fc09a087705dfd3608a02a6a9975f01493c64367", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/814b4fbb7be7c6597ca456c69e1c5b25b69e432eb3cd44c92b1ae6349af7e029fb35a4b92a589934be9919fd1984b8d4d2c455211dcaf40b1b95a69f52a42465"} build_url:https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/dkD7dNa5SCyqcu-IoRgCsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e926a7ff671063996bea7c86845dd5e2e715c39b8a56a44c3c201ace2e35ad8a210513a7155eee94b17b5dacf8d0a4614e19c0379fd52c67c1942ec9cd3c735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98d5cb7c30a7ce264f1647244164610c142aac9e2a2f231fe3ebda918e09e55ee125aa7d49ddf83552fb8422fc09a087705dfd3608a02a6a9975f01493c64367", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/814b4fbb7be7c6597ca456c69e1c5b25b69e432eb3cd44c92b1ae6349af7e029fb35a4b92a589934be9919fd1984b8d4d2c455211dcaf40b1b95a69f52a42465"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 11:12:45.041807) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 11:12:45.042149) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464284863.337325-249602142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 11:12:45.123564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 11:12:45.123948) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 11:12:45.124265) ========= ========= Total master_lag: 0.21 =========