builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1464261977.79 results: success (0) buildid: 20160526034551 builduid: 70a9f196f20c441db3ff8b7de3a8d9bc revision: a33592050e2465ea62f9d62c42623c9c88b9808f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:17.791908) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:17.792443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:17.792777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:17.817220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:17.817551) ========= 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-1464261690.771718-1043806283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 04:26:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-05-26 04:26:18 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188688 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:18.043094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:18.043426) ========= 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-1464261690.771718-1043806283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.126270 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:18.179913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 04:26:18.180234) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a33592050e2465ea62f9d62c42623c9c88b9808f --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 a33592050e2465ea62f9d62c42623c9c88b9808f --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-1464261690.771718-1043806283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 04:26:18,273 truncating revision to first 12 chars 2016-05-26 04:26:18,274 Setting DEBUG logging. 2016-05-26 04:26:18,274 attempt 1/10 2016-05-26 04:26:18,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a33592050e24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 04:26:19,360 unpacking tar archive at: fx-team-a33592050e24/testing/mozharness/ program finished with exit code 0 elapsedTime=1.386179 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 04:26:19.579815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:19.580142) ========= script_repo_revision: a33592050e2465ea62f9d62c42623c9c88b9808f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:19.580616) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:19.580899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 04:26:19.590455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-26 04:26:19.590887) ========= /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-1464261690.771718-1043806283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:19 INFO - MultiFileLogger online at 20160526 04:26:19 in /builds/slave/test 04:26:19 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 04:26:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:19 INFO - {'append_to_log': False, 04:26:19 INFO - 'base_work_dir': '/builds/slave/test', 04:26:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:26:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:19 INFO - 'branch': 'Fx-Team-Non-PGO', 04:26:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:19 INFO - 'config_files': ('talos/linux_config.py',), 04:26:19 INFO - 'default_actions': ('clobber', 04:26:19 INFO - 'read-buildbot-config', 04:26:19 INFO - 'download-and-extract', 04:26:19 INFO - 'populate-webroot', 04:26:19 INFO - 'create-virtualenv', 04:26:19 INFO - 'install', 04:26:19 INFO - 'run-tests'), 04:26:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:19 INFO - 'download_minidump_stackwalk': True, 04:26:19 INFO - 'download_symbols': 'ondemand', 04:26:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:19 INFO - 'installer_path': 'installer.exe', 04:26:19 INFO - 'log_level': 'info', 04:26:19 INFO - 'log_name': 'talos', 04:26:19 INFO - 'log_to_console': True, 04:26:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:19 INFO - 'opt_config_files': (), 04:26:19 INFO - 'pip_index': False, 04:26:19 INFO - 'sps_profile': False, 04:26:19 INFO - 'sps_profile_interval': 0, 04:26:19 INFO - 'suite': 'dromaeojs', 04:26:19 INFO - 'system_bits': '32', 04:26:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:19 INFO - 'title': 'talos-linux64-ix-056', 04:26:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:19 INFO - 'use_talos_json': True, 04:26:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:19 INFO - 'work_dir': 'build'} 04:26:19 INFO - ##### 04:26:19 INFO - ##### Running clobber step. 04:26:19 INFO - ##### 04:26:19 INFO - Running pre-action listener: _resource_record_pre_action 04:26:19 INFO - Running main action method: clobber 04:26:19 INFO - rmtree: /builds/slave/test/build 04:26:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:21 INFO - Running post-action listener: _resource_record_post_action 04:26:21 INFO - ##### 04:26:21 INFO - ##### Finished clobber step (success) 04:26:21 INFO - ##### 04:26:21 INFO - ##### 04:26:21 INFO - ##### Running read-buildbot-config step. 04:26:21 INFO - ##### 04:26:21 INFO - Running pre-action listener: _resource_record_pre_action 04:26:21 INFO - Running main action method: read_buildbot_config 04:26:21 INFO - Using buildbot properties: 04:26:21 INFO - { 04:26:21 INFO - "project": "", 04:26:21 INFO - "product": "firefox", 04:26:21 INFO - "script_repo_revision": "production", 04:26:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:26:21 INFO - "repository": "", 04:26:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:26:21 INFO - "buildid": "20160526034551", 04:26:21 INFO - "pgo_build": "False", 04:26:21 INFO - "basedir": "/builds/slave/test", 04:26:21 INFO - "buildnumber": 1786, 04:26:21 INFO - "slavename": "talos-linux64-ix-056", 04:26:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:26:21 INFO - "platform": "ubuntu64_hw", 04:26:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:26:21 INFO - "branch": "fx-team", 04:26:21 INFO - "repo_path": "integration/fx-team", 04:26:21 INFO - "revision": "a33592050e2465ea62f9d62c42623c9c88b9808f", 04:26:21 INFO - "stage_platform": "linux64", 04:26:21 INFO - "builduid": "70a9f196f20c441db3ff8b7de3a8d9bc", 04:26:21 INFO - "slavebuilddir": "test" 04:26:21 INFO - } 04:26:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:26:21 INFO - Running post-action listener: _resource_record_post_action 04:26:21 INFO - ##### 04:26:21 INFO - ##### Finished read-buildbot-config step (success) 04:26:21 INFO - ##### 04:26:21 INFO - ##### 04:26:21 INFO - ##### Running download-and-extract step. 04:26:21 INFO - ##### 04:26:21 INFO - Running pre-action listener: _resource_record_pre_action 04:26:21 INFO - Running main action method: download_and_extract 04:26:21 INFO - mkdir: /builds/slave/test/build/tests 04:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:21 INFO - https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:26:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:22 INFO - Downloaded 1361 bytes. 04:26:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:22 INFO - Using the following test package requirements: 04:26:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:26:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:26:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:22 INFO - u'jsshell-linux-x86_64.zip'], 04:26:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:26:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:26:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:26:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:26:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:26:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:22 INFO - https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:23 INFO - Downloaded 22835896 bytes. 04:26:23 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'] 04:26:23 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 04:26:24 INFO - Return code: 0 04:26:24 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 04:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:24 INFO - https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:27 INFO - Downloaded 22835896 bytes. 04:26:27 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'] 04:26:27 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 04:26:30 INFO - Return code: 0 04:26: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')]} 04:26:30 INFO - https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:26:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:31 INFO - Downloaded 10834034 bytes. 04:26:31 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'] 04:26:31 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 04:26:31 INFO - Return code: 0 04:26:31 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')]} 04:26:31 INFO - https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:26:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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 04:26:32 INFO - Downloaded 54822809 bytes. 04:26:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:32 INFO - mkdir: /builds/slave/test/properties 04:26:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:32 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:32 INFO - Contents: 04:26:32 INFO - build_url:https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:33 INFO - Running post-action listener: _resource_record_post_action 04:26:33 INFO - Running post-action listener: set_extra_try_arguments 04:26:33 INFO - ##### 04:26:33 INFO - ##### Finished download-and-extract step (success) 04:26:33 INFO - ##### 04:26:33 INFO - ##### 04:26:33 INFO - ##### Running populate-webroot step. 04:26:33 INFO - ##### 04:26:33 INFO - Running pre-action listener: _resource_record_pre_action 04:26:33 INFO - Running main action method: populate_webroot 04:26:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:33 INFO - '--tppagecycles', 04:26:33 INFO - '7'], 04:26:33 INFO - 'tests': ['tsvgm']}}, 04:26:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:26:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:26:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:26:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:33 INFO - 'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:33 INFO - 'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['damp', 'tps']}, 04:26:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:33 INFO - 'tests': ['damp', 'tps']}, 04:26:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['dromaeo_dom']}, 04:26:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['a11yr', 04:26:33 INFO - 'ts_paint', 04:26:33 INFO - 'tpaint', 04:26:33 INFO - 'sessionrestore', 04:26:33 INFO - 'sessionrestore_no_auto_restore', 04:26:33 INFO - 'tabpaint']}, 04:26:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:26:33 INFO - 'ts_paint', 04:26:33 INFO - 'tpaint', 04:26:33 INFO - 'sessionrestore', 04:26:33 INFO - 'sessionrestore_no_auto_restore', 04:26:33 INFO - 'tabpaint']}, 04:26:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:26:33 INFO - 'ts_paint', 04:26:33 INFO - 'tpaint', 04:26:33 INFO - 'sessionrestore', 04:26:33 INFO - 'sessionrestore_no_auto_restore', 04:26:33 INFO - 'tabpaint']}, 04:26:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:26:33 INFO - 'ts_paint', 04:26:33 INFO - 'tpaint', 04:26:33 INFO - 'sessionrestore', 04:26:33 INFO - 'sessionrestore_no_auto_restore', 04:26:33 INFO - 'tabpaint']}, 04:26:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['a11yr', 04:26:33 INFO - 'ts_paint', 04:26:33 INFO - 'tpaint', 04:26:33 INFO - 'sessionrestore', 04:26:33 INFO - 'sessionrestore_no_auto_restore', 04:26:33 INFO - 'tabpaint']}, 04:26:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['a11yr', 04:26:33 INFO - 'ts_paint', 04:26:33 INFO - 'tpaint', 04:26:33 INFO - 'sessionrestore', 04:26:33 INFO - 'sessionrestore_no_auto_restore', 04:26:33 INFO - 'tabpaint']}, 04:26:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['tsvgx', 04:26:33 INFO - 'tsvgr_opacity', 04:26:33 INFO - 'tart', 04:26:33 INFO - 'tscrollx', 04:26:33 INFO - 'cart']}, 04:26:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:26:33 INFO - 'tsvgr_opacity', 04:26:33 INFO - 'tart', 04:26:33 INFO - 'tscrollx', 04:26:33 INFO - 'cart']}, 04:26:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:33 INFO - 'talos_options': ['--disable-e10s'], 04:26:33 INFO - 'tests': ['tp5o']}, 04:26:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:33 INFO - 'tests': ['tp5o']}, 04:26:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:33 INFO - 'talos_options': ['--disable-e10s', 04:26:33 INFO - '--xperf_path', 04:26:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:33 INFO - 'tests': ['tp5n']}, 04:26:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:33 INFO - 'talos_options': ['--xperf_path', 04:26:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:33 INFO - 'tests': ['tp5n']}}, 04:26:33 INFO - 'talos.zip': {'path': '', 04:26:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:33 INFO - Running post-action listener: _resource_record_post_action 04:26:33 INFO - ##### 04:26:33 INFO - ##### Finished populate-webroot step (success) 04:26:33 INFO - ##### 04:26:33 INFO - ##### 04:26:33 INFO - ##### Running create-virtualenv step. 04:26:33 INFO - ##### 04:26:33 INFO - Running pre-action listener: _resource_record_pre_action 04:26:33 INFO - Running main action method: create_virtualenv 04:26:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:33 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 04:26:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:33 INFO - Using real prefix '/usr' 04:26:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:35 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:37 INFO - Installing pip.................done. 04:26:37 INFO - Return code: 0 04:26:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:37 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 0x7f7ef9bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, '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-1464261690.771718-1043806283', '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 04:26:37 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 04:26:37 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 04:26:37 INFO - Using env: {'DISPLAY': ':0', 04:26:37 INFO - 'HOME': '/home/cltbld', 04:26:37 INFO - 'LANG': 'en_US.UTF-8', 04:26:37 INFO - 'LANGUAGE': 'en_US:en', 04:26:37 INFO - 'LOGNAME': 'cltbld', 04:26:37 INFO - 'MAIL': '/var/mail/cltbld', 04:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:37 INFO - 'MOZ_NO_REMOTE': '1', 04:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:37 INFO - 'NO_EM_RESTART': '1', 04:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:37 INFO - 'PWD': '/builds/slave/test', 04:26:37 INFO - 'SHELL': '/bin/bash', 04:26:37 INFO - 'SHLVL': '1', 04:26:37 INFO - 'TERM': 'linux', 04:26:37 INFO - 'TMOUT': '86400', 04:26:37 INFO - 'USER': 'cltbld', 04:26:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:37 INFO - '_': '/tools/buildbot/bin/python'} 04:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:37 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 04:26:37 INFO - Cleaning up... 04:26:37 INFO - Return code: 0 04:26:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:37 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 0x7f7ef9bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, '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-1464261690.771718-1043806283', '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 04:26:37 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 04:26:37 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 04:26:37 INFO - Using env: {'DISPLAY': ':0', 04:26:37 INFO - 'HOME': '/home/cltbld', 04:26:37 INFO - 'LANG': 'en_US.UTF-8', 04:26:37 INFO - 'LANGUAGE': 'en_US:en', 04:26:37 INFO - 'LOGNAME': 'cltbld', 04:26:37 INFO - 'MAIL': '/var/mail/cltbld', 04:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:37 INFO - 'MOZ_NO_REMOTE': '1', 04:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:37 INFO - 'NO_EM_RESTART': '1', 04:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:37 INFO - 'PWD': '/builds/slave/test', 04:26:37 INFO - 'SHELL': '/bin/bash', 04:26:37 INFO - 'SHLVL': '1', 04:26:37 INFO - 'TERM': 'linux', 04:26:37 INFO - 'TMOUT': '86400', 04:26:37 INFO - 'USER': 'cltbld', 04:26:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:37 INFO - '_': '/tools/buildbot/bin/python'} 04:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:38 INFO - Downloading/unpacking psutil>=3.1.1 04:26:38 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 04:26:38 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 04:26:38 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 04:26:38 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 04:26:38 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 04:26:38 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 04:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:40 INFO - Installing collected packages: psutil 04:26:40 INFO - Running setup.py install for psutil 04:26:40 INFO - building 'psutil._psutil_linux' extension 04:26:40 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 04:26: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 04:26:42 INFO - building 'psutil._psutil_posix' extension 04:26: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 04:26: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 04:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:43 INFO - Successfully installed psutil 04:26:43 INFO - Cleaning up... 04:26:43 INFO - Return code: 0 04:26:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:26:43 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')]} 04:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:43 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')]} 04:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:43 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 0x7f7ef9bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, '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-1464261690.771718-1043806283', '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 04:26:43 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 04:26:43 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 04:26:43 INFO - Using env: {'DISPLAY': ':0', 04:26:43 INFO - 'HOME': '/home/cltbld', 04:26:43 INFO - 'LANG': 'en_US.UTF-8', 04:26:43 INFO - 'LANGUAGE': 'en_US:en', 04:26:43 INFO - 'LOGNAME': 'cltbld', 04:26:43 INFO - 'MAIL': '/var/mail/cltbld', 04:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:43 INFO - 'MOZ_NO_REMOTE': '1', 04:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:43 INFO - 'NO_EM_RESTART': '1', 04:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:43 INFO - 'PWD': '/builds/slave/test', 04:26:43 INFO - 'SHELL': '/bin/bash', 04:26:43 INFO - 'SHLVL': '1', 04:26:43 INFO - 'TERM': 'linux', 04:26:43 INFO - 'TMOUT': '86400', 04:26:43 INFO - 'USER': 'cltbld', 04:26:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:43 INFO - '_': '/tools/buildbot/bin/python'} 04:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:26:45 INFO - Installing collected packages: mozsystemmonitor 04:26:45 INFO - Running setup.py install for mozsystemmonitor 04:26:45 INFO - Successfully installed mozsystemmonitor 04:26:45 INFO - Cleaning up... 04:26:45 INFO - Return code: 0 04:26:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 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 0x7f7ef9bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, '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-1464261690.771718-1043806283', '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 04:26:45 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 04:26:45 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 04:26:45 INFO - Using env: {'DISPLAY': ':0', 04:26:45 INFO - 'HOME': '/home/cltbld', 04:26:45 INFO - 'LANG': 'en_US.UTF-8', 04:26:45 INFO - 'LANGUAGE': 'en_US:en', 04:26:45 INFO - 'LOGNAME': 'cltbld', 04:26:45 INFO - 'MAIL': '/var/mail/cltbld', 04:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:45 INFO - 'MOZ_NO_REMOTE': '1', 04:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:45 INFO - 'NO_EM_RESTART': '1', 04:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:45 INFO - 'PWD': '/builds/slave/test', 04:26:45 INFO - 'SHELL': '/bin/bash', 04:26:45 INFO - 'SHLVL': '1', 04:26:45 INFO - 'TERM': 'linux', 04:26:45 INFO - 'TMOUT': '86400', 04:26:45 INFO - 'USER': 'cltbld', 04:26:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:45 INFO - '_': '/tools/buildbot/bin/python'} 04:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26:48 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 04:26:48 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 04:26:48 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 04:26:48 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 04:26:48 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 04:26:48 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 04:26:48 INFO - Downloading docopt-0.6.1.tar.gz 04:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:48 INFO - Running setup.py install for blobuploader 04:26:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:48 INFO - Running setup.py install for requests 04:26:48 INFO - Running setup.py install for docopt 04:26:48 INFO - Successfully installed blobuploader requests docopt 04:26:48 INFO - Cleaning up... 04:26:49 INFO - Return code: 0 04:26:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:49 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')]} 04:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:49 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')]} 04:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:49 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 0x7f7ef9bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, '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-1464261690.771718-1043806283', '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 04:26:49 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 04:26:49 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 04:26:49 INFO - Using env: {'DISPLAY': ':0', 04:26:49 INFO - 'HOME': '/home/cltbld', 04:26:49 INFO - 'LANG': 'en_US.UTF-8', 04:26:49 INFO - 'LANGUAGE': 'en_US:en', 04:26:49 INFO - 'LOGNAME': 'cltbld', 04:26:49 INFO - 'MAIL': '/var/mail/cltbld', 04:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:49 INFO - 'MOZ_NO_REMOTE': '1', 04:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:49 INFO - 'NO_EM_RESTART': '1', 04:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:49 INFO - 'PWD': '/builds/slave/test', 04:26:49 INFO - 'SHELL': '/bin/bash', 04:26:49 INFO - 'SHLVL': '1', 04:26:49 INFO - 'TERM': 'linux', 04:26:49 INFO - 'TMOUT': '86400', 04:26:49 INFO - 'USER': 'cltbld', 04:26:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:49 INFO - '_': '/tools/buildbot/bin/python'} 04:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:49 INFO - Running setup.py (path:/tmp/pip-mCQZ6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:49 INFO - Running setup.py (path:/tmp/pip-Fj_dno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:49 INFO - Running setup.py (path:/tmp/pip-noEATe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:49 INFO - Running setup.py (path:/tmp/pip-vySP2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:49 INFO - Running setup.py (path:/tmp/pip-oKvaZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:49 INFO - Running setup.py (path:/tmp/pip-RzUVSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:49 INFO - Running setup.py (path:/tmp/pip-XU_iuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:49 INFO - Running setup.py (path:/tmp/pip-VERRF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:49 INFO - Running setup.py (path:/tmp/pip-326D5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:49 INFO - Running setup.py (path:/tmp/pip-Pt2fp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:49 INFO - Running setup.py (path:/tmp/pip-47EA6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:50 INFO - Running setup.py (path:/tmp/pip-VGXCus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:50 INFO - Running setup.py (path:/tmp/pip-s7gq3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:50 INFO - Running setup.py (path:/tmp/pip-zd3xGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:50 INFO - Running setup.py (path:/tmp/pip-3IB3by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:50 INFO - Running setup.py (path:/tmp/pip-PRpJov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:50 INFO - Running setup.py (path:/tmp/pip-Mg2w_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:50 INFO - Running setup.py install for manifestparser 04:26:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:50 INFO - Running setup.py install for mozcrash 04:26:50 INFO - Running setup.py install for mozdebug 04:26:50 INFO - Running setup.py install for mozdevice 04:26:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:50 INFO - Running setup.py install for mozfile 04:26:50 INFO - Running setup.py install for mozhttpd 04:26:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for mozinfo 04:26:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for mozInstall 04:26:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for mozleak 04:26:51 INFO - Running setup.py install for mozlog 04:26:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for moznetwork 04:26:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for mozprocess 04:26:51 INFO - Running setup.py install for mozprofile 04:26:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for mozrunner 04:26:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for mozscreenshot 04:26:52 INFO - Running setup.py install for moztest 04:26:52 INFO - Running setup.py install for mozversion 04:26:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:52 INFO - Cleaning up... 04:26:52 INFO - Return code: 0 04:26:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:52 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 0x7f7ef9bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, '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-1464261690.771718-1043806283', '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 04:26:52 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 04:26:52 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 04:26:52 INFO - Using env: {'DISPLAY': ':0', 04:26:52 INFO - 'HOME': '/home/cltbld', 04:26:52 INFO - 'LANG': 'en_US.UTF-8', 04:26:52 INFO - 'LANGUAGE': 'en_US:en', 04:26:52 INFO - 'LOGNAME': 'cltbld', 04:26:52 INFO - 'MAIL': '/var/mail/cltbld', 04:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:52 INFO - 'MOZ_NO_REMOTE': '1', 04:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:52 INFO - 'NO_EM_RESTART': '1', 04:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:52 INFO - 'PWD': '/builds/slave/test', 04:26:52 INFO - 'SHELL': '/bin/bash', 04:26:52 INFO - 'SHLVL': '1', 04:26:52 INFO - 'TERM': 'linux', 04:26:52 INFO - 'TMOUT': '86400', 04:26:52 INFO - 'USER': 'cltbld', 04:26:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:52 INFO - '_': '/tools/buildbot/bin/python'} 04:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:52 INFO - Running setup.py (path:/tmp/pip-z7Cvuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:52 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)) 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:52 INFO - Running setup.py (path:/tmp/pip-9Vzn0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:52 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)) 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:52 INFO - Running setup.py (path:/tmp/pip-eIpIdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26: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)) 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:52 INFO - Running setup.py (path:/tmp/pip-NWkwwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26: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)) 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:52 INFO - Running setup.py (path:/tmp/pip-VeL124-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26: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)) 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:52 INFO - Running setup.py (path:/tmp/pip-f02_jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26: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)) 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:52 INFO - Running setup.py (path:/tmp/pip-mXSvEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26: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)) 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:52 INFO - Running setup.py (path:/tmp/pip-nJ47jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:53 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)) 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:53 INFO - Running setup.py (path:/tmp/pip-voEAN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:53 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)) 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:53 INFO - Running setup.py (path:/tmp/pip-hWDvuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:53 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)) 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:53 INFO - Running setup.py (path:/tmp/pip-tUpWu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:53 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)) 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:53 INFO - Running setup.py (path:/tmp/pip-UKGzAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:53 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)) 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:53 INFO - Running setup.py (path:/tmp/pip-Qu0n8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:53 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)) 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:53 INFO - Running setup.py (path:/tmp/pip-7dYpAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:53 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)) 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:53 INFO - Running setup.py (path:/tmp/pip-nNijh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:53 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)) 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:53 INFO - Running setup.py (path:/tmp/pip-2ReBg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:53 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)) 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:53 INFO - Running setup.py (path:/tmp/pip-3cIQle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26: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)) 04:26: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)) 04:26: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)) 04:26: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)) 04:26: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)) 04:26: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)) 04:26:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:55 INFO - Downloading blessings-1.6.tar.gz 04:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:55 INFO - Installing collected packages: blessings 04:26:55 INFO - Running setup.py install for blessings 04:26:55 INFO - Successfully installed blessings 04:26:55 INFO - Cleaning up... 04:26:55 INFO - Return code: 0 04:26:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:56 INFO - Reading from file tmpfile_stdout 04:26:56 INFO - Current package versions: 04:26:56 INFO - argparse == 1.2.1 04:26:56 INFO - blessings == 1.6 04:26:56 INFO - blobuploader == 1.2.4 04:26:56 INFO - docopt == 0.6.1 04:26:56 INFO - manifestparser == 1.1 04:26:56 INFO - mozInstall == 1.12 04:26:56 INFO - mozcrash == 0.17 04:26:56 INFO - mozdebug == 0.1 04:26:56 INFO - mozdevice == 0.48 04:26:56 INFO - mozfile == 1.2 04:26:56 INFO - mozhttpd == 0.7 04:26:56 INFO - mozinfo == 0.9 04:26:56 INFO - mozleak == 0.1 04:26:56 INFO - mozlog == 3.2 04:26:56 INFO - moznetwork == 0.27 04:26:56 INFO - mozprocess == 0.22 04:26:56 INFO - mozprofile == 0.28 04:26:56 INFO - mozrunner == 6.11 04:26:56 INFO - mozscreenshot == 0.1 04:26:56 INFO - mozsystemmonitor == 0.3 04:26:56 INFO - moztest == 0.7 04:26:56 INFO - mozversion == 1.4 04:26:56 INFO - psutil == 3.1.1 04:26:56 INFO - requests == 1.2.3 04:26:56 INFO - wsgiref == 0.1.2 04:26:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:56 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')]} 04:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:56 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')]} 04:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:56 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 0x7f7ef9bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, '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-1464261690.771718-1043806283', '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 04:26:56 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 04:26:56 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 04:26:56 INFO - Using env: {'DISPLAY': ':0', 04:26:56 INFO - 'HOME': '/home/cltbld', 04:26:56 INFO - 'LANG': 'en_US.UTF-8', 04:26:56 INFO - 'LANGUAGE': 'en_US:en', 04:26:56 INFO - 'LOGNAME': 'cltbld', 04:26:56 INFO - 'MAIL': '/var/mail/cltbld', 04:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:56 INFO - 'MOZ_NO_REMOTE': '1', 04:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:56 INFO - 'NO_EM_RESTART': '1', 04:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:56 INFO - 'PWD': '/builds/slave/test', 04:26:56 INFO - 'SHELL': '/bin/bash', 04:26:56 INFO - 'SHLVL': '1', 04:26:56 INFO - 'TERM': 'linux', 04:26:56 INFO - 'TMOUT': '86400', 04:26:56 INFO - 'USER': 'cltbld', 04:26:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:56 INFO - '_': '/tools/buildbot/bin/python'} 04:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:56 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)) 04:26:56 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)) 04:26:56 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)) 04:26:56 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)) 04:26:56 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)) 04:26:56 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)) 04:26:56 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)) 04:26:56 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)) 04:26:56 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)) 04:26:56 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)) 04:26:56 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)) 04:26:56 INFO - Cleaning up... 04:26:56 INFO - Return code: 0 04:26:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:56 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')]} 04:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:56 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')]} 04:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:56 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 0x7f7ef9bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, '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-1464261690.771718-1043806283', '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 04:26:56 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 04:26:56 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 04:26:56 INFO - Using env: {'DISPLAY': ':0', 04:26:56 INFO - 'HOME': '/home/cltbld', 04:26:56 INFO - 'LANG': 'en_US.UTF-8', 04:26:56 INFO - 'LANGUAGE': 'en_US:en', 04:26:56 INFO - 'LOGNAME': 'cltbld', 04:26:56 INFO - 'MAIL': '/var/mail/cltbld', 04:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:56 INFO - 'MOZ_NO_REMOTE': '1', 04:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:56 INFO - 'NO_EM_RESTART': '1', 04:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:56 INFO - 'PWD': '/builds/slave/test', 04:26:56 INFO - 'SHELL': '/bin/bash', 04:26:56 INFO - 'SHLVL': '1', 04:26:56 INFO - 'TERM': 'linux', 04:26:56 INFO - 'TMOUT': '86400', 04:26:56 INFO - 'USER': 'cltbld', 04:26:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:56 INFO - '_': '/tools/buildbot/bin/python'} 04:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:56 INFO - Downloading/unpacking jsonschema 04:26:56 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 04:26:56 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 04:26:56 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 04:26:56 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 04:26:56 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 04:26:56 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 04:26:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:58 INFO - Downloading/unpacking functools32 (from jsonschema) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:58 INFO - warning: no files found matching '*.txt' 04:26:58 INFO - no previously-included directories found matching 'build' 04:26:58 INFO - no previously-included directories found matching 'dist' 04:26:58 INFO - no previously-included directories found matching '.git*' 04:26:58 INFO - Installing collected packages: jsonschema, functools32 04:26:58 INFO - Running setup.py install for functools32 04:26:58 INFO - warning: no files found matching '*.txt' 04:26:58 INFO - no previously-included directories found matching 'build' 04:26:58 INFO - no previously-included directories found matching 'dist' 04:26:58 INFO - no previously-included directories found matching '.git*' 04:26:58 INFO - Successfully installed jsonschema functools32 04:26:58 INFO - Cleaning up... 04:26:58 INFO - Return code: 0 04:26:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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 0x7f7ef9bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, '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-1464261690.771718-1043806283', '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 04:26: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 04:26: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 04:26:58 INFO - Using env: {'DISPLAY': ':0', 04:26:58 INFO - 'HOME': '/home/cltbld', 04:26:58 INFO - 'LANG': 'en_US.UTF-8', 04:26:58 INFO - 'LANGUAGE': 'en_US:en', 04:26:58 INFO - 'LOGNAME': 'cltbld', 04:26:58 INFO - 'MAIL': '/var/mail/cltbld', 04:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:58 INFO - 'MOZ_NO_REMOTE': '1', 04:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:58 INFO - 'NO_EM_RESTART': '1', 04:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:58 INFO - 'PWD': '/builds/slave/test', 04:26:58 INFO - 'SHELL': '/bin/bash', 04:26:58 INFO - 'SHLVL': '1', 04:26:58 INFO - 'TERM': 'linux', 04:26:58 INFO - 'TMOUT': '86400', 04:26:58 INFO - 'USER': 'cltbld', 04:26:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:58 INFO - '_': '/tools/buildbot/bin/python'} 04:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:59 INFO - Downloading/unpacking flake8 04:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:27:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:27:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:27:01 INFO - no previously-included directories found matching 'docs/_build' 04:27:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:27:01 INFO - Running setup.py install for pep8 04:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:27:01 INFO - no previously-included directories found matching 'docs/_build' 04:27:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:27:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:27:01 INFO - Cleaning up... 04:27:01 INFO - Return code: 0 04:27:01 INFO - Running post-action listener: _resource_record_post_action 04:27:01 INFO - Running post-action listener: _start_resource_monitoring 04:27:01 INFO - Starting resource monitoring. 04:27:01 INFO - ##### 04:27:01 INFO - ##### Finished create-virtualenv step (success) 04:27:01 INFO - ##### 04:27:01 INFO - ##### 04:27:01 INFO - ##### Running install step. 04:27:01 INFO - ##### 04:27:01 INFO - Running pre-action listener: _resource_record_pre_action 04:27:01 INFO - Running main action method: install 04:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:02 INFO - Reading from file tmpfile_stdout 04:27:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:02 INFO - Reading from file tmpfile_stdout 04:27:02 INFO - Output received: 04:27:02 INFO - Usage: mozinstall [options] installer 04:27:02 INFO - Options: 04:27:02 INFO - -h, --help show this help message and exit 04:27:02 INFO - -d DEST, --destination=DEST 04:27:02 INFO - Directory to install application into. [default: 04:27:02 INFO - "/builds/slave/test"] 04:27:02 INFO - --app=APP Application being installed. [default: firefox] 04:27:02 INFO - mkdir: /builds/slave/test/build/application 04:27:02 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'] 04:27:02 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 04:27:18 INFO - Reading from file tmpfile_stdout 04:27:18 INFO - Output received: 04:27:18 INFO - /builds/slave/test/build/application/firefox/firefox 04:27:18 INFO - Running post-action listener: _resource_record_post_action 04:27:18 INFO - ##### 04:27:18 INFO - ##### Finished install step (success) 04:27:18 INFO - ##### 04:27:18 INFO - ##### 04:27:18 INFO - ##### Running run-tests step. 04:27:18 INFO - ##### 04:27:18 INFO - Running pre-action listener: _resource_record_pre_action 04:27:18 INFO - Running main action method: run_tests 04:27:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:18 INFO - Python 2.7.3 04:27:18 INFO - Return code: 0 04:27:18 INFO - grabbing minidump binary from tooltool 04:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:18 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 0x1fed9c0>, '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 0x1fee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1feed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:18 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 04:27:18 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 04:27:18 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 04:27:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:18 INFO - Return code: 0 04:27:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:27:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:27:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:27:19 INFO - Return code: 0 04:27:19 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/A7ddYIKETJqJ3cS2KTj7Zw/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 04:27:19 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/A7ddYIKETJqJ3cS2KTj7Zw/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 04:27:19 INFO - Using env: {'DISPLAY': ':0', 04:27:19 INFO - 'HOME': '/home/cltbld', 04:27:19 INFO - 'LANG': 'en_US.UTF-8', 04:27:19 INFO - 'LANGUAGE': 'en_US:en', 04:27:19 INFO - 'LOGNAME': 'cltbld', 04:27:19 INFO - 'MAIL': '/var/mail/cltbld', 04:27:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:19 INFO - 'MOZ_NO_REMOTE': '1', 04:27:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:19 INFO - 'NO_EM_RESTART': '1', 04:27:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:19 INFO - 'PWD': '/builds/slave/test', 04:27:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:19 INFO - 'SHELL': '/bin/bash', 04:27:19 INFO - 'SHLVL': '1', 04:27:19 INFO - 'TERM': 'linux', 04:27:19 INFO - 'TMOUT': '86400', 04:27:19 INFO - 'USER': 'cltbld', 04:27:19 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464261690.771718-1043806283', 04:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:19 INFO - '_': '/tools/buildbot/bin/python'} 04:27:19 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/A7ddYIKETJqJ3cS2KTj7Zw/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 04:27:19 INFO - mozversion application_buildid: 20160526034551 04:27:19 INFO - mozversion application_changeset: a33592050e2465ea62f9d62c42623c9c88b9808f 04:27:19 INFO - mozversion application_display_name: Nightly 04:27:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:19 INFO - mozversion application_name: Firefox 04:27:19 INFO - mozversion application_remotingname: firefox 04:27:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:27:19 INFO - mozversion application_vendor: Mozilla 04:27:19 INFO - mozversion application_version: 49.0a1 04:27:19 INFO - mozversion platform_buildid: 20160526034551 04:27:19 INFO - mozversion platform_changeset: a33592050e2465ea62f9d62c42623c9c88b9808f 04:27:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:27:19 INFO - mozversion platform_version: 49.0a1 04:27:19 INFO - using testdate: 1464262039 04:27:19 INFO - actual date: 1464262039 04:27:19 INFO - starting webserver on 'localhost:45947' 04:27:19 INFO - SUITE-START | Running 2 tests 04:27:19 INFO - TEST-START | dromaeo_css 04:27:19 INFO - operating with platform_type : linux_ 04:27:19 INFO - Initialising browser for dromaeo_css test... 04:27:19 INFO - TEST-INFO | started process 3384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuEwZth/profile http://localhost:45947/getInfo.html) 04:27:26 INFO - PROCESS | 3384 | __metrics Screen width/height:1600/1200 04:27:26 INFO - PROCESS | 3384 | colorDepth:24 04:27:26 INFO - PROCESS | 3384 | Browser inner width/height: 1024/697 04:27:26 INFO - PROCESS | 3384 | __metrics 04:27:27 ERROR - PROCESS | 3384 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:27:28 INFO - TEST-INFO | 3384: exit 0 04:27:28 INFO - Browser initialized. 04:27:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:27:28 INFO - TEST-INFO | started process 3466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuEwZth/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:40 INFO - PROCESS | 3466 | RSS: Main: 156729344 04:27:40 INFO - PROCESS | 3466 | 04:28:32 INFO - PROCESS | 3466 | 1464262112110 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] 04:30:43 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45947/tests/dromaeo/cssquery-ext.html) 04:30:45 INFO - PROCESS | 3466 | RSS: Main: 231084032 04:30:45 INFO - PROCESS | 3466 | 04:33:47 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-ext.html (next: http://localhost:45947/tests/dromaeo/cssquery-jquery.html) 04:33:48 INFO - PROCESS | 3466 | RSS: Main: 240738304 04:33:48 INFO - PROCESS | 3466 | 04:36:50 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45947/tests/dromaeo/cssquery-mootools.html) 04:36:51 INFO - PROCESS | 3466 | RSS: Main: 239910912 04:36:51 INFO - PROCESS | 3466 | 04:39:53 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45947/tests/dromaeo/cssquery-prototype.html) 04:39:53 INFO - PROCESS | 3466 | RSS: Main: 236933120 04:39:53 INFO - PROCESS | 3466 | 04:42:56 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45947/tests/dromaeo/cssquery-yui.html) 04:42:57 INFO - PROCESS | 3466 | RSS: Main: 227389440 04:42:57 INFO - PROCESS | 3466 | 04:46:00 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-yui.html (next: http://localhost:45947/tests/dromaeo/cssquery-dojo.html) 04:46:00 INFO - PROCESS | 3466 | RSS: Main: 276213760 04:46:00 INFO - PROCESS | 3466 | 04:46:00 INFO - PROCESS | 3466 | __start_tp_report 04:46:00 INFO - PROCESS | 3466 | _x_x_mozilla_page_load 04:46:00 INFO - PROCESS | 3466 | _x_x_mozilla_page_load_details 04:46:00 INFO - PROCESS | 3466 | |i|pagename|runs| 04:46:00 INFO - PROCESS | 3466 | |0;dojo.html;2640.762331390175;2680.128958088622;2712.4168303814677;2718.864056797161;2724.1282789507354;4559.110973360188;4592.862214133577;4638.768061596915;4666.7199968001905;4726.740029298391;4551.408316918796;4568;4576.83981060663;4596.080783843228;4631.374764406804;4081.449004384415;4242.8727138185905;4327.978360108211;4354.3250796126495;4374.343848422746;4316.503602085769;4346.695731298811;4348.195583816988;4366.628836548897;4372.759498227596;4212.115455754295;4258.127083947783;4259.74441533509;4289.24938135825;4319.784010799447;4284.485861696617;4303.010307629263;4310.870673879788;4314.697971142022;4337.392765012901;4314.956850431518;4319.092990472004;4334.003179268786;4369.58488943553;4375.606195442394;4432.3794668746405;4520.638348932078;4565.680402371835;4569;4572.497025327211;4982.402111746614;4990.4011518617635;4994.700317980933;5012.122878496249;5016.3227964224725;4887.608991280689;4999.9500004999845;5031.723255220962;5032;5049.924251136236;4654.418197725285;4709.152352576501;4719.622430205575;4760.523947605281;4765.547273009059;5170.482951704799;5219.765110570033;5226.242194881721;5230.320058392384;5231.372235331784;4769.403824521934;4831.227003679464;4991.575716064102;5027.145385284511;5030.245463180552;4911.582515486224;4951.158303088484;4957.182064959314;4978;5016.046951079284;4890.24201248807;4914.631402644816;4916.483769204182;4922.75386230687;4965.900681986413;4848.054629347314;4852.4662287148385;4859.173940430135;4887.193613053877;4928.6057115431395;4247.10810729744;4259.212045771542;4286.6999310047995;4291.356296555479;4299.871003869889;3724.2923844469465;3733.5146430964346;3735.533058367704;3745.2135051638916;3772.5472943246436;4119.526254480713;4223.282042052859;4232.25935461293;4279.507856596469;4321.178975994551;4966.726830024311;5013.172826483662;5015.974920125376;5045.747712614355;5063.215201643751;4291.3777502262;4293.119910418357;4300.569943005675;4306.5262821089655;4348.760818155032;4411.713238639478;4433.312836510346;4520.005598768332;4521.819127234874;4534.161180181677;4643.907121857612;4662.044280922402;4667.953320466888;4704.670673052853;4709.175894218567;5030.924536131888;5043.142665746758;5044.0920634286185;5054.59563234933;5092.312537807348;4562.36126942235;4634.907301854011;4711.081339138835;4720.032393359422;4742.596879265301;4926.088673595396;4951.084049450863;4954.479779623088;4988.376452943382;5009.5491405773655;4992.076465853684;5013.147764879906;5016.498350164954;5021.974890125526;5063.924041139312;4764.714117152982;4768.546988036131;4795.64032697556;4890.657653964188;4960.404751429852;4771.355866958055;4785.688930219525;4787.42550893895;4819.228923372244;4841.1285968526;4732;4732.716037037789;4747.192977193817;4761.571458568606;4820;4841.201201801804;4877.780499877443;4927.162382394929;4934.679245849152;4935.284383764262;4845.733484658378;4855.95144048555;4861.562459378673;4876.90246195067;4907.411110666742 04:46:00 INFO - PROCESS | 3466 | |1;ext.html;564.96327738697;587.3392433512298;599.7960693364255;603.8978863573977;609.3662590905453;38271;39594.80202598986;39595;39680.20639587207;44345.55654443455;40189.19621607566;40823.183536329256;40856;40881;41005.179896402056;7434.070741157356;7557.4331925105835;7638;7670.846583068349;7808.219178082175;7410.629468526552;9676.225901927828;9967.700968970907;9971.850422243671;10258.23063270254;10103.949480252626;10174.745631359237;10179.338343007717;10181.236407269447;10185.643502477415;7495.362894154004;7757.340626046793;10000.099991000809;10077.596896124183;10083.092521673012;7572.962135189344;9605.951970240174;10027.398356098658;10048.44733539655;10361.067503924607;36345.45481817775;36621.26757464836;36647;36704.26591468156;36806.95123536409;2829.717028297154;2899.347646779479;2912.3738396244908;3384.3062172254627;3593.425051991695;28343.433131337464;29525.704742952727;29643;29661;29738.851305743334;3551.662592053751;3558.19940513385;3580.0333909844458;3587.3542762302777;3601.9194241727637;265374;269143.999999998;270669;271159;271214;54426.18360724593;55222.44777552253;55250.89498210013;55490.72254638782;55518;56746.71626641841;56912;57054.429455704914;57076;57295.713521432124;13034.217946923214;13356.599302020955;13393.330333483287;13453.394597243148;13460.865391346157;9385.483798391155;11390.202685812079;11541.480633371519;11620.941895290469;11686;17863.285468581373;17927.820721792614;17975.370862019765;18059.187336569885;18062.09689515519;6899.965500172467;6956.965215173892;7036.366726994493;7090.255523170096;7106.893396599055;849.6898631999276;894.7405252476709;951.9524023798782;953.270747877874;969.8108868770522;27343.45313093727;27373.86313068462;27541;27667.723322766513;28007;965.16513216069;1013.5236438873718;1026.8767747870304;1059.8251288537458;1124.24675467437;14347.713045739027;14552.345144468525;14684.339204735812;14786.482473113605;14907.776383354258;377754;378435;385530;387485;388953;48589.271160932614;48684.26973595328;48929;49264.7536762321;49425.25862112071;980.4901451245313;1073.1522097542854;1148.8678801937883;1158.3918442817587;1227.098082909061;25160.874195629636;28087.578686320132;28537;28958.565621516114;29239.85380073086;41079.58920410758;41267.38098928458;41691.37462938119;41697.1660566793;41719.7914010428;286591;288734;289651;289799;290341;19883.204671812964;23973;24657.63013554762;24817.25548233556;26192.214233573024;40370.39444408395;40693.38959915663;40739.592604074765;41204.38193427161;41349.37975930423;34723.30553388969;35241.64758352384;35404.64595354014;35462;35786;35557.64442355543;36053;36234;36253.27493450169;36273.27453450864;33920.321593568486;34471.65528344785;34613.48079778856;34745.30509389849;35104.47343289802;30789;31874.84062579672;31930.840345798122;32053.358932820745;32431.35137297288;24494.63258051095;24564.50870982606;24649.753502465464;24759.38101547476;24862.375238532848 04:46:00 INFO - PROCESS | 3466 | |2;jquery.html;370.8145927036482;372.0494137478741;373.42306137018306;376.8530273193457;383.23735765825995;15729.842701572996;16744.916275418607;17328.393506227283;17340.56648583786;17577.384791532284;15502.767458488132;15755.763663545027;16373.09947952862;16577.917110414463;16595.253213605385;5023.3971923369245;5196.662216955886;5206.375234971809;5217.817376391827;5227.294315267428;3681.8343174557076;3899.122697393092;5119.334486516747;5656.208130861683;6014.458698717114;5990.820275391745;6027.186329845481;6070.878582428349;6072.089186621998;6074.088886666991;5880.470757631833;5896.439838215363;6032.065029920369;6041.667708276043;6054.182685337467;3381.5942086949476;5004.924926126111;5289.9471005290225;5380.381256155514;5386.973065134688;19975.200991960304;20443.89778051115;20551.486212844648;20928.47678808042;20954;1922.3079691311116;2198.4393979535275;2330.3221680390093;2430.6961629796274;2465.112559478604;12828.871711282862;12903.16129451592;13188;13342.19946803195;13599.184048956995;1727.6112874603239;1816.7910690270655;1852.2590963614527;1884.9811501884942;1891.5460289530413;61238.17113258284;64686.67656661734;64962.350376496106;65244.67377663129;65386.3461365385;9280.164785169367;9551.14039736427;9685.70942871715;9807.313488055768;9952;13082.803757943639;13119.62243964389;13139.211647301192;13156.868431315565;13183.274919879499;7101.431885449152;7127.180374256923;7157.176924653628;7302.634868256566;7311.195768465464;6866.656667166621;6909.136357955255;6920.861582768316;6942.494040509611;6995.685194166274;6165.537584681167;6193.628382297076;6219.937800622027;6233.688315584202;6275.466585340206;1616.4908053962963;1699.337258469198;1704.3693833281766;1705.3263960735687;1727.6631056943775;726.5241266970143;853.3557164340883;881.969131080409;927.3832901120679;930.8696782450462;16901.91549042247;17465.301387944593;17467.38864139749;17729.645407091786;18009.279628814962;837.2297486312607;907.3285768531372;917.5091326140616;920.9217216536535;937.9765505862408;9881.901180988241;10023.14803241718;10247.38515689061;10256.38461692301;10264.486775661187;355055;358609;360433;363326;364848;63478;64999.35000650027;65056.02415963764;65151.348486515475;65284.94301139791;857.1171693155935;857.6955180910811;976.8046390721884;995.5520015992832;1003.0821798054699;14848.703025939205;15452.459163929658;16188.838111618734;16311.836881631032;16399.91800040992;31339.386890172664;32052;32821.835890820395;33114.50328245127;33619.663803361655;44181.337279940184;44537.331940020274;44612;44636;44773.77613112044;7602.4298177638;7765.650545725343;7771.145174030965;7818.374530037697;7992.840143196987;11373.260738052;11508.769824603629;11742.941285293518;11854.348010859141;12359.196652217577;8967;9018.639254429749;9133.543322833699;9228.169464748205;9414.529273536433;10320.587176512856;10348.068673819393;10554.261201715806;10606.469676516297;10678.83981740259;9719.951400242953;9784.412935223909;10055.597776088875;10231;10286.228532859916;7545.547267163988;7657.57883316423;7696.153423123564;7754.612269386395;8032;7205.747798827016;9533.23734101284;9988.250881183794;9994.550245238835;10170.644027459004 04:46:00 INFO - PROCESS | 3466 | |3;mootools.html;1281.3849352310885;1363.3728484896947;1425.9500917467888;1524.1845612597263;1766.743822145789;6739.35976082272;7384.926150738491;7680.654370553325;7683.57740324282;7833.138354780969;7320.63396830159;7518.7368442104535;7584.886226706604;7719.884201736979;7752.069751629798;2162.0378931375544;2223.5330580578097;2224.1103558576538;2224.710787597618;2225.7440394354694;2111.1766411099684;2154.278316763886;2187.3656639574506;2194.034624765098;2195.802377785999;2055.660815965364;2060.701198326242;2070.4306315763133;2077.4598604362823;2101.9684704729366;2134.5197330600568;2162.91348346066;2164.058634494;2164.686120512517;2166.7833216678364;2119.109973810988;2162.243214874797;2162.978370216309;2163.210428193698;2166.382580964433;7513.774586762406;7629.542227466314;7714.151443341228;7727.227277272284;7756.457048006641;4236.0257140857775;4304.612584867377;4333.349997500369;4333.566643335673;4345.630621397185;2859.356644754934;2880.1215629233075;2923.5760814681753;2950.542665886791;2976.2113040044405;916.2486760856101;923.9769005774842;931.0317270039151;959.7792507723262;969.5443141723379;10319.535620897077;10464.52909619069;10483.633072842415;10606.15150787935;10623.57505699771;4171.228322760299;4256.936145957813;4340;4356.499002614676;4389.604935555815;9089.954550227207;9103.362764606414;9120.45277283365;9190.770230744285;9204.539773011322;4410.955890441054;4415.227335216325;4418.911621767546;4422.601965823092;4423.867283981485;3509.368313703507;3939.803009849496;4006.819693113817;4061.7969101544804;4103.343465045638;3734.458503516975;3739.6634302912867;3802.752821066622;3826.808659567066;3871.225754848985;1175.3418085871767;1207.7222238885106;1213.8664746877837;1223.7736018836545;1229.26244253449;735.2463724682243;798.6485946183777;811.3265989228926;846.8518009348339;855.6534603485599;5057.418396884332;5080.923786143211;5105.106606343875;5133.307003554547;5174.223866420067;391.9098607320332;405.1532297498184;407.2953789943355;411.1940596430969;413.9898647300637;3207.5028370602595;3252.495863141217;3262.967370326314;3278.0821370016433;3375.8312084395684;9379.718608441757;9705.223582113415;9792.951035244778;9801.705948821547;9835.557399917021;9572.808543829084;9684.661036863676;9848.950755246178;9849.162821160282;9863.260255480867;7236.529625574426;7405.370543503755;7464.066991626047;7486.1016677997895;7490.4382171337365;5011.223260394645;5064.087834800238;5067.163917953644;5071.898562028812;5160.535551800356;8835.160659737314;8946.68686595966;9060.229880460234;9167.220786233245;9178.632854685738;9106.726798196065;9174.403663761834;9205.539723013688;9243.537823108683;9274.350795444254;5830.4461076197695;6383.425491705769;6597.538172327891;6627.801165965029;6693.096431981815;7606.087269527471;7639.503432276884;7642.732504362543;7668.6165691716305;7700.961495192712;6667;6815.079964204769;6862.862742745017;6905.861882762417;6909.2399836019;6611.041398997215;6691.029800678777;6748.055272261985;6817.227520844517;6920.169579650475;6100.847478813065;6138;6158;6228.781992630236;6262.185915831095;4219;4322.546132656026;4365.105153443473;4374.540673229392;4417.359482874901;4364.301711726109;4383.627391671616;4470;4520.095980803918;4553.271476563734 04:46:00 INFO - PROCESS | 3466 | |4;prototype.html;285.55509123833406;291.26455699359116;294.86730971063;295.9792814502986;296.6040336151238;4789.161896668083;4791.425028996526;4793.952060479394;4805.2850139671145;4824.407945378021;4727.267273572602;4745.932165262814;4750.28745688147;4755.144074066667;4783.139034973703;3535.752497325182;3616.493690883265;3637.6362363763546;3712.535933008374;3762.529683789526;3663.19409729859;3706.869404831525;3711.814409279525;3744.6817020553285;3748;3486.6339034401403;3652.009654738174;3664.6152154023844;3675.503806986063;3701.0932321581117;3563.964360356389;3706.66560038386;3723.962760372389;3724.478572999782;3731.9626803731885;3253.5933008373954;3258.6415494295607;3260.1523603863166;3264.6408895021527;3273.6071671399345;4565.840195593171;4566.26939689648;4567.840125595588;4572.862814115549;4574.679772415932;3965.7620542767236;4163.3130533461945;4200.4539409876825;4240.787960601958;4242.363645453176;4989.975050124763;5003.674761140514;5004.84985450437;5021;5027.673201241908;3506.877259295938;3513.472979053137;3516.050666320105;3519.665631764978;3530.699890509284;5119.180931051014;5232.241325007891;5243.2659427680155;5265.921011184835;5288.576913846921;3564.518789963374;3594.7663401878795;3610.765300255475;3613.4760459733716;3623.764455310449;3636.818159092035;3642.1076836175307;3648;3650.671439570451;3652.9634703652623;4205.6635469163;4206.8737937861915;4208.6633069354375;4211.789410529523;4216.47294088239;4917.87705307363;5017.1721665924715;5040.873978150576;5042.596592272609;5055.494450554915;1262.4319056424645;1266.1453518874723;1272.1998372303087;1272.7518133963788;1274.6048724895313;791.9388020053157;804.1676864445271;822.1696086952102;848.9490630562186;852.6376290076817;4358.869233922987;4399.978000109979;4409.316555933835;4410.434295825;4415.5363686812425;5148;5151.192600032916;5151.918097199555;5161.561267292323;5164.561012313995;4209.515905670826;4366.345048242725;4378.912421751547;4385.662372976273;4408.25059739845;2722.1561315992108;2748.6014527893744;2757.1452849616685;2767.1283545683045;2775.9312664624267;4803.759812009385;4824.421069471616;4826.855194344175;4828.830990915301;4843;5067.239914012927;5212.921806172911;5216.895662086813;5260.92108618371;5261.76322065508;4748.264019077118;4773.594244489257;4798.760061996956;4801.18379875422;4832.685875418087;5120;5125.923111153261;5134.512221338967;5136.357955255593;5147.6654017488745;4735.881602959954;4980.477049909708;4998.6500944933505;5000.249962505508;5006.774695138801;4789.425268967746;4790.99389128273;4796.424429068534;4811.436283207901;4823.975880120577;3551.7691350062164;3560.572731272264;3566.233259849145;3582.2835432914044;3590.982045089758;4945.975270123627;5040.924386134137;5055.5955523557295;5094.108531006985;5240.71176085319;5062.392512898476;5072.492750724898;5086.949130508796;5088.931324421913;5103.464136265788;5050.3182070420025;5056;5058.974705126451;5072.4420313766195;5077.593792496666;4758.262469317261;4785.330053792542;4980.007996801309;4991.201407774739;5008.874778130576;4947.431045429677;5002.374703162105;5004;5005.399352077774;5012.147934851011;4889.608831293559;4958.8760280993265;4973.875653108701;4995.325631039763;5007.048660754445 04:46:00 INFO - PROCESS | 3466 | |5;yui.html;668.9732410703572;693.5318659904564;712.2450202785049;792.5363662257579;814.0475643497108;11025.669229923094;11559.133065020114;11671.533138674453;11673.241239319459;11695.415229238526;11391.088712902969;11508.251963622379;11626.186166968315;11628.081366574505;11679.182457227997;628.1582679209857;644.8291202831253;646.1309538670481;792.4611264340247;802.3460879383313;630.977915772948;634.9047642853586;780.5277806926813;813.6541969662899;817.4972391978949;834.015861283685;836.6611522333465;838.656150978099;839.5718183726314;840.1892174052039;829.7593697827623;833.2625626320689;833.5915401453244;834.1116710703081;834.2950207075042;484.6849547793927;492.39189600843287;496.6796416311495;496.98260560880556;595.6842873277127;11551.942240288829;11970.58102966392;12039.518419263219;12055.397230138458;12071.93964030183;11181.776364472666;11253.493592788343;11505.309681419141;11572.132090093277;12392.380380981005;11070.833937490863;11158.832617510743;11168.720781980433;11179.944100279528;11348.546058157664;4204.11713540157;4220.936685949713;4226.112516371566;4289.120730250291;4311.374850646639;44183.33724994128;45201.54798452039;45261.77369113166;45304;45435.77282113568;9557.139857412867;9637;9669.323147379757;9865.753356166153;9900.356476828983;17789.555261118316;17803.46589602314;17803.821961780475;17819.821801781814;17861.642767144585;6596.142501474777;6617.073609694647;6623.966880165664;6706.832329191711;6769.8646027079185;3638.7089032877307;3686.5023221864703;3757.9060523487133;3879.049632839916;3928.253631809947;2794.1896849913296;2878.3667593129476;2893.5225687761285;2895.2182910614015;2895.7828162887868;497.4180209155297;512.9333186685782;513.4249640402699;517.492857000142;518.2666526864444;463.8283834981079;504.4854248666413;505.72690746996943;515.6725479320584;525.6977238088039;7092.219855815856;7109.431245500347;7197.89203161953;7221.638918054181;7446.515976461513;403.68714246458643;432.9567043295708;480.27478507454;482.9396325459318;502.6958689992502;3090.474619314722;3155.432022235974;3180.3162320101287;3213.453712868818;3277.573915390984;53138.734306328224;53598;54496.72751636217;55048.17427738587;55458.445415546135;48415;49167.50832491629;49474.25788613174;49622;49643.50356496389;45573.08853822905;45636.543634563226;45690.08619827651;46091.30863037057;46708.5329146711;7969.561674107979;8079.636416361395;8172.101068882299;8174.877376839471;8318.043425006203;29883;29954.700452995192;31066.23433073655;31632.683673163894;32306.19234519062;37883.431748523246;38149;38821.6117838818;39474;43524;10760.246782725448;10780.784384312114;10828.783424331627;10903.982763188835;11335.149863760085;11678.569824372373;11837.526498940291;12036.578719744766;12263.69340766488;12318.199317044364;10979.945100274448;11078.667639970492;11400.94299528497;11413.201075924606;11937;9330;9603.471809050568;9854.704358869245;11139.88860111421;11398.715032124263;10762.623308184176;10864.674059778219;11179.944100279447;11308.604198853001;11326.263792853439;8477.558815001588;8805.383623146317;8959.641614335615;8960.283177345927;9246.676366327147;8950.14973577509;9121.589528471368;9153.542322883963;9175.816483670424;9343.252539796664 04:46:00 INFO - PROCESS | 3466 | __end_tp_report 04:46:00 INFO - PROCESS | 3466 | __start_cc_report 04:46:00 INFO - PROCESS | 3466 | _x_x_mozilla_cycle_collect,1033 04:46:00 INFO - PROCESS | 3466 | __end_cc_report 04:46:00 INFO - PROCESS | 3466 | __startTimestamp1464263160558__endTimestamp 04:46:00 INFO - PROCESS | 3466 | 04:46:00 INFO - PROCESS | 3466 | ------- Summary: start ------- 04:46:00 INFO - PROCESS | 3466 | Number of tests: 6 04:46:00 INFO - PROCESS | 3466 | 04:46:00 INFO - PROCESS | 3466 | [#0] dojo.html Cycles:165 Average:4613.65 Median:4732.00 stddev:472.43 (10.0%) stddev-sans-first:447.81 04:46:00 INFO - PROCESS | 3466 | Values: 2640.8 2680.1 2712.4 2718.9 2724.1 4559.1 4592.9 4638.8 4666.7 4726.7 4551.4 4568.0 4576.8 4596.1 4631.4 4081.4 4242.9 4328.0 4354.3 4374.3 4316.5 4346.7 4348.2 4366.6 4372.8 4212.1 4258.1 4259.7 4289.2 4319.8 4284.5 4303.0 4310.9 4314.7 4337.4 4315.0 4319.1 4334.0 4369.6 4375.6 4432.4 4520.6 4565.7 4569.0 4572.5 4982.4 4990.4 4994.7 5012.1 5016.3 4887.6 5000.0 5031.7 5032.0 5049.9 4654.4 4709.2 4719.6 4760.5 4765.5 5170.5 5219.8 5226.2 5230.3 5231.4 4769.4 4831.2 4991.6 5027.1 5030.2 4911.6 4951.2 4957.2 4978.0 5016.0 4890.2 4914.6 4916.5 4922.8 4965.9 4848.1 4852.5 4859.2 4887.2 4928.6 4247.1 4259.2 4286.7 4291.4 4299.9 3724.3 3733.5 3735.5 3745.2 3772.5 4119.5 4223.3 4232.3 4279.5 4321.2 4966.7 5013.2 5016.0 5045.7 5063.2 4291.4 4293.1 4300.6 4306.5 4348.8 4411.7 4433.3 4520.0 4521.8 4534.2 4643.9 4662.0 4668.0 4704.7 4709.2 5030.9 5043.1 5044.1 5054.6 5092.3 4562.4 4634.9 4711.1 4720.0 4742.6 4926.1 4951.1 4954.5 4988.4 5009.5 4992.1 5013.1 5016.5 5022.0 5063.9 4764.7 4768.5 4795.6 4890.7 4960.4 4771.4 4785.7 4787.4 4819.2 4841.1 4732.0 4732.7 4747.2 4761.6 4820.0 4841.2 4877.8 4927.2 4934.7 4935.3 4845.7 4856.0 4861.6 4876.9 4907.4 04:46:00 INFO - PROCESS | 3466 | 04:46:00 INFO - PROCESS | 3466 | [#1] ext.html Cycles:180 Average:47084.39 Median:35433.32 stddev:83561.78 (235.8%) stddev-sans-first:83723.20 04:46:00 INFO - PROCESS | 3466 | Values: 565.0 587.3 599.8 603.9 609.4 38271.0 39594.8 39595.0 39680.2 44345.6 40189.2 40823.2 40856.0 40881.0 41005.2 7434.1 7557.4 7638.0 7670.8 7808.2 7410.6 9676.2 9967.7 9971.9 10258.2 10103.9 10174.7 10179.3 10181.2 10185.6 7495.4 7757.3 10000.1 10077.6 10083.1 7573.0 9606.0 10027.4 10048.4 10361.1 36345.5 36621.3 36647.0 36704.3 36807.0 2829.7 2899.3 2912.4 3384.3 3593.4 28343.4 29525.7 29643.0 29661.0 29738.9 3551.7 3558.2 3580.0 3587.4 3601.9 265374.0 269144.0 270669.0 271159.0 271214.0 54426.2 55222.4 55250.9 55490.7 55518.0 56746.7 56912.0 57054.4 57076.0 57295.7 13034.2 13356.6 13393.3 13453.4 13460.9 9385.5 11390.2 11541.5 11620.9 11686.0 17863.3 17927.8 17975.4 18059.2 18062.1 6900.0 6957.0 7036.4 7090.3 7106.9 849.7 894.7 952.0 953.3 969.8 27343.5 27373.9 27541.0 27667.7 28007.0 965.2 1013.5 1026.9 1059.8 1124.2 14347.7 14552.3 14684.3 14786.5 14907.8 377754.0 378435.0 385530.0 387485.0 388953.0 48589.3 48684.3 48929.0 49264.8 49425.3 980.5 1073.2 1148.9 1158.4 1227.1 25160.9 28087.6 28537.0 28958.6 29239.9 41079.6 41267.4 41691.4 41697.2 41719.8 286591.0 288734.0 289651.0 289799.0 290341.0 19883.2 23973.0 24657.6 24817.3 26192.2 40370.4 40693.4 40739.6 41204.4 41349.4 34723.3 35241.6 35404.6 35462.0 35786.0 35557.6 36053.0 36234.0 36253.3 36273.3 33920.3 34471.7 34613.5 34745.3 35104.5 30789.0 31874.8 31930.8 32053.4 32431.4 24494.6 24564.5 24649.8 24759.4 24862.4 04:46:00 INFO - PROCESS | 3466 | 04:46:00 INFO - PROCESS | 3466 | [#2] jquery.html Cycles:180 Average:22842.99 Median:44704.89 stddev:59220.69 (132.5%) stddev-sans-first:59362.79 04:46:00 INFO - PROCESS | 3466 | Values: 370.8 372.0 373.4 376.9 383.2 15729.8 16744.9 17328.4 17340.6 17577.4 15502.8 15755.8 16373.1 16577.9 16595.3 5023.4 5196.7 5206.4 5217.8 5227.3 3681.8 3899.1 5119.3 5656.2 6014.5 5990.8 6027.2 6070.9 6072.1 6074.1 5880.5 5896.4 6032.1 6041.7 6054.2 3381.6 5004.9 5289.9 5380.4 5387.0 19975.2 20443.9 20551.5 20928.5 20954.0 1922.3 2198.4 2330.3 2430.7 2465.1 12828.9 12903.2 13188.0 13342.2 13599.2 1727.6 1816.8 1852.3 1885.0 1891.5 61238.2 64686.7 64962.4 65244.7 65386.3 9280.2 9551.1 9685.7 9807.3 9952.0 13082.8 13119.6 13139.2 13156.9 13183.3 7101.4 7127.2 7157.2 7302.6 7311.2 6866.7 6909.1 6920.9 6942.5 6995.7 6165.5 6193.6 6219.9 6233.7 6275.5 1616.5 1699.3 1704.4 1705.3 1727.7 726.5 853.4 882.0 927.4 930.9 16901.9 17465.3 17467.4 17729.6 18009.3 837.2 907.3 917.5 920.9 938.0 9881.9 10023.1 10247.4 10256.4 10264.5 355055.0 358609.0 360433.0 363326.0 364848.0 63478.0 64999.4 65056.0 65151.3 65284.9 857.1 857.7 976.8 995.6 1003.1 14848.7 15452.5 16188.8 16311.8 16399.9 31339.4 32052.0 32821.8 33114.5 33619.7 44181.3 44537.3 44612.0 44636.0 44773.8 7602.4 7765.7 7771.1 7818.4 7992.8 11373.3 11508.8 11742.9 11854.3 12359.2 8967.0 9018.6 9133.5 9228.2 9414.5 10320.6 10348.1 10554.3 10606.5 10678.8 9720.0 9784.4 10055.6 10231.0 10286.2 7545.5 7657.6 7696.2 7754.6 8032.0 7205.7 9533.2 9988.3 9994.6 10170.6 04:46:00 INFO - PROCESS | 3466 | 04:46:00 INFO - PROCESS | 3466 | [#3] mootools.html Cycles:180 Average:5079.24 Median:5034.32 stddev:2911.47 (57.8%) stddev-sans-first:2905.65 04:46:00 INFO - PROCESS | 3466 | Values: 1281.4 1363.4 1426.0 1524.2 1766.7 6739.4 7384.9 7680.7 7683.6 7833.1 7320.6 7518.7 7584.9 7719.9 7752.1 2162.0 2223.5 2224.1 2224.7 2225.7 2111.2 2154.3 2187.4 2194.0 2195.8 2055.7 2060.7 2070.4 2077.5 2102.0 2134.5 2162.9 2164.1 2164.7 2166.8 2119.1 2162.2 2163.0 2163.2 2166.4 7513.8 7629.5 7714.2 7727.2 7756.5 4236.0 4304.6 4333.3 4333.6 4345.6 2859.4 2880.1 2923.6 2950.5 2976.2 916.2 924.0 931.0 959.8 969.5 10319.5 10464.5 10483.6 10606.2 10623.6 4171.2 4256.9 4340.0 4356.5 4389.6 9090.0 9103.4 9120.5 9190.8 9204.5 4411.0 4415.2 4418.9 4422.6 4423.9 3509.4 3939.8 4006.8 4061.8 4103.3 3734.5 3739.7 3802.8 3826.8 3871.2 1175.3 1207.7 1213.9 1223.8 1229.3 735.2 798.6 811.3 846.9 855.7 5057.4 5080.9 5105.1 5133.3 5174.2 391.9 405.2 407.3 411.2 414.0 3207.5 3252.5 3263.0 3278.1 3375.8 9379.7 9705.2 9793.0 9801.7 9835.6 9572.8 9684.7 9849.0 9849.2 9863.3 7236.5 7405.4 7464.1 7486.1 7490.4 5011.2 5064.1 5067.2 5071.9 5160.5 8835.2 8946.7 9060.2 9167.2 9178.6 9106.7 9174.4 9205.5 9243.5 9274.4 5830.4 6383.4 6597.5 6627.8 6693.1 7606.1 7639.5 7642.7 7668.6 7701.0 6667.0 6815.1 6862.9 6905.9 6909.2 6611.0 6691.0 6748.1 6817.2 6920.2 6100.8 6138.0 6158.0 6228.8 6262.2 4219.0 4322.5 4365.1 4374.5 4417.4 4364.3 4383.6 4470.0 4520.1 4553.3 04:46:00 INFO - PROCESS | 3466 | 04:46:00 INFO - PROCESS | 3466 | [#4] prototype.html Cycles:180 Average:4135.30 Median:4756.70 stddev:1210.86 (25.5%) stddev-sans-first:1179.28 04:46:00 INFO - PROCESS | 3466 | Values: 285.6 291.3 294.9 296.0 296.6 4789.2 4791.4 4794.0 4805.3 4824.4 4727.3 4745.9 4750.3 4755.1 4783.1 3535.8 3616.5 3637.6 3712.5 3762.5 3663.2 3706.9 3711.8 3744.7 3748.0 3486.6 3652.0 3664.6 3675.5 3701.1 3564.0 3706.7 3724.0 3724.5 3732.0 3253.6 3258.6 3260.2 3264.6 3273.6 4565.8 4566.3 4567.8 4572.9 4574.7 3965.8 4163.3 4200.5 4240.8 4242.4 4990.0 5003.7 5004.8 5021.0 5027.7 3506.9 3513.5 3516.1 3519.7 3530.7 5119.2 5232.2 5243.3 5265.9 5288.6 3564.5 3594.8 3610.8 3613.5 3623.8 3636.8 3642.1 3648.0 3650.7 3653.0 4205.7 4206.9 4208.7 4211.8 4216.5 4917.9 5017.2 5040.9 5042.6 5055.5 1262.4 1266.1 1272.2 1272.8 1274.6 791.9 804.2 822.2 848.9 852.6 4358.9 4400.0 4409.3 4410.4 4415.5 5148.0 5151.2 5151.9 5161.6 5164.6 4209.5 4366.3 4378.9 4385.7 4408.3 2722.2 2748.6 2757.1 2767.1 2775.9 4803.8 4824.4 4826.9 4828.8 4843.0 5067.2 5212.9 5216.9 5260.9 5261.8 4748.3 4773.6 4798.8 4801.2 4832.7 5120.0 5125.9 5134.5 5136.4 5147.7 4735.9 4980.5 4998.7 5000.2 5006.8 4789.4 4791.0 4796.4 4811.4 4824.0 3551.8 3560.6 3566.2 3582.3 3591.0 4946.0 5040.9 5055.6 5094.1 5240.7 5062.4 5072.5 5086.9 5088.9 5103.5 5050.3 5056.0 5059.0 5072.4 5077.6 4758.3 4785.3 4980.0 4991.2 5008.9 4947.4 5002.4 5004.0 5005.4 5012.1 4889.6 4958.9 4973.9 4995.3 5007.0 04:46:00 INFO - PROCESS | 3466 | 04:46:00 INFO - PROCESS | 3466 | [#5] yui.html Cycles:180 Average:12948.50 Median:45663.31 stddev:15043.58 (32.9%) stddev-sans-first:15057.52 04:46:00 INFO - PROCESS | 3466 | Values: 669.0 693.5 712.2 792.5 814.0 11025.7 11559.1 11671.5 11673.2 11695.4 11391.1 11508.3 11626.2 11628.1 11679.2 628.2 644.8 646.1 792.5 802.3 631.0 634.9 780.5 813.7 817.5 834.0 836.7 838.7 839.6 840.2 829.8 833.3 833.6 834.1 834.3 484.7 492.4 496.7 497.0 595.7 11551.9 11970.6 12039.5 12055.4 12071.9 11181.8 11253.5 11505.3 11572.1 12392.4 11070.8 11158.8 11168.7 11179.9 11348.5 4204.1 4220.9 4226.1 4289.1 4311.4 44183.3 45201.5 45261.8 45304.0 45435.8 9557.1 9637.0 9669.3 9865.8 9900.4 17789.6 17803.5 17803.8 17819.8 17861.6 6596.1 6617.1 6624.0 6706.8 6769.9 3638.7 3686.5 3757.9 3879.0 3928.3 2794.2 2878.4 2893.5 2895.2 2895.8 497.4 512.9 513.4 517.5 518.3 463.8 504.5 505.7 515.7 525.7 7092.2 7109.4 7197.9 7221.6 7446.5 403.7 433.0 480.3 482.9 502.7 3090.5 3155.4 3180.3 3213.5 3277.6 53138.7 53598.0 54496.7 55048.2 55458.4 48415.0 49167.5 49474.3 49622.0 49643.5 45573.1 45636.5 45690.1 46091.3 46708.5 7969.6 8079.6 8172.1 8174.9 8318.0 29883.0 29954.7 31066.2 31632.7 32306.2 37883.4 38149.0 38821.6 39474.0 43524.0 10760.2 10780.8 10828.8 10904.0 11335.1 11678.6 11837.5 12036.6 12263.7 12318.2 10979.9 11078.7 11400.9 11413.2 11937.0 9330.0 9603.5 9854.7 11139.9 11398.7 10762.6 10864.7 11179.9 11308.6 11326.3 8477.6 8805.4 8959.6 8960.3 9246.7 8950.1 9121.6 9153.5 9175.8 9343.3 04:46:00 INFO - PROCESS | 3466 | -------- Summary: end -------- 04:46:00 INFO - PROCESS | 3466 | 04:46:01 INFO - TEST-INFO | 3466: exit 0 04:46:01 INFO - TEST-OK | dromaeo_css | took 1121995ms 04:46:01 INFO - TEST-START | kraken 04:46:01 INFO - operating with platform_type : linux_ 04:46:01 INFO - Initialising browser for kraken test... 04:46:01 INFO - TEST-INFO | started process 3641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6RBRDb/profile http://localhost:45947/getInfo.html) 04:46:06 INFO - PROCESS | 3641 | __metrics Screen width/height:1600/1200 04:46:06 INFO - PROCESS | 3641 | colorDepth:24 04:46:06 INFO - PROCESS | 3641 | Browser inner width/height: 1024/697 04:46:06 INFO - PROCESS | 3641 | __metrics 04:46:07 ERROR - PROCESS | 3641 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:46:08 INFO - TEST-INFO | 3641: exit 0 04:46:08 INFO - Browser initialized. 04:46:08 INFO - Running cycle 1/1 for kraken test... 04:46:08 INFO - TEST-INFO | started process 3725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6RBRDb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:20 INFO - PROCESS | 3725 | RSS: Main: 157204480 04:46:20 INFO - PROCESS | 3725 | 04:46:22 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45947/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:23 INFO - PROCESS | 3725 | RSS: Main: 213229568 04:46:23 INFO - PROCESS | 3725 | 04:46:26 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45947/tests/kraken/driver.html?testName=audio-dft) 04:46:27 INFO - PROCESS | 3725 | RSS: Main: 201060352 04:46:27 INFO - PROCESS | 3725 | 04:46:30 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45947/tests/kraken/driver.html?testName=audio-fft) 04:46:31 INFO - PROCESS | 3725 | RSS: Main: 269938688 04:46:31 INFO - PROCESS | 3725 | 04:46:33 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45947/tests/kraken/driver.html?testName=audio-oscillator) 04:46:33 INFO - PROCESS | 3725 | RSS: Main: 178937856 04:46:33 INFO - PROCESS | 3725 | 04:46:36 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:36 INFO - PROCESS | 3725 | RSS: Main: 182824960 04:46:36 INFO - PROCESS | 3725 | 04:46:39 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45947/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:40 INFO - PROCESS | 3725 | RSS: Main: 218533888 04:46:40 INFO - PROCESS | 3725 | 04:46:44 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45947/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:44 INFO - PROCESS | 3725 | RSS: Main: 216412160 04:46:44 INFO - PROCESS | 3725 | 04:46:47 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45947/tests/kraken/driver.html?testName=json-parse-financial) 04:46:48 INFO - PROCESS | 3725 | RSS: Main: 218025984 04:46:48 INFO - PROCESS | 3725 | 04:46:50 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:50 INFO - PROCESS | 3725 | RSS: Main: 206426112 04:46:50 INFO - PROCESS | 3725 | 04:46:52 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:53 INFO - PROCESS | 3725 | RSS: Main: 211410944 04:46:53 INFO - PROCESS | 3725 | 04:46:55 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:56 INFO - PROCESS | 3725 | RSS: Main: 223313920 04:46:56 INFO - PROCESS | 3725 | 04:46:58 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:59 INFO - PROCESS | 3725 | RSS: Main: 228040704 04:46:59 INFO - PROCESS | 3725 | 04:47:02 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:02 INFO - PROCESS | 3725 | RSS: Main: 223686656 04:47:02 INFO - PROCESS | 3725 | 04:47:04 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45947/tests/kraken/driver.html?testName=ai-astar) 04:47:04 INFO - PROCESS | 3725 | RSS: Main: 269238272 04:47:04 INFO - PROCESS | 3725 | 04:47:04 INFO - PROCESS | 3725 | __start_tp_report 04:47:04 INFO - PROCESS | 3725 | _x_x_mozilla_page_load 04:47:04 INFO - PROCESS | 3725 | _x_x_mozilla_page_load_details 04:47:04 INFO - PROCESS | 3725 | |i|pagename|runs| 04:47:04 INFO - PROCESS | 3725 | |0;ai-astar;114;113;116;115;114;114;113;113;115;113 04:47:04 INFO - PROCESS | 3725 | |1;audio-beat-detection;155;132;131;180;132;135;158;139;172;129 04:47:04 INFO - PROCESS | 3725 | |2;audio-dft;165;163;160;163;163;164;163;163;166;162 04:47:04 INFO - PROCESS | 3725 | |3;audio-fft;76;77;78;109;77;76;74;78;115;75 04:47:04 INFO - PROCESS | 3725 | |4;audio-oscillator;85;84;121;84;85;85;118;84;84;117 04:47:04 INFO - PROCESS | 3725 | |5;imaging-gaussian-blur;117;118;117;117;116;118;117;117;116;117 04:47:04 INFO - PROCESS | 3725 | |6;imaging-darkroom;146;146;146;146;147;148;147;147;146;146 04:47:04 INFO - PROCESS | 3725 | |7;imaging-desaturate;95;96;95;95;95;95;96;94;95;95 04:47:04 INFO - PROCESS | 3725 | |8;json-parse-financial;65;65;65;64;64;65;65;78;63;62 04:47:04 INFO - PROCESS | 3725 | |9;json-stringify-tinderbox;66;66;66;67;66;66;66;68;65;65 04:47:04 INFO - PROCESS | 3725 | |10;stanford-crypto-aes;99;87;84;84;84;85;85;86;92;85 04:47:04 INFO - PROCESS | 3725 | |11;stanford-crypto-ccm;131;137;132;132;130;127;129;132;186;133 04:47:04 INFO - PROCESS | 3725 | |12;stanford-crypto-pbkdf2;180;173;175;174;173;175;178;174;171;173 04:47:04 INFO - PROCESS | 3725 | |13;stanford-crypto-sha256-iterative;68;66;68;70;67;66;67;67;65;66 04:47:04 INFO - PROCESS | 3725 | __end_tp_report 04:47:04 INFO - PROCESS | 3725 | __start_cc_report 04:47:04 INFO - PROCESS | 3725 | _x_x_mozilla_cycle_collect,1884 04:47:04 INFO - PROCESS | 3725 | __end_cc_report 04:47:04 INFO - PROCESS | 3725 | __startTimestamp1464263224991__endTimestamp 04:47:04 INFO - PROCESS | 3725 | 04:47:04 INFO - PROCESS | 3725 | ------- Summary: start ------- 04:47:04 INFO - PROCESS | 3725 | Number of tests: 14 04:47:04 INFO - PROCESS | 3725 | 04:47:04 INFO - PROCESS | 3725 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.05 (0.9%) stddev-sans-first:1.12 04:47:04 INFO - PROCESS | 3725 | Values: 114.0 113.0 116.0 115.0 114.0 114.0 113.0 113.0 115.0 113.0 04:47:04 INFO - PROCESS | 3725 | 04:47:04 INFO - PROCESS | 3725 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:147.00 stddev:18.66 (12.7%) stddev-sans-first:19.52 04:47:04 INFO - PROCESS | 3725 | Values: 155.0 132.0 131.0 180.0 132.0 135.0 158.0 139.0 172.0 129.0 04:47:04 INFO - PROCESS | 3725 | 04:47:04 INFO - PROCESS | 3725 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.62 (1.0%) stddev-sans-first:1.58 04:47:05 INFO - PROCESS | 3725 | Values: 165.0 163.0 160.0 163.0 163.0 164.0 163.0 163.0 166.0 162.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.50 stddev:15.14 (19.8%) stddev-sans-first:15.81 04:47:05 INFO - PROCESS | 3725 | Values: 76.0 77.0 78.0 109.0 77.0 76.0 74.0 78.0 115.0 75.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:84.00 stddev:16.57 (19.7%) stddev-sans-first:17.20 04:47:05 INFO - PROCESS | 3725 | Values: 85.0 84.0 121.0 84.0 85.0 85.0 118.0 84.0 84.0 117.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:47:05 INFO - PROCESS | 3725 | Values: 117.0 118.0 117.0 117.0 116.0 118.0 117.0 117.0 116.0 117.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:47:05 INFO - PROCESS | 3725 | Values: 146.0 146.0 146.0 146.0 147.0 148.0 147.0 147.0 146.0 146.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:47:05 INFO - PROCESS | 3725 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:4.48 (6.9%) stddev-sans-first:4.74 04:47:05 INFO - PROCESS | 3725 | Values: 65.0 65.0 65.0 64.0 64.0 65.0 65.0 78.0 63.0 62.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 04:47:05 INFO - PROCESS | 3725 | Values: 66.0 66.0 66.0 67.0 66.0 66.0 66.0 68.0 65.0 65.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.50 stddev:4.82 (5.6%) stddev-sans-first:2.54 04:47:05 INFO - PROCESS | 3725 | Values: 99.0 87.0 84.0 84.0 84.0 85.0 85.0 86.0 92.0 85.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:132.00 stddev:17.45 (13.2%) stddev-sans-first:18.38 04:47:05 INFO - PROCESS | 3725 | Values: 131.0 137.0 132.0 132.0 130.0 127.0 129.0 132.0 186.0 133.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:174.50 stddev:2.63 (1.5%) stddev-sans-first:1.94 04:47:05 INFO - PROCESS | 3725 | Values: 180.0 173.0 175.0 174.0 173.0 175.0 178.0 174.0 171.0 173.0 04:47:05 INFO - PROCESS | 3725 | 04:47:05 INFO - PROCESS | 3725 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.41 (2.1%) stddev-sans-first:1.45 04:47:05 INFO - PROCESS | 3725 | Values: 68.0 66.0 68.0 70.0 67.0 66.0 67.0 67.0 65.0 66.0 04:47:05 INFO - PROCESS | 3725 | -------- Summary: end -------- 04:47:05 INFO - PROCESS | 3725 | 04:47:07 INFO - TEST-INFO | 3725: exit 0 04:47:07 INFO - TEST-OK | kraken | took 65900ms 04:47:07 INFO - SUITE-END | took 1187s 04:47:07 INFO - Completed test suite (00:19:48) 04:47:07 INFO - javascript benchmark 04:47:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.762331390175, 2680.128958088622, 2712.4168303814677, 2718.864056797161, 2724.1282789507354, 4559.110973360188, 4592.862214133577, 4638.768061596915, 4666.7199968001905, 4726.740029298391, 4551.408316918796, 4568.0, 4576.83981060663, 4596.080783843228, 4631.374764406804, 4081.449004384415, 4242.8727138185905, 4327.978360108211, 4354.3250796126495, 4374.343848422746, 4316.503602085769, 4346.695731298811, 4348.195583816988, 4366.628836548897, 4372.759498227596, 4212.115455754295, 4258.127083947783, 4259.74441533509, 4289.24938135825, 4319.784010799447, 4284.485861696617, 4303.010307629263, 4310.870673879788, 4314.697971142022, 4337.392765012901, 4314.956850431518, 4319.092990472004, 4334.003179268786, 4369.58488943553, 4375.606195442394, 4432.3794668746405, 4520.638348932078, 4565.680402371835, 4569.0, 4572.497025327211, 4982.402111746614, 4990.4011518617635, 4994.700317980933, 5012.122878496249, 5016.3227964224725, 4887.608991280689, 4999.9500004999845, 5031.723255220962, 5032.0, 5049.924251136236, 4654.418197725285, 4709.152352576501, 4719.622430205575, 4760.523947605281, 4765.547273009059, 5170.482951704799, 5219.765110570033, 5226.242194881721, 5230.320058392384, 5231.372235331784, 4769.403824521934, 4831.227003679464, 4991.575716064102, 5027.145385284511, 5030.245463180552, 4911.582515486224, 4951.158303088484, 4957.182064959314, 4978.0, 5016.046951079284, 4890.24201248807, 4914.631402644816, 4916.483769204182, 4922.75386230687, 4965.900681986413, 4848.054629347314, 4852.4662287148385, 4859.173940430135, 4887.193613053877, 4928.6057115431395, 4247.10810729744, 4259.212045771542, 4286.6999310047995, 4291.356296555479, 4299.871003869889, 3724.2923844469465, 3733.5146430964346, 3735.533058367704, 3745.2135051638916, 3772.5472943246436, 4119.526254480713, 4223.282042052859, 4232.25935461293, 4279.507856596469, 4321.178975994551, 4966.726830024311, 5013.172826483662, 5015.974920125376, 5045.747712614355, 5063.215201643751, 4291.3777502262, 4293.119910418357, 4300.569943005675, 4306.5262821089655, 4348.760818155032, 4411.713238639478, 4433.312836510346, 4520.005598768332, 4521.819127234874, 4534.161180181677, 4643.907121857612, 4662.044280922402, 4667.953320466888, 4704.670673052853, 4709.175894218567, 5030.924536131888, 5043.142665746758, 5044.0920634286185, 5054.59563234933, 5092.312537807348, 4562.36126942235, 4634.907301854011, 4711.081339138835, 4720.032393359422, 4742.596879265301, 4926.088673595396, 4951.084049450863, 4954.479779623088, 4988.376452943382, 5009.5491405773655, 4992.076465853684, 5013.147764879906, 5016.498350164954, 5021.974890125526, 5063.924041139312, 4764.714117152982, 4768.546988036131, 4795.64032697556, 4890.657653964188, 4960.404751429852, 4771.355866958055, 4785.688930219525, 4787.42550893895, 4819.228923372244, 4841.1285968526, 4732.0, 4732.716037037789, 4747.192977193817, 4761.571458568606, 4820.0, 4841.201201801804, 4877.780499877443, 4927.162382394929, 4934.679245849152, 4935.284383764262, 4845.733484658378, 4855.95144048555, 4861.562459378673, 4876.90246195067, 4907.411110666742], "value": 4584.847945456165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.96327738697, 587.3392433512298, 599.7960693364255, 603.8978863573977, 609.3662590905453, 38271.0, 39594.80202598986, 39595.0, 39680.20639587207, 44345.55654443455, 40189.19621607566, 40823.183536329256, 40856.0, 40881.0, 41005.179896402056, 7434.070741157356, 7557.4331925105835, 7638.0, 7670.846583068349, 7808.219178082175, 7410.629468526552, 9676.225901927828, 9967.700968970907, 9971.850422243671, 10258.23063270254, 10103.949480252626, 10174.745631359237, 10179.338343007717, 10181.236407269447, 10185.643502477415, 7495.362894154004, 7757.340626046793, 10000.099991000809, 10077.596896124183, 10083.092521673012, 7572.962135189344, 9605.951970240174, 10027.398356098658, 10048.44733539655, 10361.067503924607, 36345.45481817775, 36621.26757464836, 36647.0, 36704.26591468156, 36806.95123536409, 2829.717028297154, 2899.347646779479, 2912.3738396244908, 3384.3062172254627, 3593.425051991695, 28343.433131337464, 29525.704742952727, 29643.0, 29661.0, 29738.851305743334, 3551.662592053751, 3558.19940513385, 3580.0333909844458, 3587.3542762302777, 3601.9194241727637, 265374.0, 269143.999999998, 270669.0, 271159.0, 271214.0, 54426.18360724593, 55222.44777552253, 55250.89498210013, 55490.72254638782, 55518.0, 56746.71626641841, 56912.0, 57054.429455704914, 57076.0, 57295.713521432124, 13034.217946923214, 13356.599302020955, 13393.330333483287, 13453.394597243148, 13460.865391346157, 9385.483798391155, 11390.202685812079, 11541.480633371519, 11620.941895290469, 11686.0, 17863.285468581373, 17927.820721792614, 17975.370862019765, 18059.187336569885, 18062.09689515519, 6899.965500172467, 6956.965215173892, 7036.366726994493, 7090.255523170096, 7106.893396599055, 849.6898631999276, 894.7405252476709, 951.9524023798782, 953.270747877874, 969.8108868770522, 27343.45313093727, 27373.86313068462, 27541.0, 27667.723322766513, 28007.0, 965.16513216069, 1013.5236438873718, 1026.8767747870304, 1059.8251288537458, 1124.24675467437, 14347.713045739027, 14552.345144468525, 14684.339204735812, 14786.482473113605, 14907.776383354258, 377754.0, 378435.0, 385530.0, 387485.0, 388953.0, 48589.271160932614, 48684.26973595328, 48929.0, 49264.7536762321, 49425.25862112071, 980.4901451245313, 1073.1522097542854, 1148.8678801937883, 1158.3918442817587, 1227.098082909061, 25160.874195629636, 28087.578686320132, 28537.0, 28958.565621516114, 29239.85380073086, 41079.58920410758, 41267.38098928458, 41691.37462938119, 41697.1660566793, 41719.7914010428, 286591.0, 288734.0, 289651.0, 289799.0, 290341.0, 19883.204671812964, 23973.0, 24657.63013554762, 24817.25548233556, 26192.214233573024, 40370.39444408395, 40693.38959915663, 40739.592604074765, 41204.38193427161, 41349.37975930423, 34723.30553388969, 35241.64758352384, 35404.64595354014, 35462.0, 35786.0, 35557.64442355543, 36053.0, 36234.0, 36253.27493450169, 36273.27453450864, 33920.321593568486, 34471.65528344785, 34613.48079778856, 34745.30509389849, 35104.47343289802, 30789.0, 31874.84062579672, 31930.840345798122, 32053.358932820745, 32431.35137297288, 24494.63258051095, 24564.50870982606, 24649.753502465464, 24759.38101547476, 24862.375238532848], "value": 17826.60570863934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8145927036482, 372.0494137478741, 373.42306137018306, 376.8530273193457, 383.23735765825995, 15729.842701572996, 16744.916275418607, 17328.393506227283, 17340.56648583786, 17577.384791532284, 15502.767458488132, 15755.763663545027, 16373.09947952862, 16577.917110414463, 16595.253213605385, 5023.3971923369245, 5196.662216955886, 5206.375234971809, 5217.817376391827, 5227.294315267428, 3681.8343174557076, 3899.122697393092, 5119.334486516747, 5656.208130861683, 6014.458698717114, 5990.820275391745, 6027.186329845481, 6070.878582428349, 6072.089186621998, 6074.088886666991, 5880.470757631833, 5896.439838215363, 6032.065029920369, 6041.667708276043, 6054.182685337467, 3381.5942086949476, 5004.924926126111, 5289.9471005290225, 5380.381256155514, 5386.973065134688, 19975.200991960304, 20443.89778051115, 20551.486212844648, 20928.47678808042, 20954.0, 1922.3079691311116, 2198.4393979535275, 2330.3221680390093, 2430.6961629796274, 2465.112559478604, 12828.871711282862, 12903.16129451592, 13188.0, 13342.19946803195, 13599.184048956995, 1727.6112874603239, 1816.7910690270655, 1852.2590963614527, 1884.9811501884942, 1891.5460289530413, 61238.17113258284, 64686.67656661734, 64962.350376496106, 65244.67377663129, 65386.3461365385, 9280.164785169367, 9551.14039736427, 9685.70942871715, 9807.313488055768, 9952.0, 13082.803757943639, 13119.62243964389, 13139.211647301192, 13156.868431315565, 13183.274919879499, 7101.431885449152, 7127.180374256923, 7157.176924653628, 7302.634868256566, 7311.195768465464, 6866.656667166621, 6909.136357955255, 6920.861582768316, 6942.494040509611, 6995.685194166274, 6165.537584681167, 6193.628382297076, 6219.937800622027, 6233.688315584202, 6275.466585340206, 1616.4908053962963, 1699.337258469198, 1704.3693833281766, 1705.3263960735687, 1727.6631056943775, 726.5241266970143, 853.3557164340883, 881.969131080409, 927.3832901120679, 930.8696782450462, 16901.91549042247, 17465.301387944593, 17467.38864139749, 17729.645407091786, 18009.279628814962, 837.2297486312607, 907.3285768531372, 917.5091326140616, 920.9217216536535, 937.9765505862408, 9881.901180988241, 10023.14803241718, 10247.38515689061, 10256.38461692301, 10264.486775661187, 355055.0, 358609.0, 360433.0, 363326.0, 364848.0, 63478.0, 64999.35000650027, 65056.02415963764, 65151.348486515475, 65284.94301139791, 857.1171693155935, 857.6955180910811, 976.8046390721884, 995.5520015992832, 1003.0821798054699, 14848.703025939205, 15452.459163929658, 16188.838111618734, 16311.836881631032, 16399.91800040992, 31339.386890172664, 32052.0, 32821.835890820395, 33114.50328245127, 33619.663803361655, 44181.337279940184, 44537.331940020274, 44612.0, 44636.0, 44773.77613112044, 7602.4298177638, 7765.650545725343, 7771.145174030965, 7818.374530037697, 7992.840143196987, 11373.260738052, 11508.769824603629, 11742.941285293518, 11854.348010859141, 12359.196652217577, 8967.0, 9018.639254429749, 9133.543322833699, 9228.169464748205, 9414.529273536433, 10320.587176512856, 10348.068673819393, 10554.261201715806, 10606.469676516297, 10678.83981740259, 9719.951400242953, 9784.412935223909, 10055.597776088875, 10231.0, 10286.228532859916, 7545.547267163988, 7657.57883316423, 7696.153423123564, 7754.612269386395, 8032.0, 7205.747798827016, 9533.23734101284, 9988.250881183794, 9994.550245238835, 10170.644027459004], "value": 8252.88976856996, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.3849352310885, 1363.3728484896947, 1425.9500917467888, 1524.1845612597263, 1766.743822145789, 6739.35976082272, 7384.926150738491, 7680.654370553325, 7683.57740324282, 7833.138354780969, 7320.63396830159, 7518.7368442104535, 7584.886226706604, 7719.884201736979, 7752.069751629798, 2162.0378931375544, 2223.5330580578097, 2224.1103558576538, 2224.710787597618, 2225.7440394354694, 2111.1766411099684, 2154.278316763886, 2187.3656639574506, 2194.034624765098, 2195.802377785999, 2055.660815965364, 2060.701198326242, 2070.4306315763133, 2077.4598604362823, 2101.9684704729366, 2134.5197330600568, 2162.91348346066, 2164.058634494, 2164.686120512517, 2166.7833216678364, 2119.109973810988, 2162.243214874797, 2162.978370216309, 2163.210428193698, 2166.382580964433, 7513.774586762406, 7629.542227466314, 7714.151443341228, 7727.227277272284, 7756.457048006641, 4236.0257140857775, 4304.612584867377, 4333.349997500369, 4333.566643335673, 4345.630621397185, 2859.356644754934, 2880.1215629233075, 2923.5760814681753, 2950.542665886791, 2976.2113040044405, 916.2486760856101, 923.9769005774842, 931.0317270039151, 959.7792507723262, 969.5443141723379, 10319.535620897077, 10464.52909619069, 10483.633072842415, 10606.15150787935, 10623.57505699771, 4171.228322760299, 4256.936145957813, 4340.0, 4356.499002614676, 4389.604935555815, 9089.954550227207, 9103.362764606414, 9120.45277283365, 9190.770230744285, 9204.539773011322, 4410.955890441054, 4415.227335216325, 4418.911621767546, 4422.601965823092, 4423.867283981485, 3509.368313703507, 3939.803009849496, 4006.819693113817, 4061.7969101544804, 4103.343465045638, 3734.458503516975, 3739.6634302912867, 3802.752821066622, 3826.808659567066, 3871.225754848985, 1175.3418085871767, 1207.7222238885106, 1213.8664746877837, 1223.7736018836545, 1229.26244253449, 735.2463724682243, 798.6485946183777, 811.3265989228926, 846.8518009348339, 855.6534603485599, 5057.418396884332, 5080.923786143211, 5105.106606343875, 5133.307003554547, 5174.223866420067, 391.9098607320332, 405.1532297498184, 407.2953789943355, 411.1940596430969, 413.9898647300637, 3207.5028370602595, 3252.495863141217, 3262.967370326314, 3278.0821370016433, 3375.8312084395684, 9379.718608441757, 9705.223582113415, 9792.951035244778, 9801.705948821547, 9835.557399917021, 9572.808543829084, 9684.661036863676, 9848.950755246178, 9849.162821160282, 9863.260255480867, 7236.529625574426, 7405.370543503755, 7464.066991626047, 7486.1016677997895, 7490.4382171337365, 5011.223260394645, 5064.087834800238, 5067.163917953644, 5071.898562028812, 5160.535551800356, 8835.160659737314, 8946.68686595966, 9060.229880460234, 9167.220786233245, 9178.632854685738, 9106.726798196065, 9174.403663761834, 9205.539723013688, 9243.537823108683, 9274.350795444254, 5830.4461076197695, 6383.425491705769, 6597.538172327891, 6627.801165965029, 6693.096431981815, 7606.087269527471, 7639.503432276884, 7642.732504362543, 7668.6165691716305, 7700.961495192712, 6667.0, 6815.079964204769, 6862.862742745017, 6905.861882762417, 6909.2399836019, 6611.041398997215, 6691.029800678777, 6748.055272261985, 6817.227520844517, 6920.169579650475, 6100.847478813065, 6138.0, 6158.0, 6228.781992630236, 6262.185915831095, 4219.0, 4322.546132656026, 4365.105153443473, 4374.540673229392, 4417.359482874901, 4364.301711726109, 4383.627391671616, 4470.0, 4520.095980803918, 4553.271476563734], "value": 4008.6674218817225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.55509123833406, 291.26455699359116, 294.86730971063, 295.9792814502986, 296.6040336151238, 4789.161896668083, 4791.425028996526, 4793.952060479394, 4805.2850139671145, 4824.407945378021, 4727.267273572602, 4745.932165262814, 4750.28745688147, 4755.144074066667, 4783.139034973703, 3535.752497325182, 3616.493690883265, 3637.6362363763546, 3712.535933008374, 3762.529683789526, 3663.19409729859, 3706.869404831525, 3711.814409279525, 3744.6817020553285, 3748.0, 3486.6339034401403, 3652.009654738174, 3664.6152154023844, 3675.503806986063, 3701.0932321581117, 3563.964360356389, 3706.66560038386, 3723.962760372389, 3724.478572999782, 3731.9626803731885, 3253.5933008373954, 3258.6415494295607, 3260.1523603863166, 3264.6408895021527, 3273.6071671399345, 4565.840195593171, 4566.26939689648, 4567.840125595588, 4572.862814115549, 4574.679772415932, 3965.7620542767236, 4163.3130533461945, 4200.4539409876825, 4240.787960601958, 4242.363645453176, 4989.975050124763, 5003.674761140514, 5004.84985450437, 5021.0, 5027.673201241908, 3506.877259295938, 3513.472979053137, 3516.050666320105, 3519.665631764978, 3530.699890509284, 5119.180931051014, 5232.241325007891, 5243.2659427680155, 5265.921011184835, 5288.576913846921, 3564.518789963374, 3594.7663401878795, 3610.765300255475, 3613.4760459733716, 3623.764455310449, 3636.818159092035, 3642.1076836175307, 3648.0, 3650.671439570451, 3652.9634703652623, 4205.6635469163, 4206.8737937861915, 4208.6633069354375, 4211.789410529523, 4216.47294088239, 4917.87705307363, 5017.1721665924715, 5040.873978150576, 5042.596592272609, 5055.494450554915, 1262.4319056424645, 1266.1453518874723, 1272.1998372303087, 1272.7518133963788, 1274.6048724895313, 791.9388020053157, 804.1676864445271, 822.1696086952102, 848.9490630562186, 852.6376290076817, 4358.869233922987, 4399.978000109979, 4409.316555933835, 4410.434295825, 4415.5363686812425, 5148.0, 5151.192600032916, 5151.918097199555, 5161.561267292323, 5164.561012313995, 4209.515905670826, 4366.345048242725, 4378.912421751547, 4385.662372976273, 4408.25059739845, 2722.1561315992108, 2748.6014527893744, 2757.1452849616685, 2767.1283545683045, 2775.9312664624267, 4803.759812009385, 4824.421069471616, 4826.855194344175, 4828.830990915301, 4843.0, 5067.239914012927, 5212.921806172911, 5216.895662086813, 5260.92108618371, 5261.76322065508, 4748.264019077118, 4773.594244489257, 4798.760061996956, 4801.18379875422, 4832.685875418087, 5120.0, 5125.923111153261, 5134.512221338967, 5136.357955255593, 5147.6654017488745, 4735.881602959954, 4980.477049909708, 4998.6500944933505, 5000.249962505508, 5006.774695138801, 4789.425268967746, 4790.99389128273, 4796.424429068534, 4811.436283207901, 4823.975880120577, 3551.7691350062164, 3560.572731272264, 3566.233259849145, 3582.2835432914044, 3590.982045089758, 4945.975270123627, 5040.924386134137, 5055.5955523557295, 5094.108531006985, 5240.71176085319, 5062.392512898476, 5072.492750724898, 5086.949130508796, 5088.931324421913, 5103.464136265788, 5050.3182070420025, 5056.0, 5058.974705126451, 5072.4420313766195, 5077.593792496666, 4758.262469317261, 4785.330053792542, 4980.007996801309, 4991.201407774739, 5008.874778130576, 4947.431045429677, 5002.374703162105, 5004.0, 5005.399352077774, 5012.147934851011, 4889.608831293559, 4958.8760280993265, 4973.875653108701, 4995.325631039763, 5007.048660754445], "value": 3748.837436359177, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.9732410703572, 693.5318659904564, 712.2450202785049, 792.5363662257579, 814.0475643497108, 11025.669229923094, 11559.133065020114, 11671.533138674453, 11673.241239319459, 11695.415229238526, 11391.088712902969, 11508.251963622379, 11626.186166968315, 11628.081366574505, 11679.182457227997, 628.1582679209857, 644.8291202831253, 646.1309538670481, 792.4611264340247, 802.3460879383313, 630.977915772948, 634.9047642853586, 780.5277806926813, 813.6541969662899, 817.4972391978949, 834.015861283685, 836.6611522333465, 838.656150978099, 839.5718183726314, 840.1892174052039, 829.7593697827623, 833.2625626320689, 833.5915401453244, 834.1116710703081, 834.2950207075042, 484.6849547793927, 492.39189600843287, 496.6796416311495, 496.98260560880556, 595.6842873277127, 11551.942240288829, 11970.58102966392, 12039.518419263219, 12055.397230138458, 12071.93964030183, 11181.776364472666, 11253.493592788343, 11505.309681419141, 11572.132090093277, 12392.380380981005, 11070.833937490863, 11158.832617510743, 11168.720781980433, 11179.944100279528, 11348.546058157664, 4204.11713540157, 4220.936685949713, 4226.112516371566, 4289.120730250291, 4311.374850646639, 44183.33724994128, 45201.54798452039, 45261.77369113166, 45304.0, 45435.77282113568, 9557.139857412867, 9637.0, 9669.323147379757, 9865.753356166153, 9900.356476828983, 17789.555261118316, 17803.46589602314, 17803.821961780475, 17819.821801781814, 17861.642767144585, 6596.142501474777, 6617.073609694647, 6623.966880165664, 6706.832329191711, 6769.8646027079185, 3638.7089032877307, 3686.5023221864703, 3757.9060523487133, 3879.049632839916, 3928.253631809947, 2794.1896849913296, 2878.3667593129476, 2893.5225687761285, 2895.2182910614015, 2895.7828162887868, 497.4180209155297, 512.9333186685782, 513.4249640402699, 517.492857000142, 518.2666526864444, 463.8283834981079, 504.4854248666413, 505.72690746996943, 515.6725479320584, 525.6977238088039, 7092.219855815856, 7109.431245500347, 7197.89203161953, 7221.638918054181, 7446.515976461513, 403.68714246458643, 432.9567043295708, 480.27478507454, 482.9396325459318, 502.6958689992502, 3090.474619314722, 3155.432022235974, 3180.3162320101287, 3213.453712868818, 3277.573915390984, 53138.734306328224, 53598.0, 54496.72751636217, 55048.17427738587, 55458.445415546135, 48415.0, 49167.50832491629, 49474.25788613174, 49622.0, 49643.50356496389, 45573.08853822905, 45636.543634563226, 45690.08619827651, 46091.30863037057, 46708.5329146711, 7969.561674107979, 8079.636416361395, 8172.101068882299, 8174.877376839471, 8318.043425006203, 29883.0, 29954.700452995192, 31066.23433073655, 31632.683673163894, 32306.19234519062, 37883.431748523246, 38149.0, 38821.6117838818, 39474.0, 43524.0, 10760.246782725448, 10780.784384312114, 10828.783424331627, 10903.982763188835, 11335.149863760085, 11678.569824372373, 11837.526498940291, 12036.578719744766, 12263.69340766488, 12318.199317044364, 10979.945100274448, 11078.667639970492, 11400.94299528497, 11413.201075924606, 11937.0, 9330.0, 9603.471809050568, 9854.704358869245, 11139.88860111421, 11398.715032124263, 10762.623308184176, 10864.674059778219, 11179.944100279447, 11308.604198853001, 11326.263792853439, 8477.558815001588, 8805.383623146317, 8959.641614335615, 8960.283177345927, 9246.676366327147, 8950.14973577509, 9121.589528471368, 9153.542322883963, 9175.816483670424, 9343.252539796664], "value": 5805.543429910488, "unit": "score"}], "name": "dromaeo_css", "value": 6236.850582899369, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 116.0, 115.0, 114.0, 114.0, 113.0, 113.0, 115.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 131.0, 180.0, 132.0, 135.0, 158.0, 139.0, 172.0, 129.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 160.0, 163.0, 163.0, 164.0, 163.0, 163.0, 166.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 109.0, 77.0, 76.0, 74.0, 78.0, 115.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 84.0, 85.0, 85.0, 118.0, 84.0, 84.0, 117.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 78.0, 63.0, 62.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 68.0, 65.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 87.0, 84.0, 84.0, 84.0, 85.0, 85.0, 86.0, 92.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 132.0, 132.0, 130.0, 127.0, 129.0, 132.0, 186.0, 133.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 173.0, 175.0, 174.0, 173.0, 175.0, 178.0, 174.0, 171.0, 173.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 70.0, 67.0, 66.0, 67.0, 67.0, 65.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1557.6, "alertThreshold": 2.0}]} 04:47:07 INFO - Return code: 0 04:47:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:47:07 ERROR - # TBPL SUCCESS # 04:47:07 INFO - Running post-action listener: _resource_record_post_action 04:47:07 INFO - ##### 04:47:07 INFO - ##### Finished run-tests step (success) 04:47:07 INFO - ##### 04:47:07 INFO - Running post-run listener: _resource_record_post_run 04:47:07 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 464392192; Read time: 952; Write time: 483780 04:47:07 INFO - TinderboxPrint: CPU usage
13.1% 04:47:07 INFO - TinderboxPrint: I/O read bytes / time
7,802,880 / 952 04:47:07 INFO - TinderboxPrint: I/O write bytes / time
464,392,192 / 483,780 04:47:07 INFO - TinderboxPrint: CPU idle
8,354.8 (86.9%) 04:47:07 INFO - TinderboxPrint: CPU user
1,209.1 (12.6%) 04:47:07 INFO - TinderboxPrint: Swap in / out
0 / 0 04:47:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107802624; Read time: 0; Write time: 117236 04:47:07 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 6041600; Write bytes: 356589568; Read time: 908; Write time: 366544 04:47:08 INFO - Running post-run listener: _upload_blobber_files 04:47:08 INFO - Blob upload gear active. 04:47:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:08 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 04:47:08 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'] 04:47:08 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 04:47:08 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:47:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:15 INFO - (blobuploader) - INFO - Done attempting. 04:47:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:47:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:16 INFO - (blobuploader) - INFO - Done attempting. 04:47:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:47:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:47:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:17 INFO - (blobuploader) - INFO - Done attempting. 04:47:17 INFO - (blobuploader) - INFO - Iteration through files over. 04:47:17 INFO - Return code: 0 04:47:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:47:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:47:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85ac3abdc8e297a6f5d3c74c53602e620031b6e61aa411076fb25e2d126fcc01fbd3302700cc011c9b1a3db8bc366a3f6f59dd89e7cf4a339b348976d2b7cdb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de7444c77d613657cf656b3ab3ad2af4d6308c2ae8c9b043370d5d13bf03550a9043dce2074dae73a3ba48f4b1406fea75fe4d1d3bb59ccf9f1455937d2e5716", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96a10af2e3d96264e947349e15aa358819c41f66c893eea94cd989ff50a401e2382f3017a441be8101b0ad42fc0c4c4224c486a12a0012e176d6bf2e333db004"} 04:47:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:47:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:47:17 INFO - Contents: 04:47:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85ac3abdc8e297a6f5d3c74c53602e620031b6e61aa411076fb25e2d126fcc01fbd3302700cc011c9b1a3db8bc366a3f6f59dd89e7cf4a339b348976d2b7cdb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de7444c77d613657cf656b3ab3ad2af4d6308c2ae8c9b043370d5d13bf03550a9043dce2074dae73a3ba48f4b1406fea75fe4d1d3bb59ccf9f1455937d2e5716", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96a10af2e3d96264e947349e15aa358819c41f66c893eea94cd989ff50a401e2382f3017a441be8101b0ad42fc0c4c4224c486a12a0012e176d6bf2e333db004"} 04:47:17 INFO - Running post-run listener: copy_logs_to_upload_dir 04:47:17 INFO - Copying logs to upload dir... 04:47:17 INFO - mkdir: /builds/slave/test/build/upload/logs 04:47:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.798431 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-26 04:47:17.483596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 04:47:17.487254) ========= 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-1464261690.771718-1043806283 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/85ac3abdc8e297a6f5d3c74c53602e620031b6e61aa411076fb25e2d126fcc01fbd3302700cc011c9b1a3db8bc366a3f6f59dd89e7cf4a339b348976d2b7cdb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de7444c77d613657cf656b3ab3ad2af4d6308c2ae8c9b043370d5d13bf03550a9043dce2074dae73a3ba48f4b1406fea75fe4d1d3bb59ccf9f1455937d2e5716", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96a10af2e3d96264e947349e15aa358819c41f66c893eea94cd989ff50a401e2382f3017a441be8101b0ad42fc0c4c4224c486a12a0012e176d6bf2e333db004"} build_url:https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/A7ddYIKETJqJ3cS2KTj7Zw/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/85ac3abdc8e297a6f5d3c74c53602e620031b6e61aa411076fb25e2d126fcc01fbd3302700cc011c9b1a3db8bc366a3f6f59dd89e7cf4a339b348976d2b7cdb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de7444c77d613657cf656b3ab3ad2af4d6308c2ae8c9b043370d5d13bf03550a9043dce2074dae73a3ba48f4b1406fea75fe4d1d3bb59ccf9f1455937d2e5716", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96a10af2e3d96264e947349e15aa358819c41f66c893eea94cd989ff50a401e2382f3017a441be8101b0ad42fc0c4c4224c486a12a0012e176d6bf2e333db004"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 04:47:17.517001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 04:47:17.517323) ========= 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-1464261690.771718-1043806283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 04:47:17.648477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 04:47:17.649028) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 04:47:17.649568) ========= ========= Total master_lag: 0.30 =========