builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1464379162.63 results: success (0) buildid: 20160527122546 builduid: 3608fad19f1b46f0abad57506cd1118b revision: 6438b11898cf5775f446ac0ddcf13f9e8506b26a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:22.625606) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:22.626179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:22.626723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:22.639237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:22.639663) ========= 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=52faae308a556c440401f8e5000001e8-1464379068.425440-222692293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 12:59:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 38.1M=0s 2016-05-27 12:59:23 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139866 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:22.792434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:22.792985) ========= 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=52faae308a556c440401f8e5000001e8-1464379068.425440-222692293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013779 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:22.844321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 12:59:22.844946) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6438b11898cf5775f446ac0ddcf13f9e8506b26a --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 6438b11898cf5775f446ac0ddcf13f9e8506b26a --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=52faae308a556c440401f8e5000001e8-1464379068.425440-222692293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 12:59:23,980 truncating revision to first 12 chars 2016-05-27 12:59:23,980 Setting DEBUG logging. 2016-05-27 12:59:23,980 attempt 1/10 2016-05-27 12:59:23,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6438b11898cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 12:59:25,269 unpacking tar archive at: fx-team-6438b11898cf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.646556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 12:59:24.505520) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:24.505867) ========= script_repo_revision: 6438b11898cf5775f446ac0ddcf13f9e8506b26a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:24.506285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:24.506581) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 12:59:24.518112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-27 12:59:24.518481) ========= /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=52faae308a556c440401f8e5000001e8-1464379068.425440-222692293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:59:25 INFO - MultiFileLogger online at 20160527 12:59:25 in /builds/slave/test 12:59:25 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 12:59:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:59:25 INFO - {'append_to_log': False, 12:59:25 INFO - 'base_work_dir': '/builds/slave/test', 12:59:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:59:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:59:25 INFO - 'branch': 'Fx-Team-Non-PGO', 12:59:25 INFO - 'buildbot_json_path': 'buildprops.json', 12:59:25 INFO - 'config_files': ('talos/linux_config.py',), 12:59:25 INFO - 'default_actions': ('clobber', 12:59:25 INFO - 'read-buildbot-config', 12:59:25 INFO - 'download-and-extract', 12:59:25 INFO - 'populate-webroot', 12:59:25 INFO - 'create-virtualenv', 12:59:25 INFO - 'install', 12:59:25 INFO - 'run-tests'), 12:59:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:59:25 INFO - 'download_minidump_stackwalk': True, 12:59:25 INFO - 'download_symbols': 'ondemand', 12:59:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:59:25 INFO - 'tooltool.py': '/tools/tooltool.py', 12:59:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:59:25 INFO - '/tools/misc-python/virtualenv.py')}, 12:59:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:59:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:59:25 INFO - 'installer_path': 'installer.exe', 12:59:25 INFO - 'log_level': 'info', 12:59:25 INFO - 'log_name': 'talos', 12:59:25 INFO - 'log_to_console': True, 12:59:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:59:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:59:25 INFO - 'opt_config_files': (), 12:59:25 INFO - 'pip_index': False, 12:59:25 INFO - 'sps_profile': False, 12:59:25 INFO - 'sps_profile_interval': 0, 12:59:25 INFO - 'suite': 'dromaeojs', 12:59:25 INFO - 'system_bits': '32', 12:59:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:59:25 INFO - 'title': 'talos-linux64-ix-056', 12:59:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:59:25 INFO - 'use_talos_json': True, 12:59:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:59:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:59:25 INFO - 'work_dir': 'build'} 12:59:25 INFO - ##### 12:59:25 INFO - ##### Running clobber step. 12:59:25 INFO - ##### 12:59:25 INFO - Running pre-action listener: _resource_record_pre_action 12:59:25 INFO - Running main action method: clobber 12:59:25 INFO - rmtree: /builds/slave/test/build 12:59:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:59:26 INFO - Running post-action listener: _resource_record_post_action 12:59:26 INFO - ##### 12:59:26 INFO - ##### Finished clobber step (success) 12:59:26 INFO - ##### 12:59:26 INFO - ##### 12:59:26 INFO - ##### Running read-buildbot-config step. 12:59:26 INFO - ##### 12:59:26 INFO - Running pre-action listener: _resource_record_pre_action 12:59:26 INFO - Running main action method: read_buildbot_config 12:59:26 INFO - Using buildbot properties: 12:59:26 INFO - { 12:59:26 INFO - "project": "", 12:59:26 INFO - "product": "firefox", 12:59:26 INFO - "script_repo_revision": "production", 12:59:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:59:26 INFO - "repository": "", 12:59:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:59:26 INFO - "buildid": "20160527122546", 12:59:26 INFO - "pgo_build": "False", 12:59:26 INFO - "basedir": "/builds/slave/test", 12:59:26 INFO - "buildnumber": 1794, 12:59:26 INFO - "slavename": "talos-linux64-ix-056", 12:59:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:59:26 INFO - "platform": "ubuntu64_hw", 12:59:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:59:26 INFO - "branch": "fx-team", 12:59:26 INFO - "repo_path": "integration/fx-team", 12:59:26 INFO - "revision": "6438b11898cf5775f446ac0ddcf13f9e8506b26a", 12:59:26 INFO - "stage_platform": "linux64", 12:59:26 INFO - "builduid": "3608fad19f1b46f0abad57506cd1118b", 12:59:26 INFO - "slavebuilddir": "test" 12:59:26 INFO - } 12:59:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:59:26 INFO - Running post-action listener: _resource_record_post_action 12:59:26 INFO - ##### 12:59:26 INFO - ##### Finished read-buildbot-config step (success) 12:59:26 INFO - ##### 12:59:26 INFO - ##### 12:59:26 INFO - ##### Running download-and-extract step. 12:59:26 INFO - ##### 12:59:26 INFO - Running pre-action listener: _resource_record_pre_action 12:59:26 INFO - Running main action method: download_and_extract 12:59:26 INFO - mkdir: /builds/slave/test/build/tests 12:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:26 INFO - https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:27 INFO - Downloaded 1361 bytes. 12:59:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:27 INFO - Using the following test package requirements: 12:59:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:59:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:59:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:27 INFO - u'jsshell-linux-x86_64.zip'], 12:59:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:59:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:59:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:59:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:59:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:59:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:27 INFO - https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:28 INFO - Downloaded 22837963 bytes. 12:59:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:59:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:59:30 INFO - Return code: 0 12:59:30 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 12:59:30 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')]} 12:59:30 INFO - https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:31 INFO - Downloaded 22837963 bytes. 12:59:31 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'] 12:59:31 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 12:59:33 INFO - Return code: 0 12:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:33 INFO - https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:34 INFO - Downloaded 10834034 bytes. 12:59:34 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'] 12:59:34 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 12:59:34 INFO - Return code: 0 12:59: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')]} 12:59:34 INFO - https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:59:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cT7by1DPRqKh-12RyW2BCg/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 12:59:36 INFO - Downloaded 54846381 bytes. 12:59:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:59:36 INFO - mkdir: /builds/slave/test/properties 12:59:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:59:36 INFO - Writing to file /builds/slave/test/properties/build_url 12:59:36 INFO - Contents: 12:59:36 INFO - build_url:https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:59:36 INFO - Running post-action listener: _resource_record_post_action 12:59:36 INFO - Running post-action listener: set_extra_try_arguments 12:59:36 INFO - ##### 12:59:36 INFO - ##### Finished download-and-extract step (success) 12:59:36 INFO - ##### 12:59:36 INFO - ##### 12:59:36 INFO - ##### Running populate-webroot step. 12:59:36 INFO - ##### 12:59:37 INFO - Running pre-action listener: _resource_record_pre_action 12:59:37 INFO - Running main action method: populate_webroot 12:59:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:59:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:59:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:59:37 INFO - '--tppagecycles', 12:59:37 INFO - '7'], 12:59:37 INFO - 'tests': ['tsvgm']}}, 12:59:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:59:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:59:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:59:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:59:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:37 INFO - 'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:37 INFO - 'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['damp', 'tps']}, 12:59:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:37 INFO - 'tests': ['damp', 'tps']}, 12:59:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['dromaeo_dom']}, 12:59:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:59:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['a11yr', 12:59:37 INFO - 'ts_paint', 12:59:37 INFO - 'tpaint', 12:59:37 INFO - 'sessionrestore', 12:59:37 INFO - 'sessionrestore_no_auto_restore', 12:59:37 INFO - 'tabpaint']}, 12:59:37 INFO - 'other-e10s': {'tests': ['a11yr', 12:59:37 INFO - 'ts_paint', 12:59:37 INFO - 'tpaint', 12:59:37 INFO - 'sessionrestore', 12:59:37 INFO - 'sessionrestore_no_auto_restore', 12:59:37 INFO - 'tabpaint']}, 12:59:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:59:37 INFO - 'ts_paint', 12:59:37 INFO - 'tpaint', 12:59:37 INFO - 'sessionrestore', 12:59:37 INFO - 'sessionrestore_no_auto_restore', 12:59:37 INFO - 'tabpaint']}, 12:59:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:59:37 INFO - 'ts_paint', 12:59:37 INFO - 'tpaint', 12:59:37 INFO - 'sessionrestore', 12:59:37 INFO - 'sessionrestore_no_auto_restore', 12:59:37 INFO - 'tabpaint']}, 12:59:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['a11yr', 12:59:37 INFO - 'ts_paint', 12:59:37 INFO - 'tpaint', 12:59:37 INFO - 'sessionrestore', 12:59:37 INFO - 'sessionrestore_no_auto_restore', 12:59:37 INFO - 'tabpaint']}, 12:59:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['a11yr', 12:59:37 INFO - 'ts_paint', 12:59:37 INFO - 'tpaint', 12:59:37 INFO - 'sessionrestore', 12:59:37 INFO - 'sessionrestore_no_auto_restore', 12:59:37 INFO - 'tabpaint']}, 12:59:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['tsvgx', 12:59:37 INFO - 'tsvgr_opacity', 12:59:37 INFO - 'tart', 12:59:37 INFO - 'tscrollx', 12:59:37 INFO - 'cart']}, 12:59:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:59:37 INFO - 'tsvgr_opacity', 12:59:37 INFO - 'tart', 12:59:37 INFO - 'tscrollx', 12:59:37 INFO - 'cart']}, 12:59:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:37 INFO - 'talos_options': ['--disable-e10s'], 12:59:37 INFO - 'tests': ['tp5o']}, 12:59:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:37 INFO - 'tests': ['tp5o']}, 12:59:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:37 INFO - 'talos_options': ['--disable-e10s', 12:59:37 INFO - '--xperf_path', 12:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:37 INFO - 'tests': ['tp5n']}, 12:59:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:37 INFO - 'talos_options': ['--xperf_path', 12:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:37 INFO - 'tests': ['tp5n']}}, 12:59:37 INFO - 'talos.zip': {'path': '', 12:59:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:59:37 INFO - Running post-action listener: _resource_record_post_action 12:59:37 INFO - ##### 12:59:37 INFO - ##### Finished populate-webroot step (success) 12:59:37 INFO - ##### 12:59:37 INFO - ##### 12:59:37 INFO - ##### Running create-virtualenv step. 12:59:37 INFO - ##### 12:59:37 INFO - Running pre-action listener: _resource_record_pre_action 12:59:37 INFO - Running main action method: create_virtualenv 12:59:37 INFO - Creating virtualenv /builds/slave/test/build/venv 12:59:37 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 12:59:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:59:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:59:37 INFO - Using real prefix '/usr' 12:59:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:59:37 INFO - Installing distribute.............................................................................................................................................................................................done. 12:59:39 INFO - Installing pip.................done. 12:59:39 INFO - Return code: 0 12:59:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8104a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, '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': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', '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 12:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:59:39 INFO - Using env: {'DISPLAY': ':0', 12:59:39 INFO - 'HOME': '/home/cltbld', 12:59:39 INFO - 'LANG': 'en_US.UTF-8', 12:59:39 INFO - 'LANGUAGE': 'en_US:en', 12:59:39 INFO - 'LOGNAME': 'cltbld', 12:59:39 INFO - 'MAIL': '/var/mail/cltbld', 12:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:39 INFO - 'MOZ_NO_REMOTE': '1', 12:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:39 INFO - 'NO_EM_RESTART': '1', 12:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:39 INFO - 'PWD': '/builds/slave/test', 12:59:39 INFO - 'SHELL': '/bin/bash', 12:59:39 INFO - 'SHLVL': '1', 12:59:39 INFO - 'TERM': 'linux', 12:59:39 INFO - 'TMOUT': '86400', 12:59:39 INFO - 'USER': 'cltbld', 12:59:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 12:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:39 INFO - '_': '/tools/buildbot/bin/python'} 12:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:59:39 INFO - Cleaning up... 12:59:39 INFO - Return code: 0 12:59:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8104a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, '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': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', '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 12:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:59:39 INFO - Using env: {'DISPLAY': ':0', 12:59:39 INFO - 'HOME': '/home/cltbld', 12:59:39 INFO - 'LANG': 'en_US.UTF-8', 12:59:39 INFO - 'LANGUAGE': 'en_US:en', 12:59:39 INFO - 'LOGNAME': 'cltbld', 12:59:39 INFO - 'MAIL': '/var/mail/cltbld', 12:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:39 INFO - 'MOZ_NO_REMOTE': '1', 12:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:39 INFO - 'NO_EM_RESTART': '1', 12:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:39 INFO - 'PWD': '/builds/slave/test', 12:59:39 INFO - 'SHELL': '/bin/bash', 12:59:39 INFO - 'SHLVL': '1', 12:59:39 INFO - 'TERM': 'linux', 12:59:39 INFO - 'TMOUT': '86400', 12:59:39 INFO - 'USER': 'cltbld', 12:59:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 12:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:39 INFO - '_': '/tools/buildbot/bin/python'} 12:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:39 INFO - Downloading/unpacking psutil>=3.1.1 12:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:42 INFO - Installing collected packages: psutil 12:59:42 INFO - Running setup.py install for psutil 12:59:42 INFO - building 'psutil._psutil_linux' extension 12:59:42 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 12:59:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:59:42 INFO - building 'psutil._psutil_posix' extension 12:59:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:59:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:42 INFO - Successfully installed psutil 12:59:42 INFO - Cleaning up... 12:59:42 INFO - Return code: 0 12:59:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8104a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, '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': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', '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 12:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:59:42 INFO - Using env: {'DISPLAY': ':0', 12:59:42 INFO - 'HOME': '/home/cltbld', 12:59:42 INFO - 'LANG': 'en_US.UTF-8', 12:59:42 INFO - 'LANGUAGE': 'en_US:en', 12:59:42 INFO - 'LOGNAME': 'cltbld', 12:59:42 INFO - 'MAIL': '/var/mail/cltbld', 12:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:42 INFO - 'MOZ_NO_REMOTE': '1', 12:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:42 INFO - 'NO_EM_RESTART': '1', 12:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:42 INFO - 'PWD': '/builds/slave/test', 12:59:42 INFO - 'SHELL': '/bin/bash', 12:59:42 INFO - 'SHLVL': '1', 12:59:42 INFO - 'TERM': 'linux', 12:59:42 INFO - 'TMOUT': '86400', 12:59:42 INFO - 'USER': 'cltbld', 12:59:42 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 12:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:42 INFO - '_': '/tools/buildbot/bin/python'} 12:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:59:44 INFO - Installing collected packages: mozsystemmonitor 12:59:44 INFO - Running setup.py install for mozsystemmonitor 12:59:44 INFO - Successfully installed mozsystemmonitor 12:59:44 INFO - Cleaning up... 12:59:44 INFO - Return code: 0 12:59:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:59: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')]} 12:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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')]} 12:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8104a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, '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': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', '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 12:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:59:44 INFO - Using env: {'DISPLAY': ':0', 12:59:44 INFO - 'HOME': '/home/cltbld', 12:59:44 INFO - 'LANG': 'en_US.UTF-8', 12:59:44 INFO - 'LANGUAGE': 'en_US:en', 12:59:44 INFO - 'LOGNAME': 'cltbld', 12:59:44 INFO - 'MAIL': '/var/mail/cltbld', 12:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:44 INFO - 'MOZ_NO_REMOTE': '1', 12:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:44 INFO - 'NO_EM_RESTART': '1', 12:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:44 INFO - 'PWD': '/builds/slave/test', 12:59:44 INFO - 'SHELL': '/bin/bash', 12:59:44 INFO - 'SHLVL': '1', 12:59:44 INFO - 'TERM': 'linux', 12:59:44 INFO - 'TMOUT': '86400', 12:59:44 INFO - 'USER': 'cltbld', 12:59:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 12:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:44 INFO - '_': '/tools/buildbot/bin/python'} 12:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:45 INFO - Downloading/unpacking blobuploader==1.2.4 12:59:45 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 12:59:45 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 12:59:45 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 12:59:45 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 12:59:45 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 12:59:45 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 12:59:46 INFO - Downloading blobuploader-1.2.4.tar.gz 12:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:59:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:59:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:47 INFO - Downloading docopt-0.6.1.tar.gz 12:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:59:47 INFO - Installing collected packages: blobuploader, requests, docopt 12:59:47 INFO - Running setup.py install for blobuploader 12:59:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:59:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:59:47 INFO - Running setup.py install for requests 12:59:48 INFO - Running setup.py install for docopt 12:59:48 INFO - Successfully installed blobuploader requests docopt 12:59:48 INFO - Cleaning up... 12:59:48 INFO - Return code: 0 12:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8104a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, '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': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', '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 12:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:59:48 INFO - Using env: {'DISPLAY': ':0', 12:59:48 INFO - 'HOME': '/home/cltbld', 12:59:48 INFO - 'LANG': 'en_US.UTF-8', 12:59:48 INFO - 'LANGUAGE': 'en_US:en', 12:59:48 INFO - 'LOGNAME': 'cltbld', 12:59:48 INFO - 'MAIL': '/var/mail/cltbld', 12:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:48 INFO - 'MOZ_NO_REMOTE': '1', 12:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:48 INFO - 'NO_EM_RESTART': '1', 12:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:48 INFO - 'PWD': '/builds/slave/test', 12:59:48 INFO - 'SHELL': '/bin/bash', 12:59:48 INFO - 'SHLVL': '1', 12:59:48 INFO - 'TERM': 'linux', 12:59:48 INFO - 'TMOUT': '86400', 12:59:48 INFO - 'USER': 'cltbld', 12:59:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 12:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:48 INFO - '_': '/tools/buildbot/bin/python'} 12:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:59:48 INFO - Running setup.py (path:/tmp/pip-u7ZFTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:59:48 INFO - Running setup.py (path:/tmp/pip-ALc2iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:59:48 INFO - Running setup.py (path:/tmp/pip-isytpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:59:48 INFO - Running setup.py (path:/tmp/pip-NqvkRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:59:48 INFO - Running setup.py (path:/tmp/pip-FaFvXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:59:48 INFO - Running setup.py (path:/tmp/pip-1BrqvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:59:48 INFO - Running setup.py (path:/tmp/pip-3BNQRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:59:49 INFO - Running setup.py (path:/tmp/pip-RnaohM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:59:49 INFO - Running setup.py (path:/tmp/pip-2YmKX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:59:49 INFO - Running setup.py (path:/tmp/pip-FVdPEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:59:49 INFO - Running setup.py (path:/tmp/pip-BktOzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:59:49 INFO - Running setup.py (path:/tmp/pip-Nj7Ird-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:59:49 INFO - Running setup.py (path:/tmp/pip-AbVO4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:59:49 INFO - Running setup.py (path:/tmp/pip-sE3rAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:49 INFO - Running setup.py (path:/tmp/pip-MP9oiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:59:49 INFO - Running setup.py (path:/tmp/pip-NXL1jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:59:49 INFO - Running setup.py (path:/tmp/pip-pUg6YA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:59:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:59:49 INFO - Running setup.py install for manifestparser 12:59:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:59:49 INFO - Running setup.py install for mozcrash 12:59:49 INFO - Running setup.py install for mozdebug 12:59:50 INFO - Running setup.py install for mozdevice 12:59:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Running setup.py install for mozfile 12:59:50 INFO - Running setup.py install for mozhttpd 12:59:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Running setup.py install for mozinfo 12:59:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Running setup.py install for mozInstall 12:59:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Running setup.py install for mozleak 12:59:50 INFO - Running setup.py install for mozlog 12:59:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Running setup.py install for moznetwork 12:59:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:59:50 INFO - Running setup.py install for mozprocess 12:59:51 INFO - Running setup.py install for mozprofile 12:59:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:59:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:59:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:59:51 INFO - Running setup.py install for mozrunner 12:59:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:59:51 INFO - Running setup.py install for mozscreenshot 12:59:51 INFO - Running setup.py install for moztest 12:59:51 INFO - Running setup.py install for mozversion 12:59:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:59:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:59:51 INFO - Cleaning up... 12:59:51 INFO - Return code: 0 12:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8104a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, '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': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', '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 12:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:59:51 INFO - Using env: {'DISPLAY': ':0', 12:59:51 INFO - 'HOME': '/home/cltbld', 12:59:51 INFO - 'LANG': 'en_US.UTF-8', 12:59:51 INFO - 'LANGUAGE': 'en_US:en', 12:59:51 INFO - 'LOGNAME': 'cltbld', 12:59:51 INFO - 'MAIL': '/var/mail/cltbld', 12:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:51 INFO - 'MOZ_NO_REMOTE': '1', 12:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:51 INFO - 'NO_EM_RESTART': '1', 12:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:51 INFO - 'PWD': '/builds/slave/test', 12:59:51 INFO - 'SHELL': '/bin/bash', 12:59:51 INFO - 'SHLVL': '1', 12:59:51 INFO - 'TERM': 'linux', 12:59:51 INFO - 'TMOUT': '86400', 12:59:51 INFO - 'USER': 'cltbld', 12:59:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 12:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:51 INFO - '_': '/tools/buildbot/bin/python'} 12:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:59:51 INFO - Running setup.py (path:/tmp/pip-3ZTbQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:59:51 INFO - Running setup.py (path:/tmp/pip-11ZCkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:59:51 INFO - Running setup.py (path:/tmp/pip-vtLuPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:59:52 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)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:59:52 INFO - Running setup.py (path:/tmp/pip-FRDspS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:59:52 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)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:59:52 INFO - Running setup.py (path:/tmp/pip-poMIje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:59:52 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)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:59:52 INFO - Running setup.py (path:/tmp/pip-PgKAzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:59:52 INFO - Running setup.py (path:/tmp/pip-MDvbU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:59:52 INFO - Running setup.py (path:/tmp/pip-PIczap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:59:52 INFO - Running setup.py (path:/tmp/pip-njZ9gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:59:52 INFO - Running setup.py (path:/tmp/pip-PzblsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:59:52 INFO - Running setup.py (path:/tmp/pip-TPyyfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:59:52 INFO - Running setup.py (path:/tmp/pip-IgW7Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:59:52 INFO - Running setup.py (path:/tmp/pip-CrWtDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:59:52 INFO - Running setup.py (path:/tmp/pip-FcxfyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:52 INFO - Running setup.py (path:/tmp/pip-r4J6O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:59:52 INFO - Running setup.py (path:/tmp/pip-m6BF2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:59:52 INFO - Running setup.py (path:/tmp/pip-y2ovNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:59:53 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)) 12:59:53 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)) 12:59:53 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)) 12:59:53 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)) 12:59:53 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)) 12:59:53 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)) 12:59:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:59:53 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 12:59:53 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 12:59:53 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 12:59:53 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 12:59:53 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 12:59:53 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 12:59:54 INFO - Downloading blessings-1.6.tar.gz 12:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:59:55 INFO - Installing collected packages: blessings 12:59:55 INFO - Running setup.py install for blessings 12:59:55 INFO - Successfully installed blessings 12:59:55 INFO - Cleaning up... 12:59:55 INFO - Return code: 0 12:59:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:59:55 INFO - Reading from file tmpfile_stdout 12:59:55 INFO - Current package versions: 12:59:55 INFO - argparse == 1.2.1 12:59:55 INFO - blessings == 1.6 12:59:55 INFO - blobuploader == 1.2.4 12:59:55 INFO - docopt == 0.6.1 12:59:55 INFO - manifestparser == 1.1 12:59:55 INFO - mozInstall == 1.12 12:59:55 INFO - mozcrash == 0.17 12:59:55 INFO - mozdebug == 0.1 12:59:55 INFO - mozdevice == 0.48 12:59:55 INFO - mozfile == 1.2 12:59:55 INFO - mozhttpd == 0.7 12:59:55 INFO - mozinfo == 0.9 12:59:55 INFO - mozleak == 0.1 12:59:55 INFO - mozlog == 3.2 12:59:55 INFO - moznetwork == 0.27 12:59:55 INFO - mozprocess == 0.22 12:59:55 INFO - mozprofile == 0.28 12:59:55 INFO - mozrunner == 6.11 12:59:55 INFO - mozscreenshot == 0.1 12:59:55 INFO - mozsystemmonitor == 0.3 12:59:55 INFO - moztest == 0.7 12:59:55 INFO - mozversion == 1.4 12:59:55 INFO - psutil == 3.1.1 12:59:55 INFO - requests == 1.2.3 12:59:55 INFO - wsgiref == 0.1.2 12:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8104a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, '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': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', '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 12:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:59:55 INFO - Using env: {'DISPLAY': ':0', 12:59:55 INFO - 'HOME': '/home/cltbld', 12:59:55 INFO - 'LANG': 'en_US.UTF-8', 12:59:55 INFO - 'LANGUAGE': 'en_US:en', 12:59:55 INFO - 'LOGNAME': 'cltbld', 12:59:55 INFO - 'MAIL': '/var/mail/cltbld', 12:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:55 INFO - 'MOZ_NO_REMOTE': '1', 12:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:55 INFO - 'NO_EM_RESTART': '1', 12:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:55 INFO - 'PWD': '/builds/slave/test', 12:59:55 INFO - 'SHELL': '/bin/bash', 12:59:55 INFO - 'SHLVL': '1', 12:59:55 INFO - 'TERM': 'linux', 12:59:55 INFO - 'TMOUT': '86400', 12:59:55 INFO - 'USER': 'cltbld', 12:59:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 12:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:55 INFO - '_': '/tools/buildbot/bin/python'} 12:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:59:55 INFO - Cleaning up... 12:59:55 INFO - Return code: 0 12:59:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8104a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, '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': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', '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 12:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:59:55 INFO - Using env: {'DISPLAY': ':0', 12:59:55 INFO - 'HOME': '/home/cltbld', 12:59:55 INFO - 'LANG': 'en_US.UTF-8', 12:59:55 INFO - 'LANGUAGE': 'en_US:en', 12:59:55 INFO - 'LOGNAME': 'cltbld', 12:59:55 INFO - 'MAIL': '/var/mail/cltbld', 12:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:55 INFO - 'MOZ_NO_REMOTE': '1', 12:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:55 INFO - 'NO_EM_RESTART': '1', 12:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:55 INFO - 'PWD': '/builds/slave/test', 12:59:55 INFO - 'SHELL': '/bin/bash', 12:59:55 INFO - 'SHLVL': '1', 12:59:55 INFO - 'TERM': 'linux', 12:59:55 INFO - 'TMOUT': '86400', 12:59:55 INFO - 'USER': 'cltbld', 12:59:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 12:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:55 INFO - '_': '/tools/buildbot/bin/python'} 12:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:55 INFO - Downloading/unpacking jsonschema 12:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:59:57 INFO - Downloading/unpacking functools32 (from jsonschema) 12:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:57 INFO - Downloading functools32-3.2.3-2.tar.gz 12:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:59:57 INFO - warning: no files found matching '*.txt' 12:59:57 INFO - no previously-included directories found matching 'build' 12:59:57 INFO - no previously-included directories found matching 'dist' 12:59:57 INFO - no previously-included directories found matching '.git*' 12:59:57 INFO - Installing collected packages: jsonschema, functools32 12:59:58 INFO - Running setup.py install for functools32 12:59:58 INFO - warning: no files found matching '*.txt' 12:59:58 INFO - no previously-included directories found matching 'build' 12:59:58 INFO - no previously-included directories found matching 'dist' 12:59:58 INFO - no previously-included directories found matching '.git*' 12:59:58 INFO - Successfully installed jsonschema functools32 12:59:58 INFO - Cleaning up... 12:59:58 INFO - Return code: 0 12:59:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:58 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 0x7f8104a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, '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': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', '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 12:59:58 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 12:59:58 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 12:59:58 INFO - Using env: {'DISPLAY': ':0', 12:59:58 INFO - 'HOME': '/home/cltbld', 12:59:58 INFO - 'LANG': 'en_US.UTF-8', 12:59:58 INFO - 'LANGUAGE': 'en_US:en', 12:59:58 INFO - 'LOGNAME': 'cltbld', 12:59:58 INFO - 'MAIL': '/var/mail/cltbld', 12:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:58 INFO - 'MOZ_NO_REMOTE': '1', 12:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:58 INFO - 'NO_EM_RESTART': '1', 12:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:58 INFO - 'PWD': '/builds/slave/test', 12:59:58 INFO - 'SHELL': '/bin/bash', 12:59:58 INFO - 'SHLVL': '1', 12:59:58 INFO - 'TERM': 'linux', 12:59:58 INFO - 'TMOUT': '86400', 12:59:58 INFO - 'USER': 'cltbld', 12:59:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 12:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:58 INFO - '_': '/tools/buildbot/bin/python'} 12:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:58 INFO - Downloading/unpacking flake8 12:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:00:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:00:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:00:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:00:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:00:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:00:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:00:00 INFO - no previously-included directories found matching 'docs/_build' 13:00:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:00:01 INFO - Running setup.py install for pep8 13:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:00:01 INFO - no previously-included directories found matching 'docs/_build' 13:00:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:00:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:00:01 INFO - Cleaning up... 13:00:01 INFO - Return code: 0 13:00:01 INFO - Running post-action listener: _resource_record_post_action 13:00:01 INFO - Running post-action listener: _start_resource_monitoring 13:00:01 INFO - Starting resource monitoring. 13:00:01 INFO - ##### 13:00:01 INFO - ##### Finished create-virtualenv step (success) 13:00:01 INFO - ##### 13:00:01 INFO - ##### 13:00:01 INFO - ##### Running install step. 13:00:01 INFO - ##### 13:00:01 INFO - Running pre-action listener: _resource_record_pre_action 13:00:01 INFO - Running main action method: install 13:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:01 INFO - Reading from file tmpfile_stdout 13:00:01 INFO - Detecting whether we're running mozinstall >=1.0... 13:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:00:01 INFO - Reading from file tmpfile_stdout 13:00:01 INFO - Output received: 13:00:01 INFO - Usage: mozinstall [options] installer 13:00:01 INFO - Options: 13:00:01 INFO - -h, --help show this help message and exit 13:00:01 INFO - -d DEST, --destination=DEST 13:00:01 INFO - Directory to install application into. [default: 13:00:01 INFO - "/builds/slave/test"] 13:00:01 INFO - --app=APP Application being installed. [default: firefox] 13:00:01 INFO - mkdir: /builds/slave/test/build/application 13:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:00:17 INFO - Reading from file tmpfile_stdout 13:00:17 INFO - Output received: 13:00:17 INFO - /builds/slave/test/build/application/firefox/firefox 13:00:17 INFO - Running post-action listener: _resource_record_post_action 13:00:17 INFO - ##### 13:00:17 INFO - ##### Finished install step (success) 13:00:17 INFO - ##### 13:00:17 INFO - ##### 13:00:17 INFO - ##### Running run-tests step. 13:00:17 INFO - ##### 13:00:17 INFO - Running pre-action listener: _resource_record_pre_action 13:00:17 INFO - Running main action method: run_tests 13:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:00:17 INFO - Python 2.7.3 13:00:17 INFO - Return code: 0 13:00:17 INFO - grabbing minidump binary from tooltool 13:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b9c0>, '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 0x220c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:00:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:00:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:00:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:00:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:00:17 INFO - Return code: 0 13:00:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:00:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:00:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:00:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:00:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:00:18 INFO - Return code: 0 13:00:18 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/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 13:00:18 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/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 13:00:18 INFO - Using env: {'DISPLAY': ':0', 13:00:18 INFO - 'HOME': '/home/cltbld', 13:00:18 INFO - 'LANG': 'en_US.UTF-8', 13:00:18 INFO - 'LANGUAGE': 'en_US:en', 13:00:18 INFO - 'LOGNAME': 'cltbld', 13:00:18 INFO - 'MAIL': '/var/mail/cltbld', 13:00:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:00:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:18 INFO - 'MOZ_NO_REMOTE': '1', 13:00:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:18 INFO - 'NO_EM_RESTART': '1', 13:00:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:18 INFO - 'PWD': '/builds/slave/test', 13:00:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:00:18 INFO - 'SHELL': '/bin/bash', 13:00:18 INFO - 'SHLVL': '1', 13:00:18 INFO - 'TERM': 'linux', 13:00:18 INFO - 'TMOUT': '86400', 13:00:18 INFO - 'USER': 'cltbld', 13:00:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464379068.425440-222692293', 13:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:18 INFO - '_': '/tools/buildbot/bin/python'} 13:00:18 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/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 13:00:18 INFO - mozversion application_buildid: 20160527122546 13:00:18 INFO - mozversion application_changeset: 6438b11898cf5775f446ac0ddcf13f9e8506b26a 13:00:18 INFO - mozversion application_display_name: Nightly 13:00:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:00:18 INFO - mozversion application_name: Firefox 13:00:18 INFO - mozversion application_remotingname: firefox 13:00:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:00:18 INFO - mozversion application_vendor: Mozilla 13:00:18 INFO - mozversion application_version: 49.0a1 13:00:18 INFO - mozversion platform_buildid: 20160527122546 13:00:18 INFO - mozversion platform_changeset: 6438b11898cf5775f446ac0ddcf13f9e8506b26a 13:00:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:00:18 INFO - mozversion platform_version: 49.0a1 13:00:18 INFO - using testdate: 1464379218 13:00:18 INFO - actual date: 1464379218 13:00:18 INFO - starting webserver on 'localhost:39085' 13:00:18 INFO - SUITE-START | Running 2 tests 13:00:18 INFO - TEST-START | dromaeo_css 13:00:18 INFO - operating with platform_type : linux_ 13:00:18 INFO - Initialising browser for dromaeo_css test... 13:00:18 INFO - TEST-INFO | started process 31484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoR54OE/profile http://localhost:39085/getInfo.html) 13:00:23 INFO - PROCESS | 31484 | __metrics Screen width/height:1600/1200 13:00:23 INFO - PROCESS | 31484 | colorDepth:24 13:00:23 INFO - PROCESS | 31484 | Browser inner width/height: 1024/697 13:00:23 INFO - PROCESS | 31484 | __metrics 13:00:24 ERROR - PROCESS | 31484 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:00:25 INFO - TEST-INFO | 31484: exit 0 13:00:25 INFO - Browser initialized. 13:00:25 INFO - Running cycle 1/1 for dromaeo_css test... 13:00:25 INFO - TEST-INFO | started process 31566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoR54OE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:00:37 INFO - PROCESS | 31566 | RSS: Main: 157118464 13:00:37 INFO - PROCESS | 31566 | 13:01:28 INFO - PROCESS | 31566 | 1464379288681 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] 13:03:40 INFO - PROCESS | 31566 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39085/tests/dromaeo/cssquery-ext.html) 13:03:41 INFO - PROCESS | 31566 | RSS: Main: 242413568 13:03:41 INFO - PROCESS | 31566 | 13:06:44 INFO - PROCESS | 31566 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-ext.html (next: http://localhost:39085/tests/dromaeo/cssquery-jquery.html) 13:06:44 INFO - PROCESS | 31566 | RSS: Main: 248164352 13:06:44 INFO - PROCESS | 31566 | 13:09:46 INFO - PROCESS | 31566 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39085/tests/dromaeo/cssquery-mootools.html) 13:09:47 INFO - PROCESS | 31566 | RSS: Main: 242274304 13:09:47 INFO - PROCESS | 31566 | 13:12:49 INFO - PROCESS | 31566 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39085/tests/dromaeo/cssquery-prototype.html) 13:12:50 INFO - PROCESS | 31566 | RSS: Main: 243875840 13:12:50 INFO - PROCESS | 31566 | 13:15:53 INFO - PROCESS | 31566 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39085/tests/dromaeo/cssquery-yui.html) 13:15:53 INFO - PROCESS | 31566 | RSS: Main: 232996864 13:15:53 INFO - PROCESS | 31566 | 13:18:56 INFO - PROCESS | 31566 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-yui.html (next: http://localhost:39085/tests/dromaeo/cssquery-dojo.html) 13:18:57 INFO - PROCESS | 31566 | RSS: Main: 280616960 13:18:57 INFO - PROCESS | 31566 | 13:18:57 INFO - PROCESS | 31566 | __start_tp_report 13:18:57 INFO - PROCESS | 31566 | _x_x_mozilla_page_load 13:18:57 INFO - PROCESS | 31566 | _x_x_mozilla_page_load_details 13:18:57 INFO - PROCESS | 31566 | |i|pagename|runs| 13:18:57 INFO - PROCESS | 31566 | |0;dojo.html;2679.517686816373;2680.986595067024;2709.0518318588493;2724.7683946864518;2726.7682247009;4691.15559199344;4710.246360582308;4734.9526504734895;4763.261694437359;4824.348712923755;4767;4771.30816031676;4775.808967641299;4776.068666610013;4828.0585285869265;4294.506131794845;4414.29371300592;4457.465104187502;4476.2390393632995;4564;4473.597376236138;4509.864704058867;4525.47956984946;4532.206863798839;4557.886052848672;4349.043210493702;4368.89077773055;4387.868363949086;4410.095930334273;4428.800703968329;4355.085432059272;4373.7813109344725;4386.407834942306;4428.180786554498;4439.178751930871;4388.71473354231;4414.161309351213;4421.226285400042;4454.0646464242545;4460.420145381112;4626.791794369262;4676.555727205944;4680.040591678698;4684;4695.95304046962;5092.79628814847;5119.488051194888;5133.076046311662;5138.948610513884;5139.743012849342;5155.793768249266;5174.4825517448335;5186.429492755831;5187.83273763404;5196.636235463481;4781.497942716034;4786.736729479877;4843.467218605951;4850.53919877611;4913.557779799764;5338.706371149624;5348.812791552355;5361.303030605996;5392.78428862849;5408.729563521808;5112.539871411516;5147;5167.9224811627855;5169.741512924339;5169.819056333085;5087;5118.539331460186;5164.535191832753;5176.818811341585;5251.081060814342;5146.691198528026;5151.021305951932;5151.922721159186;5153.613478989091;5155.819546315936;5142.640015198975;5143.305653736697;5148.562372198405;5151.9484805152215;5196.76614552346;4356.607905288539;4391.538888416734;4396.032872767986;4442.178197033494;4448.799804008828;3850.614938506183;3904.941425878614;3916.4321173429694;3916.4712763777097;3916.706247031484;4405.647548196137;4443.933340999887;4461.196984542814;4461.330800379904;4480.350349199348;5217.0870097733505;5218.478152184827;5222.764975576109;5232.372115346183;5266.3943646480375;4451.421315229064;4454.844080457233;4460.687751857339;4489.169503641837;4505.031418245093;4578.610818080434;4647.651426143053;4702.741349225757;4722.5513576210205;4732.361131247307;4881.487443818348;4888.65779395446;4891.559759621651;4929.507049295042;4935.8025678972435;5209.661372010807;5214.113600687968;5271.762770675252;5274.657147285414;5276.023935571931;4743.264793956804;4752.691075080109;4772.976135119302;4814.903701926012;4886.047220791911;5096.796128154832;5117.053345131163;5126.974365128151;5129.692218466904;5170.146925757358;5183.196604526304;5194.922076168936;5203.427622961547;5222.3472065991755;5225.320708307896;4912.214045752662;4940.950590494049;4989.60083193351;4997.0505603935135;5012.774425150804;4979.950200498093;5008.87477813043;5010.273510341053;5022.648414610942;5068.797248110034;4858.878528036827;4957.504249575158;4969.776360063878;4975.676581022222;5003.974980125076;5055.823046193365;5071.112555302881;5072.365954255718;5088.720120393414;5106.387233532;5008.899822003613;5014.749262536931;5020.548150666457;5021.748912554431;5076.36545431821 13:18:57 INFO - PROCESS | 31566 | |1;ext.html;607.4411541381929;610.5054905526524;627.7206643043846;629.6096420219465;631.7946667333118;27550.448991020166;29940.25149371267;40877;41607.37588936161;41746;42210;42337.7883110584;42738.786306068505;42748;42771.78614106933;7478.065241844783;7593.9620301898685;7596.5062270952485;7596.696132154707;7606.73376431825;7614.505057171294;7764.805879852993;7766.339861111812;7773.883391749128;7785.727499537517;7762.573058481781;7849.215078492162;7854.921450785505;7856.646450909694;7863.52818830872;7795.532268063906;7855.371570274365;7864.2922137007945;7868.134505204423;7875.4487185897015;7684.077910650702;7769.339606133485;7770.689172433096;7771.145174030852;7777.533347999138;36348.63651363505;36490.63509364925;36590.45114323287;36663.26673466543;36794.448083278774;3035.4839677254918;3077.6306843178736;3188.473901806199;3368.528406023159;3545.6099829018785;29127.563086553717;29848.701512984808;29869.55195672045;29984.25039374033;30467.695323046708;3507.736919731005;3534.6465353464446;3542.681158695704;3562.4656301554714;3572.8392222350058;253491.59287831906;254052;254718;254752;254851;51895.48104518982;51903;52218.738906305225;52279.73860130751;52296.47703522916;49148.75425622921;55086;55859;56175;61417;13321.800172997413;13405.06164568471;13409.798853017213;13467;13468.39392227352;10124.949375253223;10218.693439196835;10229.386236825814;10236.692899213036;10253.641122560675;13705.629437056215;15139.167345795866;15357.308921098578;15649.68700626004;16038.67922641564;6006.189164462829;6038.5772995889865;6093.573449858467;6099.8475038123515;6209.410106039919;790.5217343507211;862.0904945282787;917.9724608261763;920.1442658327686;928.3687092776842;27880.442391152064;28120.042701359926;28145;28320.291992700346;28371.858140709166;843.2797736720336;964.7009427077488;977.6480467031863;982.597135174575;1046.1735229169024;14488.34802433893;14876.330565124379;15051;15083.396664133532;15149.545513634388;361057;362914;364643;365289;365760;48304.516954830004;48585.27122093172;48719.756401218474;48830;48883.266750998766;1082.7726177502655;1143.382573410349;1148.7472755993667;1162.7558212775243;1175.9941200293945;27712.722872771013;28949.7105028947;29160;29215.561766573945;29316;41315;46578.53421465742;47404.52595474001;47751;51621;333936;334527;337694;338033;338774.3061284678;22115.34134939854;22282.77717222807;22729.09083636636;23066.769332306463;25117.120900769118;42393.36409953792;42713.35929960991;42767;42872;43681;36646.63353366539;37124.25751485009;37452.625473746004;37511;37816.62183378131;35899.7622169155;36317.45523817092;36537.634623654485;36672;37174.44238336481;35939.101522462144;36315.81842090773;36438;36760.81619591992;37199.81400092982;30398;31486.84256578794;31555.526667100472;31833.36333273368;31940.680593194702;23967;24375.51248975046;24415.75584244206;24605.63091553664;24753.752462475146 13:18:57 INFO - PROCESS | 31566 | |2;jquery.html;378.8673964112561;382.39390565952965;388.5298788465956;394.48716668331195;403.7537102367557;13154.53959111429;13862.237576933265;15841;17611.207495662693;17720.822791772094;15793.526194214162;16165.19174041299;16687.83312166878;18086;18146.81853181468;4506.369108324837;5129.794808207676;5293.470652934714;5323.44103869092;5336.4930331618625;5106.974465127669;5252.52727254547;5255.106631872591;5274.894502109955;5308.442613525582;5157.174852023677;5189.688618682872;5243.606729495284;5246.658967167141;5253.658512196714;5051.318072060261;5161.845144645667;5170.870728231825;5197.116490196676;5200.2979597754575;4484.843030493949;4667.509911459282;4669.066186762661;4672.065586882637;4677.906441871178;21070.789292107034;21145.47136321589;21253.468663283387;21370.46573835651;21524.784752152435;1626.1300204390595;1763.647270545896;1790.2928343304322;1906.218450435315;1927.171316333976;5182.663126896778;5203.4796520348045;5229.2156176573435;9215.354925155241;9471.323932433064;1684.8315168483177;1698.5583748225426;1725.663495618355;1788.50816025594;1826.3242600237998;47967.52032479666;48722;66303.00545491821;71464.6426767868;71907.92138117985;9346.065393460736;9420.623175073057;10021.298509104292;10038.598456061676;10138.645147419806;11764.823527647091;12450.564230251897;13532.255725935169;13535.458581656623;13551.932240338932;6359.411579719807;6435.22777266731;6551.312112228147;6592.406683398422;6907.171139463196;5794.594378393472;6085.908711369333;6123.2652081750475;6165.445109940127;6798.932010679929;4044.69664775143;4092.6725861930972;4105.384192371109;4128.318827393447;4165.187788381297;1740.4169603182822;1756.394044054799;1777.4845294864604;1790;1872.8127187281436;759.2976496740492;878.0297770963122;922.31748506105;961.5624890674866;993.3344659078434;16765.413210537572;17251.56871078208;17361;17532.2110505025;17803.68552088246;918.4489306416096;940.1303793990531;943.8851789095955;967.1778987860403;975.3416443900339;9458.385204961656;9747.171490423252;9796.216302695768;9851.507424628884;9940.25448091396;348414;394611;395021;396573;401312;48736;79790.20209797943;80064.19935800684;81165;81248.59375703083;905.5110240470073;915.8855143107112;916.8899732032199;934.621478301289;945.8675785390051;15345.539633811004;15366.615834604225;15370.615734606725;15445.61385965315;15830.44593439224;27741.861290693418;33251.00246992594;34954;36042.45936310905;36673.44989825101;34481.48277775886;43471.13057738891;43651;48297.517024830704;50811.23783143182;7151.2491188424465;7306.232845551353;7409.62951852416;7466.066741657293;7556.546607203585;10080.69757907264;11362.318260904372;11504.827427588425;11515.19393642437;11574.6527604172;8849;8999.145081217273;9014.368994170345;9034.186923176945;9649.951750241204;9756.804863902824;9840.901590983998;10066.8489972649;10070.093691567501;10209.642662506776;9123.726288211099;9319.627214911328;9457.33798634089;9685.467299298607;9764.121229089416;7520.7367742130955;7573.886391704019;7740.7677769667;7768.456208065607;7798.025246844145;6971.79084627462;7983.2415920487465;9112.453252804853;9167.816643666956;9282.907170928203 13:18:57 INFO - PROCESS | 31566 | |3;mootools.html;1255.522901297507;1370.1505066858547;1446.8553144685534;1509.856563626455;1734.7744793176878;6900.137482814648;7636.465447418683;7881.448298619099;7883.724069657563;8109.756707298776;7942.563159026251;7968.521888686683;7990;8024.638891249893;8032.598370081501;1916.5112896211447;2160.5570857974158;2240.406292332533;2280.1563421534056;2282.7032485776826;2282.258266063536;2326.9301920942316;2329.5457385809773;2331.895064722092;2334.2180369576213;2207.3267653365715;2232.2187234467888;2240.8991595378247;2242.9775702242932;2246.472079061419;1874.7000479923283;2081.8542702010864;2112.3240563019763;2122.4375540481783;2200.9559808803733;2223.9666405003936;2225.8219342452567;2254.8985295661732;2254.9549009019893;2255.4812393149505;7881.211878812131;7933.444658873824;7934.603269836485;7937.404694647925;7941.285284324381;4675.719456832601;4824.951750482521;4827.9034419311765;4829.323894654751;4832.685875418087;2960.570717246009;3063.6476805167467;3071.5699802027734;3072.877084916601;3086.861091250899;914.07221670005;919.9218066464292;951.6145960885852;953.7901661634429;954.6897258390982;10798.622048228275;10821.404822734747;10832.133429325635;10832.295900766503;10864.185186110994;4269.594388533084;4443.111377724404;4479.820807167742;4514.81940722374;4516.728996260234;9200.171984521425;9217.354785164975;9266.814663706822;9304.488253146006;9340.299477539076;4839.588634965997;4846.709197448165;4852.830150944771;4855.708657480563;4863.781129849165;3782.451544526028;3796.069962859062;3898.1229223424502;3908.159745654698;4223.049813791872;3486.2156014896955;3543.6987856032524;3780.2061567071223;3827.196288779332;3827.4547425961982;1216.1243904388825;1238.4055653286293;1247.8377810884526;1249.6813312605227;1259.9685007874878;719.453215556181;807.3420162567488;889.3374436045187;891.7483354529865;934.8223837470858;5221.660592061504;5244.846133850547;5287.947120528823;5295.523402893758;5339.038972984822;417.4677286459727;422.98731038068905;427.89944363074653;434.24224727850105;437.1541068033302;3691.870784522529;3852.730308878408;3856.7107466940092;3920.6863450923856;3933.449317095609;9407.29445291606;9760.511974401252;9810.313278070467;9815.165710914653;9838.458884761407;9667.951660241653;9734.269929755155;9734.756631084138;9739.513024348755;9778.266630002636;6831.59010459374;7131.643417829192;7134.250903655042;7390.852182956418;7466.887996680054;5536.390996990247;5548.694821784679;5559.221708960829;5566.888662226814;5696.971515142398;8782.209601135928;8864.42381245217;8879.822403551763;8920.375573709778;8969.50667713282;8579.613917373608;8912.955435223043;8933.374663773473;9083.227925626132;9241.537923103684;6130.969345153246;6592.604443733199;6827.112475378169;6844.247132815287;6852.862942741018;7669.3864490841715;7670.42471814605;7750.186230445722;7753.379729621504;7780.1052878919645;6667.099941507834;6786.117804685557;6863.897041544481;6912.170539535288;6993.895091573529;6797.1843378794865;6801.5238933274195;6809.455243580403;6923.653817309215;6987.371136597527;6004.699765011819;6182.474489668249;6186.81439556814;6560;6622.768203112868;4535.501094879494;4560.1335746208115;4583.472900616339;4655.23188673865;4669.509701481295;4592.655550833634;4602.723836569817;4625.352450656978;4676.929846052244;4710.1757192490495 13:18:57 INFO - PROCESS | 31566 | |4;prototype.html;292.6575906189758;301.1672724915609;304.9512078067509;316.2000139646695;316.8399958021199;4595.402597662308;4777.283407488879;4792;4817.397825271841;4827.155247831629;4585.220512512872;4667.29990501425;4707.90584188316;4717.481077081527;4742.834000809972;3752.08074021865;3756.267527832074;3762.6859481419006;3764.491793607869;3774.9056273593105;3546.308469848381;3651.872184473544;3770.472133901256;3775.6413140751583;3792.886213413602;3747.4566187902738;3784.6375304890357;3802.9239415211678;3805.7335986480957;3810.8856734298015;3742.9251414971686;3747.550293964728;3763.6989040876665;3775.3581891078584;3792.975896507955;3357.9496307555405;3359.6136444308727;3370.4101782188263;3381.1885147564653;3383.407903616882;4442.600165985044;4505.819767209307;4538.773061346919;4542.636589072867;4545.5908968193025;4300.376445415429;4314.892127696801;4317.309230523133;4325.394444777734;4345.587169218919;4783.751636730731;4954.108260513106;4963.305137280783;4972.204447288416;5014.924776128324;3528.0826984984087;3538.716902647782;3542.3446662367546;3542.875999340011;3559.6440355964455;5181.922271165936;5186.870328241786;5197.324347834795;5204.791808327663;5210.947890521084;3654.634536546377;3661.1945372018113;3678.7240956927803;3686.916891956036;3694.7598406103516;3551.804650744234;3713.2573485303046;3717.423799311111;3723.6594825862667;3753.6809371203753;4206.6003729646245;4216.936745948813;4219.409282700363;4256.106217694257;4279.914401711948;5018.799248030111;5027.271045698353;5028.497150285016;5039.319691841554;5046.974765126224;1191.5948577483698;1204.6085022367765;1236.0852968803201;1249.4127759952808;1270.5235536673747;817.5707753429378;824.4640983360863;830.2195935820309;839.2069494327801;847.7287268074157;3979.781112038808;4020.7587544747407;4032.697547683935;4041.8787436376956;4061.720558024213;4546;4571.862844114682;4587.9541204588195;4588.632909367243;4608.28571571407;3848.5381754189675;4018.5981401860163;4044.170944956277;4044.503533692494;4044.5955404459905;2401.7478164792797;2418.3833122553638;2447.1801946348173;2456.3245107595553;2468.60502319628;4264.594863487963;4351.69538132334;4360.149770794728;4403.669724770655;4404.66964977628;4457.7548234846745;4629.65277604181;4631.768411579407;4633.606143477842;4672.065586882569;4279.507856596407;4326.329418940007;4332.501762297313;4345.804438800198;4348.673849461303;4549.977250113729;4552.590266875997;4575.519570445055;4579.404677391918;4581.61056310204;4320.243957307396;4450.6884518083425;4469.709468884512;4512.842050528216;4535;4337.135031936297;4346.739195648272;4350.73895566267;4394.143142087262;4403.9779801100785;3270;3277.229850984969;3292.5555050067933;3298.175456135966;3323.7839540429795;4585.472670642919;4940.827071052496;4969.664257798829;5130.538251557377;5186.4035635902355;4901.14230009754;4901.995091006406;4927.359443272351;4955.033768415268;4955.82654607087;4967.552920237196;4970.577500912318;4987.401511818605;4991.376077990251;4998.325226094431;4735.550122738335;4877.829275975466;4887.90022244992;4896.853094407174;4924.482929292372;4946.406431228275;4957.231629097496;5001.4998500149695;5016.423111342242;5025.246213067923;4870.756462176806;4884.4613946606705;4897.8285759998225;4911.852644420673;4935.753212339297 13:18:57 INFO - PROCESS | 31566 | |5;yui.html;591.1163654788043;704.8484575816199;753.6834529497611;754.7282978127877;787.7754839870638;12234.571789987353;12346.938265308672;12411.627651170456;12426.751464970717;12532.310722910248;11740.002099821504;11784.587539436121;11873.465694043767;11877.7624447511;11924.463399147038;634.2199095113014;650.9479241660656;651.6546230497844;792.8533221354054;806.8305655812258;655.9114519539872;658.3087757854258;767.4742801181209;786.4101923557332;786.6106277392698;838.2078935406043;841.7264389073545;843.4686147726924;843.7890527368158;844.1347618690829;822.6092606012127;827.7268501394556;831.7005877883956;834.1741675741033;835.1606635331514;494.140196058855;501.2906736967187;504.3896884769433;615.4522474997256;615.704461858306;10310.639127630571;11705.765884682258;12094.939525302405;12127.454264558117;12621.558245461365;11597.942010289895;11831.230969986924;11921.225120367235;12055.819162712567;12359.75280494394;9521.761955951088;9692.903070969342;9846.113849753556;9851.21190304781;9891.010898910052;3242.96757032429;3261.3314270574474;3287.819169945652;3298.340331933599;3313.7017668409717;44751.77624111858;44907.550924490664;45017.324740128926;45168.77415612934;46528;9938.503074846229;9979.151772099307;10018.248631352677;10054.396736195706;10122.190224782;17393.478195654152;17508.12459377026;17577.560560986076;17602.383916563114;17604.647907042043;6419;6521.543491955613;6648.235452922879;6689.331066893369;6793.796186114425;3487.982560087234;3588.5693716753635;3619.9638003619625;3653;3707.647773461517;2719.2522056434245;2813.08574713219;2813.366992426688;2818.2390754496582;2821.1677555121287;504.3418339067552;506.07388479083187;506.1319836480454;517.9689218646894;518.1036806325003;488.75562218890553;585.5579037826413;589.8289496046099;600.6936462404205;616.3066550131102;7290.198078211392;7523.134839493418;7535.924640753632;7586.582737949356;7598.544087354777;605.2102006881063;615.4215037864393;620.2618883528587;626.2703949898317;626.8558231606664;3541.327147841902;3579.3736096183065;3634.273145370936;3654.543182102237;3748;54181.1872821908;54683.72658136684;54841.177382339294;55868.72065639646;55951.440485595434;43747.56252437498;45372.319415208796;49007;50263.49736502588;50585.49414505808;45417.545824541994;45726.54273457223;46225.537744622125;46281.537184628396;46727;8062.1534738853925;8190.590470476333;8237.382196335178;8240.629171687408;8548.316134709332;30852.53721194139;31032.22419439532;31075.37849243048;31234.531482028244;31494.685053150093;35952.64047359493;40657.18685626212;40675.79662101671;40816.1836763269;41695.166096678506;10254.743631409274;10396.844047339144;10456.16350691958;10601.840972385266;10623.681289561326;11730;11816.645500634995;11981.700457488632;12060.396980151132;12179.269243845398;10576.682699519026;10733.141348692243;11115.388653624128;11238.66284011481;11239.60661376848;10216.744581385228;10470.947645261725;10701.732456688645;10999.395033273247;11271.436428178395;10191.541380638037;10617.89382106169;10675.252732308663;11002.174836887425;11250.549978000789;9382.577783999599;9458.196053335269;9742.853857192005;9897.752556186153;10000.349977251455;8814.338924580554;9083.636654533744;9273.350865439625;9341.439513629204;9589.904100958902 13:18:57 INFO - PROCESS | 31566 | __end_tp_report 13:18:57 INFO - PROCESS | 31566 | __start_cc_report 13:18:57 INFO - PROCESS | 31566 | _x_x_mozilla_cycle_collect,979 13:18:57 INFO - PROCESS | 31566 | __end_cc_report 13:18:57 INFO - PROCESS | 31566 | __startTimestamp1464380337245__endTimestamp 13:18:57 INFO - PROCESS | 31566 | 13:18:57 INFO - PROCESS | 31566 | ------- Summary: start ------- 13:18:57 INFO - PROCESS | 31566 | Number of tests: 6 13:18:57 INFO - PROCESS | 31566 | 13:18:57 INFO - PROCESS | 31566 | [#0] dojo.html Cycles:165 Average:4778.24 Median:4891.56 stddev:503.15 (10.3%) stddev-sans-first:476.99 13:18:57 INFO - PROCESS | 31566 | Values: 2679.5 2681.0 2709.1 2724.8 2726.8 4691.2 4710.2 4735.0 4763.3 4824.3 4767.0 4771.3 4775.8 4776.1 4828.1 4294.5 4414.3 4457.5 4476.2 4564.0 4473.6 4509.9 4525.5 4532.2 4557.9 4349.0 4368.9 4387.9 4410.1 4428.8 4355.1 4373.8 4386.4 4428.2 4439.2 4388.7 4414.2 4421.2 4454.1 4460.4 4626.8 4676.6 4680.0 4684.0 4696.0 5092.8 5119.5 5133.1 5138.9 5139.7 5155.8 5174.5 5186.4 5187.8 5196.6 4781.5 4786.7 4843.5 4850.5 4913.6 5338.7 5348.8 5361.3 5392.8 5408.7 5112.5 5147.0 5167.9 5169.7 5169.8 5087.0 5118.5 5164.5 5176.8 5251.1 5146.7 5151.0 5151.9 5153.6 5155.8 5142.6 5143.3 5148.6 5151.9 5196.8 4356.6 4391.5 4396.0 4442.2 4448.8 3850.6 3904.9 3916.4 3916.5 3916.7 4405.6 4443.9 4461.2 4461.3 4480.4 5217.1 5218.5 5222.8 5232.4 5266.4 4451.4 4454.8 4460.7 4489.2 4505.0 4578.6 4647.7 4702.7 4722.6 4732.4 4881.5 4888.7 4891.6 4929.5 4935.8 5209.7 5214.1 5271.8 5274.7 5276.0 4743.3 4752.7 4773.0 4814.9 4886.0 5096.8 5117.1 5127.0 5129.7 5170.1 5183.2 5194.9 5203.4 5222.3 5225.3 4912.2 4941.0 4989.6 4997.1 5012.8 4980.0 5008.9 5010.3 5022.6 5068.8 4858.9 4957.5 4969.8 4975.7 5004.0 5055.8 5071.1 5072.4 5088.7 5106.4 5008.9 5014.7 5020.5 5021.7 5076.4 13:18:57 INFO - PROCESS | 31566 | 13:18:57 INFO - PROCESS | 31566 | [#1] ext.html Cycles:180 Average:47269.18 Median:201175.23 stddev:84655.81 (42.1%) stddev-sans-first:84820.80 13:18:57 INFO - PROCESS | 31566 | Values: 607.4 610.5 627.7 629.6 631.8 27550.4 29940.3 40877.0 41607.4 41746.0 42210.0 42337.8 42738.8 42748.0 42771.8 7478.1 7594.0 7596.5 7596.7 7606.7 7614.5 7764.8 7766.3 7773.9 7785.7 7762.6 7849.2 7854.9 7856.6 7863.5 7795.5 7855.4 7864.3 7868.1 7875.4 7684.1 7769.3 7770.7 7771.1 7777.5 36348.6 36490.6 36590.5 36663.3 36794.4 3035.5 3077.6 3188.5 3368.5 3545.6 29127.6 29848.7 29869.6 29984.3 30467.7 3507.7 3534.6 3542.7 3562.5 3572.8 253491.6 254052.0 254718.0 254752.0 254851.0 51895.5 51903.0 52218.7 52279.7 52296.5 49148.8 55086.0 55859.0 56175.0 61417.0 13321.8 13405.1 13409.8 13467.0 13468.4 10124.9 10218.7 10229.4 10236.7 10253.6 13705.6 15139.2 15357.3 15649.7 16038.7 6006.2 6038.6 6093.6 6099.8 6209.4 790.5 862.1 918.0 920.1 928.4 27880.4 28120.0 28145.0 28320.3 28371.9 843.3 964.7 977.6 982.6 1046.2 14488.3 14876.3 15051.0 15083.4 15149.5 361057.0 362914.0 364643.0 365289.0 365760.0 48304.5 48585.3 48719.8 48830.0 48883.3 1082.8 1143.4 1148.7 1162.8 1176.0 27712.7 28949.7 29160.0 29215.6 29316.0 41315.0 46578.5 47404.5 47751.0 51621.0 333936.0 334527.0 337694.0 338033.0 338774.3 22115.3 22282.8 22729.1 23066.8 25117.1 42393.4 42713.4 42767.0 42872.0 43681.0 36646.6 37124.3 37452.6 37511.0 37816.6 35899.8 36317.5 36537.6 36672.0 37174.4 35939.1 36315.8 36438.0 36760.8 37199.8 30398.0 31486.8 31555.5 31833.4 31940.7 23967.0 24375.5 24415.8 24605.6 24753.8 13:18:57 INFO - PROCESS | 31566 | 13:18:57 INFO - PROCESS | 31566 | [#2] jquery.html Cycles:180 Average:23352.49 Median:27959.11 stddev:63881.53 (228.5%) stddev-sans-first:64037.45 13:18:57 INFO - PROCESS | 31566 | Values: 378.9 382.4 388.5 394.5 403.8 13154.5 13862.2 15841.0 17611.2 17720.8 15793.5 16165.2 16687.8 18086.0 18146.8 4506.4 5129.8 5293.5 5323.4 5336.5 5107.0 5252.5 5255.1 5274.9 5308.4 5157.2 5189.7 5243.6 5246.7 5253.7 5051.3 5161.8 5170.9 5197.1 5200.3 4484.8 4667.5 4669.1 4672.1 4677.9 21070.8 21145.5 21253.5 21370.5 21524.8 1626.1 1763.6 1790.3 1906.2 1927.2 5182.7 5203.5 5229.2 9215.4 9471.3 1684.8 1698.6 1725.7 1788.5 1826.3 47967.5 48722.0 66303.0 71464.6 71907.9 9346.1 9420.6 10021.3 10038.6 10138.6 11764.8 12450.6 13532.3 13535.5 13551.9 6359.4 6435.2 6551.3 6592.4 6907.2 5794.6 6085.9 6123.3 6165.4 6798.9 4044.7 4092.7 4105.4 4128.3 4165.2 1740.4 1756.4 1777.5 1790.0 1872.8 759.3 878.0 922.3 961.6 993.3 16765.4 17251.6 17361.0 17532.2 17803.7 918.4 940.1 943.9 967.2 975.3 9458.4 9747.2 9796.2 9851.5 9940.3 348414.0 394611.0 395021.0 396573.0 401312.0 48736.0 79790.2 80064.2 81165.0 81248.6 905.5 915.9 916.9 934.6 945.9 15345.5 15366.6 15370.6 15445.6 15830.4 27741.9 33251.0 34954.0 36042.5 36673.4 34481.5 43471.1 43651.0 48297.5 50811.2 7151.2 7306.2 7409.6 7466.1 7556.5 10080.7 11362.3 11504.8 11515.2 11574.7 8849.0 8999.1 9014.4 9034.2 9650.0 9756.8 9840.9 10066.8 10070.1 10209.6 9123.7 9319.6 9457.3 9685.5 9764.1 7520.7 7573.9 7740.8 7768.5 7798.0 6971.8 7983.2 9112.5 9167.8 9282.9 13:18:57 INFO - PROCESS | 31566 | 13:18:57 INFO - PROCESS | 31566 | [#3] mootools.html Cycles:180 Average:5201.60 Median:5233.25 stddev:2915.17 (55.7%) stddev-sans-first:2908.27 13:18:57 INFO - PROCESS | 31566 | Values: 1255.5 1370.2 1446.9 1509.9 1734.8 6900.1 7636.5 7881.4 7883.7 8109.8 7942.6 7968.5 7990.0 8024.6 8032.6 1916.5 2160.6 2240.4 2280.2 2282.7 2282.3 2326.9 2329.5 2331.9 2334.2 2207.3 2232.2 2240.9 2243.0 2246.5 1874.7 2081.9 2112.3 2122.4 2201.0 2224.0 2225.8 2254.9 2255.0 2255.5 7881.2 7933.4 7934.6 7937.4 7941.3 4675.7 4825.0 4827.9 4829.3 4832.7 2960.6 3063.6 3071.6 3072.9 3086.9 914.1 919.9 951.6 953.8 954.7 10798.6 10821.4 10832.1 10832.3 10864.2 4269.6 4443.1 4479.8 4514.8 4516.7 9200.2 9217.4 9266.8 9304.5 9340.3 4839.6 4846.7 4852.8 4855.7 4863.8 3782.5 3796.1 3898.1 3908.2 4223.0 3486.2 3543.7 3780.2 3827.2 3827.5 1216.1 1238.4 1247.8 1249.7 1260.0 719.5 807.3 889.3 891.7 934.8 5221.7 5244.8 5287.9 5295.5 5339.0 417.5 423.0 427.9 434.2 437.2 3691.9 3852.7 3856.7 3920.7 3933.4 9407.3 9760.5 9810.3 9815.2 9838.5 9668.0 9734.3 9734.8 9739.5 9778.3 6831.6 7131.6 7134.3 7390.9 7466.9 5536.4 5548.7 5559.2 5566.9 5697.0 8782.2 8864.4 8879.8 8920.4 8969.5 8579.6 8913.0 8933.4 9083.2 9241.5 6131.0 6592.6 6827.1 6844.2 6852.9 7669.4 7670.4 7750.2 7753.4 7780.1 6667.1 6786.1 6863.9 6912.2 6993.9 6797.2 6801.5 6809.5 6923.7 6987.4 6004.7 6182.5 6186.8 6560.0 6622.8 4535.5 4560.1 4583.5 4655.2 4669.5 4592.7 4602.7 4625.4 4676.9 4710.2 13:18:57 INFO - PROCESS | 31566 | 13:18:57 INFO - PROCESS | 31566 | [#4] prototype.html Cycles:180 Average:4000.11 Median:4355.92 stddev:1148.12 (26.4%) stddev-sans-first:1117.11 13:18:57 INFO - PROCESS | 31566 | Values: 292.7 301.2 305.0 316.2 316.8 4595.4 4777.3 4792.0 4817.4 4827.2 4585.2 4667.3 4707.9 4717.5 4742.8 3752.1 3756.3 3762.7 3764.5 3774.9 3546.3 3651.9 3770.5 3775.6 3792.9 3747.5 3784.6 3802.9 3805.7 3810.9 3742.9 3747.6 3763.7 3775.4 3793.0 3357.9 3359.6 3370.4 3381.2 3383.4 4442.6 4505.8 4538.8 4542.6 4545.6 4300.4 4314.9 4317.3 4325.4 4345.6 4783.8 4954.1 4963.3 4972.2 5014.9 3528.1 3538.7 3542.3 3542.9 3559.6 5181.9 5186.9 5197.3 5204.8 5210.9 3654.6 3661.2 3678.7 3686.9 3694.8 3551.8 3713.3 3717.4 3723.7 3753.7 4206.6 4216.9 4219.4 4256.1 4279.9 5018.8 5027.3 5028.5 5039.3 5047.0 1191.6 1204.6 1236.1 1249.4 1270.5 817.6 824.5 830.2 839.2 847.7 3979.8 4020.8 4032.7 4041.9 4061.7 4546.0 4571.9 4588.0 4588.6 4608.3 3848.5 4018.6 4044.2 4044.5 4044.6 2401.7 2418.4 2447.2 2456.3 2468.6 4264.6 4351.7 4360.1 4403.7 4404.7 4457.8 4629.7 4631.8 4633.6 4672.1 4279.5 4326.3 4332.5 4345.8 4348.7 4550.0 4552.6 4575.5 4579.4 4581.6 4320.2 4450.7 4469.7 4512.8 4535.0 4337.1 4346.7 4350.7 4394.1 4404.0 3270.0 3277.2 3292.6 3298.2 3323.8 4585.5 4940.8 4969.7 5130.5 5186.4 4901.1 4902.0 4927.4 4955.0 4955.8 4967.6 4970.6 4987.4 4991.4 4998.3 4735.6 4877.8 4887.9 4896.9 4924.5 4946.4 4957.2 5001.5 5016.4 5025.2 4870.8 4884.5 4897.8 4911.9 4935.8 13:18:57 INFO - PROCESS | 31566 | 13:18:57 INFO - PROCESS | 31566 | [#5] yui.html Cycles:180 Average:12950.01 Median:45572.04 stddev:15056.13 (33.0%) stddev-sans-first:15069.76 13:18:57 INFO - PROCESS | 31566 | Values: 591.1 704.8 753.7 754.7 787.8 12234.6 12346.9 12411.6 12426.8 12532.3 11740.0 11784.6 11873.5 11877.8 11924.5 634.2 650.9 651.7 792.9 806.8 655.9 658.3 767.5 786.4 786.6 838.2 841.7 843.5 843.8 844.1 822.6 827.7 831.7 834.2 835.2 494.1 501.3 504.4 615.5 615.7 10310.6 11705.8 12094.9 12127.5 12621.6 11597.9 11831.2 11921.2 12055.8 12359.8 9521.8 9692.9 9846.1 9851.2 9891.0 3243.0 3261.3 3287.8 3298.3 3313.7 44751.8 44907.6 45017.3 45168.8 46528.0 9938.5 9979.2 10018.2 10054.4 10122.2 17393.5 17508.1 17577.6 17602.4 17604.6 6419.0 6521.5 6648.2 6689.3 6793.8 3488.0 3588.6 3620.0 3653.0 3707.6 2719.3 2813.1 2813.4 2818.2 2821.2 504.3 506.1 506.1 518.0 518.1 488.8 585.6 589.8 600.7 616.3 7290.2 7523.1 7535.9 7586.6 7598.5 605.2 615.4 620.3 626.3 626.9 3541.3 3579.4 3634.3 3654.5 3748.0 54181.2 54683.7 54841.2 55868.7 55951.4 43747.6 45372.3 49007.0 50263.5 50585.5 45417.5 45726.5 46225.5 46281.5 46727.0 8062.2 8190.6 8237.4 8240.6 8548.3 30852.5 31032.2 31075.4 31234.5 31494.7 35952.6 40657.2 40675.8 40816.2 41695.2 10254.7 10396.8 10456.2 10601.8 10623.7 11730.0 11816.6 11981.7 12060.4 12179.3 10576.7 10733.1 11115.4 11238.7 11239.6 10216.7 10470.9 10701.7 10999.4 11271.4 10191.5 10617.9 10675.3 11002.2 11250.5 9382.6 9458.2 9742.9 9897.8 10000.3 8814.3 9083.6 9273.4 9341.4 9589.9 13:18:57 INFO - PROCESS | 31566 | -------- Summary: end -------- 13:18:57 INFO - PROCESS | 31566 | 13:18:57 INFO - TEST-INFO | 31566: exit 0 13:18:58 INFO - TEST-OK | dromaeo_css | took 1119392ms 13:18:58 INFO - TEST-START | kraken 13:18:58 INFO - operating with platform_type : linux_ 13:18:58 INFO - Initialising browser for kraken test... 13:18:58 INFO - TEST-INFO | started process 31753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG249AI/profile http://localhost:39085/getInfo.html) 13:19:02 INFO - PROCESS | 31753 | __metrics Screen width/height:1600/1200 13:19:02 INFO - PROCESS | 31753 | colorDepth:24 13:19:02 INFO - PROCESS | 31753 | Browser inner width/height: 1024/697 13:19:02 INFO - PROCESS | 31753 | __metrics 13:19:03 ERROR - PROCESS | 31753 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:19:04 INFO - TEST-INFO | 31753: exit 0 13:19:04 INFO - Browser initialized. 13:19:04 INFO - Running cycle 1/1 for kraken test... 13:19:04 INFO - TEST-INFO | started process 31836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG249AI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:16 INFO - PROCESS | 31836 | RSS: Main: 157302784 13:19:16 INFO - PROCESS | 31836 | 13:19:19 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39085/tests/kraken/driver.html?testName=audio-beat-detection) 13:19:20 INFO - PROCESS | 31836 | RSS: Main: 213868544 13:19:20 INFO - PROCESS | 31836 | 13:19:23 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39085/tests/kraken/driver.html?testName=audio-dft) 13:19:23 INFO - PROCESS | 31836 | RSS: Main: 202256384 13:19:23 INFO - PROCESS | 31836 | 13:19:26 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39085/tests/kraken/driver.html?testName=audio-fft) 13:19:27 INFO - PROCESS | 31836 | RSS: Main: 269987840 13:19:27 INFO - PROCESS | 31836 | 13:19:29 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39085/tests/kraken/driver.html?testName=audio-oscillator) 13:19:30 INFO - PROCESS | 31836 | RSS: Main: 180183040 13:19:30 INFO - PROCESS | 31836 | 13:19:32 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39085/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:19:33 INFO - PROCESS | 31836 | RSS: Main: 183861248 13:19:33 INFO - PROCESS | 31836 | 13:19:36 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39085/tests/kraken/driver.html?testName=imaging-darkroom) 13:19:36 INFO - PROCESS | 31836 | RSS: Main: 220364800 13:19:36 INFO - PROCESS | 31836 | 13:19:40 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39085/tests/kraken/driver.html?testName=imaging-desaturate) 13:19:41 INFO - PROCESS | 31836 | RSS: Main: 216236032 13:19:41 INFO - PROCESS | 31836 | 13:19:43 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39085/tests/kraken/driver.html?testName=json-parse-financial) 13:19:44 INFO - PROCESS | 31836 | RSS: Main: 218718208 13:19:44 INFO - PROCESS | 31836 | 13:19:46 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39085/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:19:46 INFO - PROCESS | 31836 | RSS: Main: 207429632 13:19:46 INFO - PROCESS | 31836 | 13:19:48 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:19:49 INFO - PROCESS | 31836 | RSS: Main: 210001920 13:19:49 INFO - PROCESS | 31836 | 13:19:51 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:19:52 INFO - PROCESS | 31836 | RSS: Main: 215953408 13:19:52 INFO - PROCESS | 31836 | 13:19:55 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:19:55 INFO - PROCESS | 31836 | RSS: Main: 222334976 13:19:55 INFO - PROCESS | 31836 | 13:19:58 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:19:59 INFO - PROCESS | 31836 | RSS: Main: 222969856 13:19:59 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39085/tests/kraken/driver.html?testName=ai-astar) 13:20:01 INFO - PROCESS | 31836 | RSS: Main: 266235904 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | __start_tp_report 13:20:01 INFO - PROCESS | 31836 | _x_x_mozilla_page_load 13:20:01 INFO - PROCESS | 31836 | _x_x_mozilla_page_load_details 13:20:01 INFO - PROCESS | 31836 | |i|pagename|runs| 13:20:01 INFO - PROCESS | 31836 | |0;ai-astar;114;109;116;115;115;115;115;115;114;113 13:20:01 INFO - PROCESS | 31836 | |1;audio-beat-detection;158;131;130;201;133;129;157;133;165;138 13:20:01 INFO - PROCESS | 31836 | |2;audio-dft;162;163;161;162;162;161;162;163;163;162 13:20:01 INFO - PROCESS | 31836 | |3;audio-fft;77;76;75;107;75;76;75;75;107;76 13:20:01 INFO - PROCESS | 31836 | |4;audio-oscillator;85;85;119;84;85;85;126;84;85;124 13:20:01 INFO - PROCESS | 31836 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 13:20:01 INFO - PROCESS | 31836 | |6;imaging-darkroom;147;146;146;146;146;147;146;146;146;148 13:20:01 INFO - PROCESS | 31836 | |7;imaging-desaturate;95;96;96;95;94;95;95;94;94;95 13:20:01 INFO - PROCESS | 31836 | |8;json-parse-financial;64;65;65;66;81;65;65;65;64;66 13:20:01 INFO - PROCESS | 31836 | |9;json-stringify-tinderbox;66;66;66;66;66;65;66;66;65;66 13:20:01 INFO - PROCESS | 31836 | |10;stanford-crypto-aes;82;84;83;82;85;90;87;85;121;84 13:20:01 INFO - PROCESS | 31836 | |11;stanford-crypto-ccm;138;138;131;131;131;137;131;127;133;142 13:20:01 INFO - PROCESS | 31836 | |12;stanford-crypto-pbkdf2;173;168;168;170;169;176;172;167;169;169 13:20:01 INFO - PROCESS | 31836 | |13;stanford-crypto-sha256-iterative;67;67;66;67;66;66;68;67;69;66 13:20:01 INFO - PROCESS | 31836 | __end_tp_report 13:20:01 INFO - PROCESS | 31836 | __start_cc_report 13:20:01 INFO - PROCESS | 31836 | _x_x_mozilla_cycle_collect,1872 13:20:01 INFO - PROCESS | 31836 | __end_cc_report 13:20:01 INFO - PROCESS | 31836 | __startTimestamp1464380401301__endTimestamp 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | ------- Summary: start ------- 13:20:01 INFO - PROCESS | 31836 | Number of tests: 14 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:1.97 (1.7%) stddev-sans-first:2.09 13:20:01 INFO - PROCESS | 31836 | Values: 114.0 109.0 116.0 115.0 115.0 115.0 115.0 115.0 114.0 113.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:147.50 stddev:23.10 (15.7%) stddev-sans-first:24.18 13:20:01 INFO - PROCESS | 31836 | Values: 158.0 131.0 130.0 201.0 133.0 129.0 157.0 133.0 165.0 138.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 13:20:01 INFO - PROCESS | 31836 | Values: 162.0 163.0 161.0 162.0 162.0 161.0 162.0 163.0 163.0 162.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.50 stddev:13.25 (17.5%) stddev-sans-first:13.93 13:20:01 INFO - PROCESS | 31836 | Values: 77.0 76.0 75.0 107.0 75.0 76.0 75.0 75.0 107.0 76.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.58 (21.9%) stddev-sans-first:19.26 13:20:01 INFO - PROCESS | 31836 | Values: 85.0 85.0 119.0 84.0 85.0 85.0 126.0 84.0 85.0 124.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:20:01 INFO - PROCESS | 31836 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 13:20:01 INFO - PROCESS | 31836 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 148.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 13:20:01 INFO - PROCESS | 31836 | Values: 95.0 96.0 96.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:65.00 stddev:5.10 (7.9%) stddev-sans-first:5.33 13:20:01 INFO - PROCESS | 31836 | Values: 64.0 65.0 65.0 66.0 81.0 65.0 65.0 65.0 64.0 66.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 13:20:01 INFO - PROCESS | 31836 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 65.0 66.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:84.50 stddev:11.74 (13.9%) stddev-sans-first:12.23 13:20:01 INFO - PROCESS | 31836 | Values: 82.0 84.0 83.0 82.0 85.0 90.0 87.0 85.0 121.0 84.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:135.00 stddev:4.61 (3.4%) stddev-sans-first:4.64 13:20:01 INFO - PROCESS | 31836 | Values: 138.0 138.0 131.0 131.0 131.0 137.0 131.0 127.0 133.0 142.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:169.50 stddev:2.77 (1.6%) stddev-sans-first:2.73 13:20:01 INFO - PROCESS | 31836 | Values: 173.0 168.0 168.0 170.0 169.0 176.0 172.0 167.0 169.0 169.0 13:20:01 INFO - PROCESS | 31836 | 13:20:01 INFO - PROCESS | 31836 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 13:20:01 INFO - PROCESS | 31836 | Values: 67.0 67.0 66.0 67.0 66.0 66.0 68.0 67.0 69.0 66.0 13:20:01 INFO - PROCESS | 31836 | -------- Summary: end -------- 13:20:01 INFO - PROCESS | 31836 | 13:20:02 INFO - TEST-INFO | 31836: exit 0 13:20:02 INFO - TEST-OK | kraken | took 64416ms 13:20:02 INFO - SUITE-END | took 1183s 13:20:02 INFO - Completed test suite (00:19:43) 13:20:02 INFO - javascript benchmark 13:20:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2679.517686816373, 2680.986595067024, 2709.0518318588493, 2724.7683946864518, 2726.7682247009, 4691.15559199344, 4710.246360582308, 4734.9526504734895, 4763.261694437359, 4824.348712923755, 4767.0, 4771.30816031676, 4775.808967641299, 4776.068666610013, 4828.0585285869265, 4294.506131794845, 4414.29371300592, 4457.465104187502, 4476.2390393632995, 4564.0, 4473.597376236138, 4509.864704058867, 4525.47956984946, 4532.206863798839, 4557.886052848672, 4349.043210493702, 4368.89077773055, 4387.868363949086, 4410.095930334273, 4428.800703968329, 4355.085432059272, 4373.7813109344725, 4386.407834942306, 4428.180786554498, 4439.178751930871, 4388.71473354231, 4414.161309351213, 4421.226285400042, 4454.0646464242545, 4460.420145381112, 4626.791794369262, 4676.555727205944, 4680.040591678698, 4684.0, 4695.95304046962, 5092.79628814847, 5119.488051194888, 5133.076046311662, 5138.948610513884, 5139.743012849342, 5155.793768249266, 5174.4825517448335, 5186.429492755831, 5187.83273763404, 5196.636235463481, 4781.497942716034, 4786.736729479877, 4843.467218605951, 4850.53919877611, 4913.557779799764, 5338.706371149624, 5348.812791552355, 5361.303030605996, 5392.78428862849, 5408.729563521808, 5112.539871411516, 5147.0, 5167.9224811627855, 5169.741512924339, 5169.819056333085, 5087.0, 5118.539331460186, 5164.535191832753, 5176.818811341585, 5251.081060814342, 5146.691198528026, 5151.021305951932, 5151.922721159186, 5153.613478989091, 5155.819546315936, 5142.640015198975, 5143.305653736697, 5148.562372198405, 5151.9484805152215, 5196.76614552346, 4356.607905288539, 4391.538888416734, 4396.032872767986, 4442.178197033494, 4448.799804008828, 3850.614938506183, 3904.941425878614, 3916.4321173429694, 3916.4712763777097, 3916.706247031484, 4405.647548196137, 4443.933340999887, 4461.196984542814, 4461.330800379904, 4480.350349199348, 5217.0870097733505, 5218.478152184827, 5222.764975576109, 5232.372115346183, 5266.3943646480375, 4451.421315229064, 4454.844080457233, 4460.687751857339, 4489.169503641837, 4505.031418245093, 4578.610818080434, 4647.651426143053, 4702.741349225757, 4722.5513576210205, 4732.361131247307, 4881.487443818348, 4888.65779395446, 4891.559759621651, 4929.507049295042, 4935.8025678972435, 5209.661372010807, 5214.113600687968, 5271.762770675252, 5274.657147285414, 5276.023935571931, 4743.264793956804, 4752.691075080109, 4772.976135119302, 4814.903701926012, 4886.047220791911, 5096.796128154832, 5117.053345131163, 5126.974365128151, 5129.692218466904, 5170.146925757358, 5183.196604526304, 5194.922076168936, 5203.427622961547, 5222.3472065991755, 5225.320708307896, 4912.214045752662, 4940.950590494049, 4989.60083193351, 4997.0505603935135, 5012.774425150804, 4979.950200498093, 5008.87477813043, 5010.273510341053, 5022.648414610942, 5068.797248110034, 4858.878528036827, 4957.504249575158, 4969.776360063878, 4975.676581022222, 5003.974980125076, 5055.823046193365, 5071.112555302881, 5072.365954255718, 5088.720120393414, 5106.387233532, 5008.899822003613, 5014.749262536931, 5020.548150666457, 5021.748912554431, 5076.36545431821], "value": 4746.09881386697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.4411541381929, 610.5054905526524, 627.7206643043846, 629.6096420219465, 631.7946667333118, 27550.448991020166, 29940.25149371267, 40877.0, 41607.37588936161, 41746.0, 42210.0, 42337.7883110584, 42738.786306068505, 42748.0, 42771.78614106933, 7478.065241844783, 7593.9620301898685, 7596.5062270952485, 7596.696132154707, 7606.73376431825, 7614.505057171294, 7764.805879852993, 7766.339861111812, 7773.883391749128, 7785.727499537517, 7762.573058481781, 7849.215078492162, 7854.921450785505, 7856.646450909694, 7863.52818830872, 7795.532268063906, 7855.371570274365, 7864.2922137007945, 7868.134505204423, 7875.4487185897015, 7684.077910650702, 7769.339606133485, 7770.689172433096, 7771.145174030852, 7777.533347999138, 36348.63651363505, 36490.63509364925, 36590.45114323287, 36663.26673466543, 36794.448083278774, 3035.4839677254918, 3077.6306843178736, 3188.473901806199, 3368.528406023159, 3545.6099829018785, 29127.563086553717, 29848.701512984808, 29869.55195672045, 29984.25039374033, 30467.695323046708, 3507.736919731005, 3534.6465353464446, 3542.681158695704, 3562.4656301554714, 3572.8392222350058, 253491.59287831906, 254052.0, 254718.0, 254752.0, 254851.0, 51895.48104518982, 51903.0, 52218.738906305225, 52279.73860130751, 52296.47703522916, 49148.75425622921, 55086.0, 55859.0, 56175.0, 61417.0, 13321.800172997413, 13405.06164568471, 13409.798853017213, 13467.0, 13468.39392227352, 10124.949375253223, 10218.693439196835, 10229.386236825814, 10236.692899213036, 10253.641122560675, 13705.629437056215, 15139.167345795866, 15357.308921098578, 15649.68700626004, 16038.67922641564, 6006.189164462829, 6038.5772995889865, 6093.573449858467, 6099.8475038123515, 6209.410106039919, 790.5217343507211, 862.0904945282787, 917.9724608261763, 920.1442658327686, 928.3687092776842, 27880.442391152064, 28120.042701359926, 28145.0, 28320.291992700346, 28371.858140709166, 843.2797736720336, 964.7009427077488, 977.6480467031863, 982.597135174575, 1046.1735229169024, 14488.34802433893, 14876.330565124379, 15051.0, 15083.396664133532, 15149.545513634388, 361057.0, 362914.0, 364643.0, 365289.0, 365760.0, 48304.516954830004, 48585.27122093172, 48719.756401218474, 48830.0, 48883.266750998766, 1082.7726177502655, 1143.382573410349, 1148.7472755993667, 1162.7558212775243, 1175.9941200293945, 27712.722872771013, 28949.7105028947, 29160.0, 29215.561766573945, 29316.0, 41315.0, 46578.53421465742, 47404.52595474001, 47751.0, 51621.0, 333936.0, 334527.0, 337694.0, 338033.0, 338774.3061284678, 22115.34134939854, 22282.77717222807, 22729.09083636636, 23066.769332306463, 25117.120900769118, 42393.36409953792, 42713.35929960991, 42767.0, 42872.0, 43681.0, 36646.63353366539, 37124.25751485009, 37452.625473746004, 37511.0, 37816.62183378131, 35899.7622169155, 36317.45523817092, 36537.634623654485, 36672.0, 37174.44238336481, 35939.101522462144, 36315.81842090773, 36438.0, 36760.81619591992, 37199.81400092982, 30398.0, 31486.84256578794, 31555.526667100472, 31833.36333273368, 31940.680593194702, 23967.0, 24375.51248975046, 24415.75584244206, 24605.63091553664, 24753.752462475146], "value": 17329.832213635218, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.8673964112561, 382.39390565952965, 388.5298788465956, 394.48716668331195, 403.7537102367557, 13154.53959111429, 13862.237576933265, 15841.0, 17611.207495662693, 17720.822791772094, 15793.526194214162, 16165.19174041299, 16687.83312166878, 18086.0, 18146.81853181468, 4506.369108324837, 5129.794808207676, 5293.470652934714, 5323.44103869092, 5336.4930331618625, 5106.974465127669, 5252.52727254547, 5255.106631872591, 5274.894502109955, 5308.442613525582, 5157.174852023677, 5189.688618682872, 5243.606729495284, 5246.658967167141, 5253.658512196714, 5051.318072060261, 5161.845144645667, 5170.870728231825, 5197.116490196676, 5200.2979597754575, 4484.843030493949, 4667.509911459282, 4669.066186762661, 4672.065586882637, 4677.906441871178, 21070.789292107034, 21145.47136321589, 21253.468663283387, 21370.46573835651, 21524.784752152435, 1626.1300204390595, 1763.647270545896, 1790.2928343304322, 1906.218450435315, 1927.171316333976, 5182.663126896778, 5203.4796520348045, 5229.2156176573435, 9215.354925155241, 9471.323932433064, 1684.8315168483177, 1698.5583748225426, 1725.663495618355, 1788.50816025594, 1826.3242600237998, 47967.52032479666, 48722.0, 66303.00545491821, 71464.6426767868, 71907.92138117985, 9346.065393460736, 9420.623175073057, 10021.298509104292, 10038.598456061676, 10138.645147419806, 11764.823527647091, 12450.564230251897, 13532.255725935169, 13535.458581656623, 13551.932240338932, 6359.411579719807, 6435.22777266731, 6551.312112228147, 6592.406683398422, 6907.171139463196, 5794.594378393472, 6085.908711369333, 6123.2652081750475, 6165.445109940127, 6798.932010679929, 4044.69664775143, 4092.6725861930972, 4105.384192371109, 4128.318827393447, 4165.187788381297, 1740.4169603182822, 1756.394044054799, 1777.4845294864604, 1790.0, 1872.8127187281436, 759.2976496740492, 878.0297770963122, 922.31748506105, 961.5624890674866, 993.3344659078434, 16765.413210537572, 17251.56871078208, 17361.0, 17532.2110505025, 17803.68552088246, 918.4489306416096, 940.1303793990531, 943.8851789095955, 967.1778987860403, 975.3416443900339, 9458.385204961656, 9747.171490423252, 9796.216302695768, 9851.507424628884, 9940.25448091396, 348414.0, 394611.0, 395021.0, 396573.0, 401312.0, 48736.0, 79790.20209797943, 80064.19935800684, 81165.0, 81248.59375703083, 905.5110240470073, 915.8855143107112, 916.8899732032199, 934.621478301289, 945.8675785390051, 15345.539633811004, 15366.615834604225, 15370.615734606725, 15445.61385965315, 15830.44593439224, 27741.861290693418, 33251.00246992594, 34954.0, 36042.45936310905, 36673.44989825101, 34481.48277775886, 43471.13057738891, 43651.0, 48297.517024830704, 50811.23783143182, 7151.2491188424465, 7306.232845551353, 7409.62951852416, 7466.066741657293, 7556.546607203585, 10080.69757907264, 11362.318260904372, 11504.827427588425, 11515.19393642437, 11574.6527604172, 8849.0, 8999.145081217273, 9014.368994170345, 9034.186923176945, 9649.951750241204, 9756.804863902824, 9840.901590983998, 10066.8489972649, 10070.093691567501, 10209.642662506776, 9123.726288211099, 9319.627214911328, 9457.33798634089, 9685.467299298607, 9764.121229089416, 7520.7367742130955, 7573.886391704019, 7740.7677769667, 7768.456208065607, 7798.025246844145, 6971.79084627462, 7983.2415920487465, 9112.453252804853, 9167.816643666956, 9282.907170928203], "value": 7834.85813783845, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.522901297507, 1370.1505066858547, 1446.8553144685534, 1509.856563626455, 1734.7744793176878, 6900.137482814648, 7636.465447418683, 7881.448298619099, 7883.724069657563, 8109.756707298776, 7942.563159026251, 7968.521888686683, 7990.0, 8024.638891249893, 8032.598370081501, 1916.5112896211447, 2160.5570857974158, 2240.406292332533, 2280.1563421534056, 2282.7032485776826, 2282.258266063536, 2326.9301920942316, 2329.5457385809773, 2331.895064722092, 2334.2180369576213, 2207.3267653365715, 2232.2187234467888, 2240.8991595378247, 2242.9775702242932, 2246.472079061419, 1874.7000479923283, 2081.8542702010864, 2112.3240563019763, 2122.4375540481783, 2200.9559808803733, 2223.9666405003936, 2225.8219342452567, 2254.8985295661732, 2254.9549009019893, 2255.4812393149505, 7881.211878812131, 7933.444658873824, 7934.603269836485, 7937.404694647925, 7941.285284324381, 4675.719456832601, 4824.951750482521, 4827.9034419311765, 4829.323894654751, 4832.685875418087, 2960.570717246009, 3063.6476805167467, 3071.5699802027734, 3072.877084916601, 3086.861091250899, 914.07221670005, 919.9218066464292, 951.6145960885852, 953.7901661634429, 954.6897258390982, 10798.622048228275, 10821.404822734747, 10832.133429325635, 10832.295900766503, 10864.185186110994, 4269.594388533084, 4443.111377724404, 4479.820807167742, 4514.81940722374, 4516.728996260234, 9200.171984521425, 9217.354785164975, 9266.814663706822, 9304.488253146006, 9340.299477539076, 4839.588634965997, 4846.709197448165, 4852.830150944771, 4855.708657480563, 4863.781129849165, 3782.451544526028, 3796.069962859062, 3898.1229223424502, 3908.159745654698, 4223.049813791872, 3486.2156014896955, 3543.6987856032524, 3780.2061567071223, 3827.196288779332, 3827.4547425961982, 1216.1243904388825, 1238.4055653286293, 1247.8377810884526, 1249.6813312605227, 1259.9685007874878, 719.453215556181, 807.3420162567488, 889.3374436045187, 891.7483354529865, 934.8223837470858, 5221.660592061504, 5244.846133850547, 5287.947120528823, 5295.523402893758, 5339.038972984822, 417.4677286459727, 422.98731038068905, 427.89944363074653, 434.24224727850105, 437.1541068033302, 3691.870784522529, 3852.730308878408, 3856.7107466940092, 3920.6863450923856, 3933.449317095609, 9407.29445291606, 9760.511974401252, 9810.313278070467, 9815.165710914653, 9838.458884761407, 9667.951660241653, 9734.269929755155, 9734.756631084138, 9739.513024348755, 9778.266630002636, 6831.59010459374, 7131.643417829192, 7134.250903655042, 7390.852182956418, 7466.887996680054, 5536.390996990247, 5548.694821784679, 5559.221708960829, 5566.888662226814, 5696.971515142398, 8782.209601135928, 8864.42381245217, 8879.822403551763, 8920.375573709778, 8969.50667713282, 8579.613917373608, 8912.955435223043, 8933.374663773473, 9083.227925626132, 9241.537923103684, 6130.969345153246, 6592.604443733199, 6827.112475378169, 6844.247132815287, 6852.862942741018, 7669.3864490841715, 7670.42471814605, 7750.186230445722, 7753.379729621504, 7780.1052878919645, 6667.099941507834, 6786.117804685557, 6863.897041544481, 6912.170539535288, 6993.895091573529, 6797.1843378794865, 6801.5238933274195, 6809.455243580403, 6923.653817309215, 6987.371136597527, 6004.699765011819, 6182.474489668249, 6186.81439556814, 6560.0, 6622.768203112868, 4535.501094879494, 4560.1335746208115, 4583.472900616339, 4655.23188673865, 4669.509701481295, 4592.655550833634, 4602.723836569817, 4625.352450656978, 4676.929846052244, 4710.1757192490495], "value": 4127.336061272525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.6575906189758, 301.1672724915609, 304.9512078067509, 316.2000139646695, 316.8399958021199, 4595.402597662308, 4777.283407488879, 4792.0, 4817.397825271841, 4827.155247831629, 4585.220512512872, 4667.29990501425, 4707.90584188316, 4717.481077081527, 4742.834000809972, 3752.08074021865, 3756.267527832074, 3762.6859481419006, 3764.491793607869, 3774.9056273593105, 3546.308469848381, 3651.872184473544, 3770.472133901256, 3775.6413140751583, 3792.886213413602, 3747.4566187902738, 3784.6375304890357, 3802.9239415211678, 3805.7335986480957, 3810.8856734298015, 3742.9251414971686, 3747.550293964728, 3763.6989040876665, 3775.3581891078584, 3792.975896507955, 3357.9496307555405, 3359.6136444308727, 3370.4101782188263, 3381.1885147564653, 3383.407903616882, 4442.600165985044, 4505.819767209307, 4538.773061346919, 4542.636589072867, 4545.5908968193025, 4300.376445415429, 4314.892127696801, 4317.309230523133, 4325.394444777734, 4345.587169218919, 4783.751636730731, 4954.108260513106, 4963.305137280783, 4972.204447288416, 5014.924776128324, 3528.0826984984087, 3538.716902647782, 3542.3446662367546, 3542.875999340011, 3559.6440355964455, 5181.922271165936, 5186.870328241786, 5197.324347834795, 5204.791808327663, 5210.947890521084, 3654.634536546377, 3661.1945372018113, 3678.7240956927803, 3686.916891956036, 3694.7598406103516, 3551.804650744234, 3713.2573485303046, 3717.423799311111, 3723.6594825862667, 3753.6809371203753, 4206.6003729646245, 4216.936745948813, 4219.409282700363, 4256.106217694257, 4279.914401711948, 5018.799248030111, 5027.271045698353, 5028.497150285016, 5039.319691841554, 5046.974765126224, 1191.5948577483698, 1204.6085022367765, 1236.0852968803201, 1249.4127759952808, 1270.5235536673747, 817.5707753429378, 824.4640983360863, 830.2195935820309, 839.2069494327801, 847.7287268074157, 3979.781112038808, 4020.7587544747407, 4032.697547683935, 4041.8787436376956, 4061.720558024213, 4546.0, 4571.862844114682, 4587.9541204588195, 4588.632909367243, 4608.28571571407, 3848.5381754189675, 4018.5981401860163, 4044.170944956277, 4044.503533692494, 4044.5955404459905, 2401.7478164792797, 2418.3833122553638, 2447.1801946348173, 2456.3245107595553, 2468.60502319628, 4264.594863487963, 4351.69538132334, 4360.149770794728, 4403.669724770655, 4404.66964977628, 4457.7548234846745, 4629.65277604181, 4631.768411579407, 4633.606143477842, 4672.065586882569, 4279.507856596407, 4326.329418940007, 4332.501762297313, 4345.804438800198, 4348.673849461303, 4549.977250113729, 4552.590266875997, 4575.519570445055, 4579.404677391918, 4581.61056310204, 4320.243957307396, 4450.6884518083425, 4469.709468884512, 4512.842050528216, 4535.0, 4337.135031936297, 4346.739195648272, 4350.73895566267, 4394.143142087262, 4403.9779801100785, 3270.0, 3277.229850984969, 3292.5555050067933, 3298.175456135966, 3323.7839540429795, 4585.472670642919, 4940.827071052496, 4969.664257798829, 5130.538251557377, 5186.4035635902355, 4901.14230009754, 4901.995091006406, 4927.359443272351, 4955.033768415268, 4955.82654607087, 4967.552920237196, 4970.577500912318, 4987.401511818605, 4991.376077990251, 4998.325226094431, 4735.550122738335, 4877.829275975466, 4887.90022244992, 4896.853094407174, 4924.482929292372, 4946.406431228275, 4957.231629097496, 5001.4998500149695, 5016.423111342242, 5025.246213067923, 4870.756462176806, 4884.4613946606705, 4897.8285759998225, 4911.852644420673, 4935.753212339297], "value": 3641.0227764841293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1163654788043, 704.8484575816199, 753.6834529497611, 754.7282978127877, 787.7754839870638, 12234.571789987353, 12346.938265308672, 12411.627651170456, 12426.751464970717, 12532.310722910248, 11740.002099821504, 11784.587539436121, 11873.465694043767, 11877.7624447511, 11924.463399147038, 634.2199095113014, 650.9479241660656, 651.6546230497844, 792.8533221354054, 806.8305655812258, 655.9114519539872, 658.3087757854258, 767.4742801181209, 786.4101923557332, 786.6106277392698, 838.2078935406043, 841.7264389073545, 843.4686147726924, 843.7890527368158, 844.1347618690829, 822.6092606012127, 827.7268501394556, 831.7005877883956, 834.1741675741033, 835.1606635331514, 494.140196058855, 501.2906736967187, 504.3896884769433, 615.4522474997256, 615.704461858306, 10310.639127630571, 11705.765884682258, 12094.939525302405, 12127.454264558117, 12621.558245461365, 11597.942010289895, 11831.230969986924, 11921.225120367235, 12055.819162712567, 12359.75280494394, 9521.761955951088, 9692.903070969342, 9846.113849753556, 9851.21190304781, 9891.010898910052, 3242.96757032429, 3261.3314270574474, 3287.819169945652, 3298.340331933599, 3313.7017668409717, 44751.77624111858, 44907.550924490664, 45017.324740128926, 45168.77415612934, 46528.0, 9938.503074846229, 9979.151772099307, 10018.248631352677, 10054.396736195706, 10122.190224782, 17393.478195654152, 17508.12459377026, 17577.560560986076, 17602.383916563114, 17604.647907042043, 6419.0, 6521.543491955613, 6648.235452922879, 6689.331066893369, 6793.796186114425, 3487.982560087234, 3588.5693716753635, 3619.9638003619625, 3653.0, 3707.647773461517, 2719.2522056434245, 2813.08574713219, 2813.366992426688, 2818.2390754496582, 2821.1677555121287, 504.3418339067552, 506.07388479083187, 506.1319836480454, 517.9689218646894, 518.1036806325003, 488.75562218890553, 585.5579037826413, 589.8289496046099, 600.6936462404205, 616.3066550131102, 7290.198078211392, 7523.134839493418, 7535.924640753632, 7586.582737949356, 7598.544087354777, 605.2102006881063, 615.4215037864393, 620.2618883528587, 626.2703949898317, 626.8558231606664, 3541.327147841902, 3579.3736096183065, 3634.273145370936, 3654.543182102237, 3748.0, 54181.1872821908, 54683.72658136684, 54841.177382339294, 55868.72065639646, 55951.440485595434, 43747.56252437498, 45372.319415208796, 49007.0, 50263.49736502588, 50585.49414505808, 45417.545824541994, 45726.54273457223, 46225.537744622125, 46281.537184628396, 46727.0, 8062.1534738853925, 8190.590470476333, 8237.382196335178, 8240.629171687408, 8548.316134709332, 30852.53721194139, 31032.22419439532, 31075.37849243048, 31234.531482028244, 31494.685053150093, 35952.64047359493, 40657.18685626212, 40675.79662101671, 40816.1836763269, 41695.166096678506, 10254.743631409274, 10396.844047339144, 10456.16350691958, 10601.840972385266, 10623.681289561326, 11730.0, 11816.645500634995, 11981.700457488632, 12060.396980151132, 12179.269243845398, 10576.682699519026, 10733.141348692243, 11115.388653624128, 11238.66284011481, 11239.60661376848, 10216.744581385228, 10470.947645261725, 10701.732456688645, 10999.395033273247, 11271.436428178395, 10191.541380638037, 10617.89382106169, 10675.252732308663, 11002.174836887425, 11250.549978000789, 9382.577783999599, 9458.196053335269, 9742.853857192005, 9897.752556186153, 10000.349977251455, 8814.338924580554, 9083.636654533744, 9273.350865439625, 9341.439513629204, 9589.904100958902], "value": 5860.292682064951, "unit": "score"}], "name": "dromaeo_css", "value": 6199.226579956618, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 130.0, 201.0, 133.0, 129.0, 157.0, 133.0, 165.0, 138.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 162.0, 161.0, 162.0, 163.0, 163.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 107.0, 75.0, 76.0, 75.0, 75.0, 107.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 84.0, 85.0, 85.0, 126.0, 84.0, 85.0, 124.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 81.0, 65.0, 65.0, 65.0, 64.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 83.0, 82.0, 85.0, 90.0, 87.0, 85.0, 121.0, 84.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 131.0, 131.0, 131.0, 137.0, 131.0, 127.0, 133.0, 142.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 168.0, 168.0, 170.0, 169.0, 176.0, 172.0, 167.0, 169.0, 169.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 68.0, 67.0, 69.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1551.5, "alertThreshold": 2.0}]} 13:20:02 INFO - Return code: 0 13:20:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:20:02 ERROR - # TBPL SUCCESS # 13:20:02 INFO - Running post-action listener: _resource_record_post_action 13:20:02 INFO - ##### 13:20:02 INFO - ##### Finished run-tests step (success) 13:20:02 INFO - ##### 13:20:02 INFO - Running post-run listener: _resource_record_post_run 13:20:02 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538075136; Read time: 12; Write time: 502936 13:20:02 INFO - TinderboxPrint: CPU usage
13.2% 13:20:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:20:02 INFO - TinderboxPrint: I/O write bytes / time
538,075,136 / 502,936 13:20:02 INFO - TinderboxPrint: CPU idle
8,314.1 (86.7%) 13:20:02 INFO - TinderboxPrint: CPU user
1,222.2 (12.8%) 13:20:02 INFO - TinderboxPrint: Swap in / out
0 / 0 13:20:02 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243957760; Read time: 0; Write time: 270964 13:20:02 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294117376; Read time: 12; Write time: 231972 13:20:03 INFO - Running post-run listener: _upload_blobber_files 13:20:03 INFO - Blob upload gear active. 13:20:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:20:03 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 13:20:03 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'] 13:20:03 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 13:20:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:07 INFO - (blobuploader) - INFO - Done attempting. 13:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:09 INFO - (blobuploader) - INFO - Done attempting. 13:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:09 INFO - (blobuploader) - INFO - Done attempting. 13:20:09 INFO - (blobuploader) - INFO - Iteration through files over. 13:20:09 INFO - Return code: 0 13:20:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:20:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:20:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1729f72b8c845b0a54c632342ad57ca39943ee730898a59e0242ded21056e34de915a253b8900df54f7ca278c4e6925979355db7ed19fea59a5650e79d90e2fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3df56cf2d577b2eaec39c9bb855f19756c42457a8ad13917649ae8d40c1e347ab1c148acacc769a991cdc54f809d0c747ffb7fbf75a13d6603059060d8aed285", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149a811016a80b7536dc198b7f07947a939ed515f3f8e456ae7a20e2e319355180325ced871064676041b0b4c6da4fa5992c25bdf7d0d13bc8a31d7f020a1585"} 13:20:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:20:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:20:09 INFO - Contents: 13:20:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1729f72b8c845b0a54c632342ad57ca39943ee730898a59e0242ded21056e34de915a253b8900df54f7ca278c4e6925979355db7ed19fea59a5650e79d90e2fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3df56cf2d577b2eaec39c9bb855f19756c42457a8ad13917649ae8d40c1e347ab1c148acacc769a991cdc54f809d0c747ffb7fbf75a13d6603059060d8aed285", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149a811016a80b7536dc198b7f07947a939ed515f3f8e456ae7a20e2e319355180325ced871064676041b0b4c6da4fa5992c25bdf7d0d13bc8a31d7f020a1585"} 13:20:09 INFO - Running post-run listener: copy_logs_to_upload_dir 13:20:09 INFO - Copying logs to upload dir... 13:20:09 INFO - mkdir: /builds/slave/test/build/upload/logs 13:20:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.305342 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-27 13:20:08.818035) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 13:20:08.821974) ========= 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=52faae308a556c440401f8e5000001e8-1464379068.425440-222692293 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/1729f72b8c845b0a54c632342ad57ca39943ee730898a59e0242ded21056e34de915a253b8900df54f7ca278c4e6925979355db7ed19fea59a5650e79d90e2fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3df56cf2d577b2eaec39c9bb855f19756c42457a8ad13917649ae8d40c1e347ab1c148acacc769a991cdc54f809d0c747ffb7fbf75a13d6603059060d8aed285", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149a811016a80b7536dc198b7f07947a939ed515f3f8e456ae7a20e2e319355180325ced871064676041b0b4c6da4fa5992c25bdf7d0d13bc8a31d7f020a1585"} build_url:https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011577 build_url: 'https://queue.taskcluster.net/v1/task/cT7by1DPRqKh-12RyW2BCg/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/1729f72b8c845b0a54c632342ad57ca39943ee730898a59e0242ded21056e34de915a253b8900df54f7ca278c4e6925979355db7ed19fea59a5650e79d90e2fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3df56cf2d577b2eaec39c9bb855f19756c42457a8ad13917649ae8d40c1e347ab1c148acacc769a991cdc54f809d0c747ffb7fbf75a13d6603059060d8aed285", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149a811016a80b7536dc198b7f07947a939ed515f3f8e456ae7a20e2e319355180325ced871064676041b0b4c6da4fa5992c25bdf7d0d13bc8a31d7f020a1585"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 13:20:08.847636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:20:08.848038) ========= 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=52faae308a556c440401f8e5000001e8-1464379068.425440-222692293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:20:08.930422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 13:20:08.930817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 13:20:08.931130) ========= ========= Total master_lag: 0.15 =========