builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1466787500.23 results: success (0) buildid: 20160624092958 builduid: 0c0f9c89822a48ccbd368ae0973de426 revision: 0b20196061d7a3162d7ee6aa0dc470e0e2b24236 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:20.230615) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:20.231124) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:20.231488) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:20.265729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:20.265999) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 09:58:20-- 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% 28.1M=0s 2016-06-24 09:58:20 (28.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101766 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:20.383199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:20.383490) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021608 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:20.433572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:20.433875) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0b20196061d7a3162d7ee6aa0dc470e0e2b24236 --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 0b20196061d7a3162d7ee6aa0dc470e0e2b24236 --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=31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 09:58:20,568 truncating revision to first 12 chars 2016-06-24 09:58:20,568 Setting DEBUG logging. 2016-06-24 09:58:20,568 attempt 1/10 2016-06-24 09:58:20,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0b20196061d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 09:58:21,006 unpacking tar archive at: fx-team-0b20196061d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.802962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:21.251222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:21.251702) ========= script_repo_revision: 0b20196061d7a3162d7ee6aa0dc470e0e2b24236 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:21.252313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:21.252716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 09:58:21.263039) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-24 09:58:21.263523) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:58:21 INFO - MultiFileLogger online at 20160624 09:58:21 in /builds/slave/test 09:58:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 09:58:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:21 INFO - {'append_to_log': False, 09:58:21 INFO - 'base_work_dir': '/builds/slave/test', 09:58:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:58:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:21 INFO - 'branch': 'Fx-Team-Non-PGO', 09:58:21 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:21 INFO - 'config_files': ('talos/linux_config.py',), 09:58:21 INFO - 'default_actions': ('clobber', 09:58:21 INFO - 'read-buildbot-config', 09:58:21 INFO - 'download-and-extract', 09:58:21 INFO - 'populate-webroot', 09:58:21 INFO - 'create-virtualenv', 09:58:21 INFO - 'install', 09:58:21 INFO - 'run-tests'), 09:58:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:21 INFO - 'download_minidump_stackwalk': True, 09:58:21 INFO - 'download_symbols': 'ondemand', 09:58:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:21 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:21 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:21 INFO - 'installer_path': 'installer.exe', 09:58:21 INFO - 'log_level': 'info', 09:58:21 INFO - 'log_name': 'talos', 09:58:21 INFO - 'log_to_console': True, 09:58:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:58:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:58:21 INFO - 'opt_config_files': (), 09:58:21 INFO - 'pip_index': False, 09:58:21 INFO - 'sps_profile': False, 09:58:21 INFO - 'sps_profile_interval': 0, 09:58:21 INFO - 'suite': 'dromaeojs-e10s', 09:58:21 INFO - 'system_bits': '32', 09:58:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:21 INFO - 'title': 'talos-linux64-ix-014', 09:58:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:21 INFO - 'use_talos_json': True, 09:58:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:21 INFO - 'work_dir': 'build'} 09:58:21 INFO - ##### 09:58:21 INFO - ##### Running clobber step. 09:58:21 INFO - ##### 09:58:21 INFO - Running pre-action listener: _resource_record_pre_action 09:58:21 INFO - Running main action method: clobber 09:58:21 INFO - rmtree: /builds/slave/test/build 09:58:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:21 INFO - Running post-action listener: _resource_record_post_action 09:58:21 INFO - ##### 09:58:21 INFO - ##### Finished clobber step (success) 09:58:21 INFO - ##### 09:58:21 INFO - ##### 09:58:21 INFO - ##### Running read-buildbot-config step. 09:58:21 INFO - ##### 09:58:21 INFO - Running pre-action listener: _resource_record_pre_action 09:58:21 INFO - Running main action method: read_buildbot_config 09:58:21 INFO - Using buildbot properties: 09:58:21 INFO - { 09:58:21 INFO - "project": "", 09:58:21 INFO - "product": "firefox", 09:58:21 INFO - "script_repo_revision": "production", 09:58:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:58:21 INFO - "repository": "", 09:58:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:58:21 INFO - "buildid": "20160624092958", 09:58:21 INFO - "pgo_build": "False", 09:58:21 INFO - "basedir": "/builds/slave/test", 09:58:21 INFO - "buildnumber": 1430, 09:58:21 INFO - "slavename": "talos-linux64-ix-014", 09:58:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:58:21 INFO - "platform": "ubuntu64_hw", 09:58:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:58:21 INFO - "branch": "fx-team", 09:58:21 INFO - "repo_path": "integration/fx-team", 09:58:21 INFO - "revision": "0b20196061d7a3162d7ee6aa0dc470e0e2b24236", 09:58:21 INFO - "stage_platform": "linux64", 09:58:21 INFO - "builduid": "0c0f9c89822a48ccbd368ae0973de426", 09:58:21 INFO - "slavebuilddir": "test" 09:58:21 INFO - } 09:58:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:58:21 INFO - Running post-action listener: _resource_record_post_action 09:58:21 INFO - ##### 09:58:21 INFO - ##### Finished read-buildbot-config step (success) 09:58:21 INFO - ##### 09:58:21 INFO - ##### 09:58:21 INFO - ##### Running download-and-extract step. 09:58:21 INFO - ##### 09:58:21 INFO - Running pre-action listener: _resource_record_pre_action 09:58:21 INFO - Running main action method: download_and_extract 09:58:21 INFO - mkdir: /builds/slave/test/build/tests 09:58: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')]} 09:58:21 INFO - https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:58:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:58:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:58:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:58:23 INFO - Downloaded 1361 bytes. 09:58:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:58:23 INFO - Using the following test package requirements: 09:58:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:58:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:58:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:23 INFO - u'jsshell-linux-x86_64.zip'], 09:58:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:58:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:58:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:58:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:58:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:58:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:58:23 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')]} 09:58:23 INFO - https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:24 INFO - Downloaded 22710890 bytes. 09:58:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:58:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:58:25 INFO - Return code: 0 09:58:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:58:25 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')]} 09:58:25 INFO - https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:58:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:27 INFO - Downloaded 22710890 bytes. 09:58:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:58:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:58:29 INFO - Return code: 0 09:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:29 INFO - https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:58:30 INFO - Downloaded 14405518 bytes. 09:58:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:58:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:58:30 INFO - Return code: 0 09:58: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')]} 09:58:30 INFO - https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:58:33 INFO - Downloaded 56266647 bytes. 09:58:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:33 INFO - mkdir: /builds/slave/test/properties 09:58:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:33 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:33 INFO - Contents: 09:58:33 INFO - build_url:https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:33 INFO - Running post-action listener: _resource_record_post_action 09:58:33 INFO - Running post-action listener: set_extra_try_arguments 09:58:33 INFO - ##### 09:58:33 INFO - ##### Finished download-and-extract step (success) 09:58:33 INFO - ##### 09:58:33 INFO - ##### 09:58:33 INFO - ##### Running populate-webroot step. 09:58:33 INFO - ##### 09:58:33 INFO - Running pre-action listener: _resource_record_pre_action 09:58:33 INFO - Running main action method: populate_webroot 09:58:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:33 INFO - '--tppagecycles', 09:58:33 INFO - '7'], 09:58:33 INFO - 'tests': ['tsvgm']}}, 09:58:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:33 INFO - 'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:33 INFO - 'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['damp', 'tps']}, 09:58:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:33 INFO - 'tests': ['damp', 'tps']}, 09:58:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['dromaeo_dom']}, 09:58:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['basic_compositor_video']}, 09:58:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:58:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['a11yr', 09:58:33 INFO - 'ts_paint', 09:58:33 INFO - 'tpaint', 09:58:33 INFO - 'sessionrestore', 09:58:33 INFO - 'sessionrestore_no_auto_restore', 09:58:33 INFO - 'tabpaint']}, 09:58:33 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:33 INFO - 'ts_paint', 09:58:33 INFO - 'tpaint', 09:58:33 INFO - 'sessionrestore', 09:58:33 INFO - 'sessionrestore_no_auto_restore', 09:58:33 INFO - 'tabpaint']}, 09:58:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:33 INFO - 'ts_paint', 09:58:33 INFO - 'tpaint', 09:58:33 INFO - 'sessionrestore', 09:58:33 INFO - 'sessionrestore_no_auto_restore', 09:58:33 INFO - 'tabpaint']}, 09:58:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:33 INFO - 'ts_paint', 09:58:33 INFO - 'tpaint', 09:58:33 INFO - 'sessionrestore', 09:58:33 INFO - 'sessionrestore_no_auto_restore', 09:58:33 INFO - 'tabpaint']}, 09:58:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['a11yr', 09:58:33 INFO - 'ts_paint', 09:58:33 INFO - 'tpaint', 09:58:33 INFO - 'sessionrestore', 09:58:33 INFO - 'sessionrestore_no_auto_restore', 09:58:33 INFO - 'tabpaint']}, 09:58:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['a11yr', 09:58:33 INFO - 'ts_paint', 09:58:33 INFO - 'tpaint', 09:58:33 INFO - 'sessionrestore', 09:58:33 INFO - 'sessionrestore_no_auto_restore', 09:58:33 INFO - 'tabpaint']}, 09:58:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['tsvgx', 09:58:33 INFO - 'tsvgr_opacity', 09:58:33 INFO - 'tart', 09:58:33 INFO - 'tscrollx', 09:58:33 INFO - 'cart']}, 09:58:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:33 INFO - 'tsvgr_opacity', 09:58:33 INFO - 'tart', 09:58:33 INFO - 'tscrollx', 09:58:33 INFO - 'cart']}, 09:58:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:33 INFO - 'talos_options': ['--disable-e10s'], 09:58:33 INFO - 'tests': ['tp5o']}, 09:58:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:33 INFO - 'tests': ['tp5o']}, 09:58:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:33 INFO - 'talos_options': ['--disable-e10s', 09:58:33 INFO - '--xperf_path', 09:58:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:33 INFO - 'tests': ['tp5n']}, 09:58:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:33 INFO - 'talos_options': ['--xperf_path', 09:58:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:33 INFO - 'tests': ['tp5n']}}, 09:58:33 INFO - 'talos.zip': {'path': '', 09:58:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:33 INFO - Running post-action listener: _resource_record_post_action 09:58:33 INFO - ##### 09:58:33 INFO - ##### Finished populate-webroot step (success) 09:58:33 INFO - ##### 09:58:33 INFO - ##### 09:58:33 INFO - ##### Running create-virtualenv step. 09:58:33 INFO - ##### 09:58:33 INFO - Running pre-action listener: _resource_record_pre_action 09:58:33 INFO - Running main action method: create_virtualenv 09:58:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58: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 09:58:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:33 INFO - Using real prefix '/usr' 09:58:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:34 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:36 INFO - Installing pip.................done. 09:58:36 INFO - Return code: 0 09:58:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58:36 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')]} 09:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:36 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')]} 09:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:36 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 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:36 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 09:58:36 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 09:58:36 INFO - Using env: {'DISPLAY': ':0', 09:58:36 INFO - 'HOME': '/home/cltbld', 09:58:36 INFO - 'LANG': 'en_US.UTF-8', 09:58:36 INFO - 'LANGUAGE': 'en_US:en', 09:58:36 INFO - 'LOGNAME': 'cltbld', 09:58:36 INFO - 'MAIL': '/var/mail/cltbld', 09:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:36 INFO - 'MOZ_NO_REMOTE': '1', 09:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:36 INFO - 'NO_EM_RESTART': '1', 09:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:36 INFO - 'PWD': '/builds/slave/test', 09:58:36 INFO - 'SHELL': '/bin/bash', 09:58:36 INFO - 'SHLVL': '1', 09:58:36 INFO - 'TERM': 'linux', 09:58:36 INFO - 'TMOUT': '86400', 09:58:36 INFO - 'USER': 'cltbld', 09:58:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:36 INFO - '_': '/tools/buildbot/bin/python'} 09:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:36 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 09:58:36 INFO - Cleaning up... 09:58:36 INFO - Return code: 0 09:58:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:58:36 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')]} 09:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:36 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')]} 09:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:36 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 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:36 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 09:58:36 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 09:58:36 INFO - Using env: {'DISPLAY': ':0', 09:58:36 INFO - 'HOME': '/home/cltbld', 09:58:36 INFO - 'LANG': 'en_US.UTF-8', 09:58:36 INFO - 'LANGUAGE': 'en_US:en', 09:58:36 INFO - 'LOGNAME': 'cltbld', 09:58:36 INFO - 'MAIL': '/var/mail/cltbld', 09:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:36 INFO - 'MOZ_NO_REMOTE': '1', 09:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:36 INFO - 'NO_EM_RESTART': '1', 09:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:36 INFO - 'PWD': '/builds/slave/test', 09:58:36 INFO - 'SHELL': '/bin/bash', 09:58:36 INFO - 'SHLVL': '1', 09:58:36 INFO - 'TERM': 'linux', 09:58:36 INFO - 'TMOUT': '86400', 09:58:36 INFO - 'USER': 'cltbld', 09:58:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:36 INFO - '_': '/tools/buildbot/bin/python'} 09:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:36 INFO - Downloading/unpacking psutil>=3.1.1 09:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:38 INFO - Installing collected packages: psutil 09:58:38 INFO - Running setup.py install for psutil 09:58:38 INFO - building 'psutil._psutil_linux' extension 09:58:38 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 09:58:39 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 09:58:39 INFO - building 'psutil._psutil_posix' extension 09:58:39 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 09:58:39 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 09:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:39 INFO - Successfully installed psutil 09:58:39 INFO - Cleaning up... 09:58:39 INFO - Return code: 0 09:58:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:58:39 INFO - Using env: {'DISPLAY': ':0', 09:58:39 INFO - 'HOME': '/home/cltbld', 09:58:39 INFO - 'LANG': 'en_US.UTF-8', 09:58:39 INFO - 'LANGUAGE': 'en_US:en', 09:58:39 INFO - 'LOGNAME': 'cltbld', 09:58:39 INFO - 'MAIL': '/var/mail/cltbld', 09:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:39 INFO - 'MOZ_NO_REMOTE': '1', 09:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:39 INFO - 'NO_EM_RESTART': '1', 09:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:39 INFO - 'PWD': '/builds/slave/test', 09:58:39 INFO - 'SHELL': '/bin/bash', 09:58:39 INFO - 'SHLVL': '1', 09:58:39 INFO - 'TERM': 'linux', 09:58:39 INFO - 'TMOUT': '86400', 09:58:39 INFO - 'USER': 'cltbld', 09:58:39 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:39 INFO - '_': '/tools/buildbot/bin/python'} 09:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:41 INFO - Installing collected packages: mozsystemmonitor 09:58:41 INFO - Running setup.py install for mozsystemmonitor 09:58:41 INFO - Successfully installed mozsystemmonitor 09:58:41 INFO - Cleaning up... 09:58:41 INFO - Return code: 0 09:58:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:58:41 INFO - Using env: {'DISPLAY': ':0', 09:58:41 INFO - 'HOME': '/home/cltbld', 09:58:41 INFO - 'LANG': 'en_US.UTF-8', 09:58:41 INFO - 'LANGUAGE': 'en_US:en', 09:58:41 INFO - 'LOGNAME': 'cltbld', 09:58:41 INFO - 'MAIL': '/var/mail/cltbld', 09:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:41 INFO - 'MOZ_NO_REMOTE': '1', 09:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:41 INFO - 'NO_EM_RESTART': '1', 09:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:41 INFO - 'PWD': '/builds/slave/test', 09:58:41 INFO - 'SHELL': '/bin/bash', 09:58:41 INFO - 'SHLVL': '1', 09:58:41 INFO - 'TERM': 'linux', 09:58:41 INFO - 'TMOUT': '86400', 09:58:41 INFO - 'USER': 'cltbld', 09:58:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:41 INFO - '_': '/tools/buildbot/bin/python'} 09:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:41 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:41 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 09:58:41 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 09:58:41 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 09:58:41 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 09:58:41 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 09:58:41 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 09:58:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:43 INFO - warning: no files found matching '*.txt' 09:58:43 INFO - no previously-included directories found matching 'build' 09:58:43 INFO - no previously-included directories found matching 'dist' 09:58:43 INFO - no previously-included directories found matching '.git*' 09:58:43 INFO - Installing collected packages: jsonschema, functools32 09:58:44 INFO - Running setup.py install for functools32 09:58:44 INFO - warning: no files found matching '*.txt' 09:58:44 INFO - no previously-included directories found matching 'build' 09:58:44 INFO - no previously-included directories found matching 'dist' 09:58:44 INFO - no previously-included directories found matching '.git*' 09:58:44 INFO - Successfully installed jsonschema functools32 09:58:44 INFO - Cleaning up... 09:58:44 INFO - Return code: 0 09:58:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:58:44 INFO - Using env: {'DISPLAY': ':0', 09:58:44 INFO - 'HOME': '/home/cltbld', 09:58:44 INFO - 'LANG': 'en_US.UTF-8', 09:58:44 INFO - 'LANGUAGE': 'en_US:en', 09:58:44 INFO - 'LOGNAME': 'cltbld', 09:58:44 INFO - 'MAIL': '/var/mail/cltbld', 09:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:44 INFO - 'MOZ_NO_REMOTE': '1', 09:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:44 INFO - 'NO_EM_RESTART': '1', 09:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:44 INFO - 'PWD': '/builds/slave/test', 09:58:44 INFO - 'SHELL': '/bin/bash', 09:58:44 INFO - 'SHLVL': '1', 09:58:44 INFO - 'TERM': 'linux', 09:58:44 INFO - 'TMOUT': '86400', 09:58:44 INFO - 'USER': 'cltbld', 09:58:44 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:44 INFO - '_': '/tools/buildbot/bin/python'} 09:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:47 INFO - Downloading docopt-0.6.1.tar.gz 09:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:47 INFO - Running setup.py install for blobuploader 09:58:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:47 INFO - Running setup.py install for requests 09:58:47 INFO - Running setup.py install for docopt 09:58:47 INFO - Successfully installed blobuploader requests docopt 09:58:47 INFO - Cleaning up... 09:58:47 INFO - Return code: 0 09:58:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:47 INFO - Using env: {'DISPLAY': ':0', 09:58:47 INFO - 'HOME': '/home/cltbld', 09:58:47 INFO - 'LANG': 'en_US.UTF-8', 09:58:47 INFO - 'LANGUAGE': 'en_US:en', 09:58:47 INFO - 'LOGNAME': 'cltbld', 09:58:47 INFO - 'MAIL': '/var/mail/cltbld', 09:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:47 INFO - 'MOZ_NO_REMOTE': '1', 09:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:47 INFO - 'NO_EM_RESTART': '1', 09:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:47 INFO - 'PWD': '/builds/slave/test', 09:58:47 INFO - 'SHELL': '/bin/bash', 09:58:47 INFO - 'SHLVL': '1', 09:58:47 INFO - 'TERM': 'linux', 09:58:47 INFO - 'TMOUT': '86400', 09:58:47 INFO - 'USER': 'cltbld', 09:58:47 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:47 INFO - '_': '/tools/buildbot/bin/python'} 09:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:48 INFO - Running setup.py (path:/tmp/pip-wYCXvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:48 INFO - Running setup.py (path:/tmp/pip-x6jo2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:48 INFO - Running setup.py (path:/tmp/pip-HljpqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:48 INFO - Running setup.py (path:/tmp/pip-nd9Hi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:48 INFO - Running setup.py (path:/tmp/pip-ivMM7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:48 INFO - Running setup.py (path:/tmp/pip-avfFr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:48 INFO - Running setup.py (path:/tmp/pip-S3Kc5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:48 INFO - Running setup.py (path:/tmp/pip-qQPv5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:48 INFO - Running setup.py (path:/tmp/pip-7xFKib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:48 INFO - Running setup.py (path:/tmp/pip-zbbtuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:48 INFO - Running setup.py (path:/tmp/pip-AKaO41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:48 INFO - Running setup.py (path:/tmp/pip-v0Fk9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:48 INFO - Running setup.py (path:/tmp/pip-IZvQiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:49 INFO - Running setup.py (path:/tmp/pip-1PfGRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:49 INFO - Running setup.py (path:/tmp/pip-KqbKYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:49 INFO - Running setup.py (path:/tmp/pip-TE_J4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:49 INFO - Running setup.py (path:/tmp/pip-cAKLPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:49 INFO - Running setup.py install for manifestparser 09:58:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:49 INFO - Running setup.py install for mozcrash 09:58:49 INFO - Running setup.py install for mozdebug 09:58:49 INFO - Running setup.py install for mozdevice 09:58:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:49 INFO - Running setup.py install for mozfile 09:58:49 INFO - Running setup.py install for mozhttpd 09:58:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:49 INFO - Running setup.py install for mozinfo 09:58:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:49 INFO - Running setup.py install for mozInstall 09:58:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozleak 09:58:50 INFO - Running setup.py install for mozlog 09:58:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for moznetwork 09:58:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozprocess 09:58:50 INFO - Running setup.py install for mozprofile 09:58:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozrunner 09:58:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozscreenshot 09:58:50 INFO - Running setup.py install for moztest 09:58:50 INFO - Running setup.py install for mozversion 09:58:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:51 INFO - Cleaning up... 09:58:51 INFO - Return code: 0 09:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:51 INFO - Using env: {'DISPLAY': ':0', 09:58:51 INFO - 'HOME': '/home/cltbld', 09:58:51 INFO - 'LANG': 'en_US.UTF-8', 09:58:51 INFO - 'LANGUAGE': 'en_US:en', 09:58:51 INFO - 'LOGNAME': 'cltbld', 09:58:51 INFO - 'MAIL': '/var/mail/cltbld', 09:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:51 INFO - 'MOZ_NO_REMOTE': '1', 09:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:51 INFO - 'NO_EM_RESTART': '1', 09:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:51 INFO - 'PWD': '/builds/slave/test', 09:58:51 INFO - 'SHELL': '/bin/bash', 09:58:51 INFO - 'SHLVL': '1', 09:58:51 INFO - 'TERM': 'linux', 09:58:51 INFO - 'TMOUT': '86400', 09:58:51 INFO - 'USER': 'cltbld', 09:58:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:51 INFO - '_': '/tools/buildbot/bin/python'} 09:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:51 INFO - Running setup.py (path:/tmp/pip-CJmN50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:51 INFO - Running setup.py (path:/tmp/pip-E5Br2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:51 INFO - Running setup.py (path:/tmp/pip-yW6ueh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:51 INFO - Running setup.py (path:/tmp/pip-SK9E86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:51 INFO - Running setup.py (path:/tmp/pip-JFHKLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:51 INFO - Running setup.py (path:/tmp/pip-ORpXMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:51 INFO - Running setup.py (path:/tmp/pip-l6RRfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:51 INFO - Running setup.py (path:/tmp/pip-vxUfwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:51 INFO - Running setup.py (path:/tmp/pip-vuwo9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:51 INFO - Running setup.py (path:/tmp/pip-zjQXuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:52 INFO - Running setup.py (path:/tmp/pip-opcvN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:52 INFO - Running setup.py (path:/tmp/pip-XA_lLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:52 INFO - Running setup.py (path:/tmp/pip-ziylp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:52 INFO - Running setup.py (path:/tmp/pip-oLOAzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:52 INFO - Running setup.py (path:/tmp/pip-nYslkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:52 INFO - Running setup.py (path:/tmp/pip-4ZXGus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:52 INFO - Running setup.py (path:/tmp/pip-GclyaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:54 INFO - Downloading blessings-1.6.tar.gz 09:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:54 INFO - Installing collected packages: blessings 09:58:54 INFO - Running setup.py install for blessings 09:58:54 INFO - Successfully installed blessings 09:58:54 INFO - Cleaning up... 09:58:54 INFO - Return code: 0 09:58:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:54 INFO - Reading from file tmpfile_stdout 09:58:54 INFO - Current package versions: 09:58:54 INFO - argparse == 1.2.1 09:58:54 INFO - blessings == 1.6 09:58:54 INFO - blobuploader == 1.2.4 09:58:54 INFO - docopt == 0.6.1 09:58:54 INFO - functools32 == 3.2.3-2 09:58:54 INFO - jsonschema == 2.5.1 09:58:54 INFO - manifestparser == 1.1 09:58:54 INFO - mozInstall == 1.12 09:58:54 INFO - mozcrash == 0.17 09:58:54 INFO - mozdebug == 0.1 09:58:54 INFO - mozdevice == 0.48 09:58:54 INFO - mozfile == 1.2 09:58:54 INFO - mozhttpd == 0.7 09:58:54 INFO - mozinfo == 0.9 09:58:54 INFO - mozleak == 0.1 09:58:54 INFO - mozlog == 3.2 09:58:54 INFO - moznetwork == 0.27 09:58:54 INFO - mozprocess == 0.22 09:58:54 INFO - mozprofile == 0.28 09:58:54 INFO - mozrunner == 6.11 09:58:54 INFO - mozscreenshot == 0.1 09:58:54 INFO - mozsystemmonitor == 0.3 09:58:54 INFO - moztest == 0.7 09:58:54 INFO - mozversion == 1.4 09:58:54 INFO - psutil == 3.1.1 09:58:54 INFO - requests == 1.2.3 09:58:54 INFO - wsgiref == 0.1.2 09:58:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:54 INFO - Using env: {'DISPLAY': ':0', 09:58:54 INFO - 'HOME': '/home/cltbld', 09:58:54 INFO - 'LANG': 'en_US.UTF-8', 09:58:54 INFO - 'LANGUAGE': 'en_US:en', 09:58:54 INFO - 'LOGNAME': 'cltbld', 09:58:54 INFO - 'MAIL': '/var/mail/cltbld', 09:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:54 INFO - 'MOZ_NO_REMOTE': '1', 09:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:54 INFO - 'NO_EM_RESTART': '1', 09:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:54 INFO - 'PWD': '/builds/slave/test', 09:58:54 INFO - 'SHELL': '/bin/bash', 09:58:54 INFO - 'SHLVL': '1', 09:58:54 INFO - 'TERM': 'linux', 09:58:54 INFO - 'TMOUT': '86400', 09:58:54 INFO - 'USER': 'cltbld', 09:58:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:54 INFO - '_': '/tools/buildbot/bin/python'} 09:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:58:55 INFO - Cleaning up... 09:58:55 INFO - Return code: 0 09:58:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:58:55 INFO - Using env: {'DISPLAY': ':0', 09:58:55 INFO - 'HOME': '/home/cltbld', 09:58:55 INFO - 'LANG': 'en_US.UTF-8', 09:58:55 INFO - 'LANGUAGE': 'en_US:en', 09:58:55 INFO - 'LOGNAME': 'cltbld', 09:58:55 INFO - 'MAIL': '/var/mail/cltbld', 09:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:55 INFO - 'MOZ_NO_REMOTE': '1', 09:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:55 INFO - 'NO_EM_RESTART': '1', 09:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:55 INFO - 'PWD': '/builds/slave/test', 09:58:55 INFO - 'SHELL': '/bin/bash', 09:58:55 INFO - 'SHLVL': '1', 09:58:55 INFO - 'TERM': 'linux', 09:58:55 INFO - 'TMOUT': '86400', 09:58:55 INFO - 'USER': 'cltbld', 09:58:55 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:55 INFO - '_': '/tools/buildbot/bin/python'} 09:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:55 INFO - Cleaning up... 09:58:55 INFO - Return code: 0 09:58:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9b1d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', '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 09:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:58:55 INFO - Using env: {'DISPLAY': ':0', 09:58:55 INFO - 'HOME': '/home/cltbld', 09:58:55 INFO - 'LANG': 'en_US.UTF-8', 09:58:55 INFO - 'LANGUAGE': 'en_US:en', 09:58:55 INFO - 'LOGNAME': 'cltbld', 09:58:55 INFO - 'MAIL': '/var/mail/cltbld', 09:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:55 INFO - 'MOZ_NO_REMOTE': '1', 09:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:55 INFO - 'NO_EM_RESTART': '1', 09:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:55 INFO - 'PWD': '/builds/slave/test', 09:58:55 INFO - 'SHELL': '/bin/bash', 09:58:55 INFO - 'SHLVL': '1', 09:58:55 INFO - 'TERM': 'linux', 09:58:55 INFO - 'TMOUT': '86400', 09:58:55 INFO - 'USER': 'cltbld', 09:58:55 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:55 INFO - '_': '/tools/buildbot/bin/python'} 09:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:55 INFO - Downloading/unpacking flake8 09:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:58:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:58:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:58 INFO - no previously-included directories found matching 'docs/_build' 09:58:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:58:58 INFO - Running setup.py install for pep8 09:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:58 INFO - no previously-included directories found matching 'docs/_build' 09:58:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:58:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:58:58 INFO - Cleaning up... 09:58:58 INFO - Return code: 0 09:58:58 INFO - Running post-action listener: _resource_record_post_action 09:58:58 INFO - Running post-action listener: _start_resource_monitoring 09:58:58 INFO - Starting resource monitoring. 09:58:58 INFO - ##### 09:58:58 INFO - ##### Finished create-virtualenv step (success) 09:58:58 INFO - ##### 09:58:58 INFO - ##### 09:58:58 INFO - ##### Running install step. 09:58:58 INFO - ##### 09:58:58 INFO - Running pre-action listener: _resource_record_pre_action 09:58:58 INFO - Running main action method: install 09:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:58 INFO - Reading from file tmpfile_stdout 09:58:58 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:58 INFO - Reading from file tmpfile_stdout 09:58:58 INFO - Output received: 09:58:58 INFO - Usage: mozinstall [options] installer 09:58:58 INFO - Options: 09:58:58 INFO - -h, --help show this help message and exit 09:58:58 INFO - -d DEST, --destination=DEST 09:58:58 INFO - Directory to install application into. [default: 09:58:58 INFO - "/builds/slave/test"] 09:58:58 INFO - --app=APP Application being installed. [default: firefox] 09:58:58 INFO - mkdir: /builds/slave/test/build/application 09:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:59:14 INFO - Reading from file tmpfile_stdout 09:59:14 INFO - Output received: 09:59:14 INFO - /builds/slave/test/build/application/firefox/firefox 09:59:14 INFO - Running post-action listener: _resource_record_post_action 09:59:14 INFO - ##### 09:59:14 INFO - ##### Finished install step (success) 09:59:14 INFO - ##### 09:59:14 INFO - ##### 09:59:14 INFO - ##### Running run-tests step. 09:59:14 INFO - ##### 09:59:14 INFO - Running pre-action listener: _resource_record_pre_action 09:59:14 INFO - Running main action method: run_tests 09:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:14 INFO - Python 2.7.3 09:59:14 INFO - Return code: 0 09:59:14 INFO - grabbing minidump binary from tooltool 09:59:14 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')]} 09:59:14 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 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:14 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 09:59:14 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 09:59:14 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 09:59:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:15 INFO - Return code: 0 09:59:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:59:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:59:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:59:15 INFO - Return code: 0 09:59:15 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:59:15 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:59:15 INFO - Using env: {'DISPLAY': ':0', 09:59:15 INFO - 'HOME': '/home/cltbld', 09:59:15 INFO - 'LANG': 'en_US.UTF-8', 09:59:15 INFO - 'LANGUAGE': 'en_US:en', 09:59:15 INFO - 'LOGNAME': 'cltbld', 09:59:15 INFO - 'MAIL': '/var/mail/cltbld', 09:59:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:15 INFO - 'MOZ_NO_REMOTE': '1', 09:59:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:15 INFO - 'NO_EM_RESTART': '1', 09:59:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:15 INFO - 'PWD': '/builds/slave/test', 09:59:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:15 INFO - 'SHELL': '/bin/bash', 09:59:15 INFO - 'SHLVL': '1', 09:59:15 INFO - 'TERM': 'linux', 09:59:15 INFO - 'TMOUT': '86400', 09:59:15 INFO - 'USER': 'cltbld', 09:59:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544', 09:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:15 INFO - '_': '/tools/buildbot/bin/python'} 09:59:15 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:59:16 INFO - mozversion application_buildid: 20160624092958 09:59:16 INFO - mozversion application_changeset: 0b20196061d7a3162d7ee6aa0dc470e0e2b24236 09:59:16 INFO - mozversion application_display_name: Nightly 09:59:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:16 INFO - mozversion application_name: Firefox 09:59:16 INFO - mozversion application_remotingname: firefox 09:59:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:59:16 INFO - mozversion application_vendor: Mozilla 09:59:16 INFO - mozversion application_version: 50.0a1 09:59:16 INFO - mozversion platform_buildid: 20160624092958 09:59:16 INFO - mozversion platform_changeset: 0b20196061d7a3162d7ee6aa0dc470e0e2b24236 09:59:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:59:16 INFO - mozversion platform_version: 50.0a1 09:59:16 INFO - using testdate: 1466787556 09:59:16 INFO - actual date: 1466787556 09:59:16 INFO - starting webserver on 'localhost:54222' 09:59:16 INFO - SUITE-START | Running 2 tests 09:59:16 INFO - TEST-START | dromaeo_css 09:59:16 INFO - operating with platform_type : linux_ 09:59:16 INFO - Initialising browser for dromaeo_css test... 09:59:16 INFO - TEST-INFO | started process 21695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS7UaVV/profile http://localhost:54222/getInfo.html) 09:59:21 INFO - PROCESS | 21695 | __metrics Screen width/height:1600/1200 09:59:21 INFO - PROCESS | 21695 | colorDepth:24 09:59:21 INFO - PROCESS | 21695 | Browser inner width/height: 1024/697 09:59:21 INFO - PROCESS | 21695 | __metrics 09:59:21 ERROR - PROCESS | 21695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:59:22 INFO - TEST-INFO | 21695: exit 0 09:59:22 INFO - Browser initialized. 09:59:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:22 INFO - TEST-INFO | started process 21813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS7UaVV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:34 INFO - PROCESS | 21813 | RSS: Main: 185987072 09:59:34 INFO - PROCESS | 21813 | 10:00:24 INFO - PROCESS | 21813 | 1466787624278 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:02:36 INFO - PROCESS | 21813 | Cycle 1(1): loaded http://localhost:54222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54222/tests/dromaeo/cssquery-ext.html) 10:02:37 INFO - PROCESS | 21813 | RSS: Main: 189042688 10:02:37 INFO - PROCESS | 21813 | 10:05:40 INFO - PROCESS | 21813 | Cycle 1(1): loaded http://localhost:54222/tests/dromaeo/cssquery-ext.html (next: http://localhost:54222/tests/dromaeo/cssquery-jquery.html) 10:05:40 INFO - PROCESS | 21813 | RSS: Main: 188289024 10:05:40 INFO - PROCESS | 21813 | 10:08:42 INFO - PROCESS | 21813 | Cycle 1(1): loaded http://localhost:54222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54222/tests/dromaeo/cssquery-mootools.html) 10:08:43 INFO - PROCESS | 21813 | RSS: Main: 189313024 10:08:43 INFO - PROCESS | 21813 | 10:11:45 INFO - PROCESS | 21813 | Cycle 1(1): loaded http://localhost:54222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54222/tests/dromaeo/cssquery-prototype.html) 10:11:45 INFO - PROCESS | 21813 | RSS: Main: 186867712 10:11:45 INFO - PROCESS | 21813 | 10:14:48 INFO - PROCESS | 21813 | Cycle 1(1): loaded http://localhost:54222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54222/tests/dromaeo/cssquery-yui.html) 10:14:49 INFO - PROCESS | 21813 | RSS: Main: 188731392 10:14:49 INFO - PROCESS | 21813 | 10:17:51 INFO - PROCESS | 21813 | Cycle 1(1): loaded http://localhost:54222/tests/dromaeo/cssquery-yui.html (next: http://localhost:54222/tests/dromaeo/cssquery-dojo.html) 10:17:51 INFO - PROCESS | 21813 | RSS: Main: 189657088 10:17:51 INFO - PROCESS | 21813 | 10:17:51 INFO - PROCESS | 21813 | __start_tp_report 10:17:51 INFO - PROCESS | 21813 | _x_x_mozilla_page_load 10:17:51 INFO - PROCESS | 21813 | _x_x_mozilla_page_load_details 10:17:51 INFO - PROCESS | 21813 | |i|pagename|runs| 10:17:51 INFO - PROCESS | 21813 | |0;dojo.html;2661.747134022268;2701.4191948731027;2724.8365098094105;2751.6422865027544;2754.5317296059666;4844.079624871272;4898;4950.2327139293375;4967;4969.378827646544;4803.039392121581;4918.336024636673;4932.901341973158;4946.084974279761;5050.873728156798;4456.777161141946;4465.218586747306;4500.684952053358;4596.402467679214;4637.930431043537;4510.616597589209;4625.79183936722;4629.305604159386;4680.812767489297;4689.109069276844;4401.339799030139;4474.217012022883;4587.288970209589;4592.47186573545;4628.490866004737;4480.507144214133;4490.416245888014;4493.68544201906;4498.257787465064;4539.137563862855;4505.07645932583;4519.819207231707;4530.682852200347;4534.6372290216705;4587.288970209623;4764.380630518011;4801.303810947393;4801.447833499123;4915.483874193194;4927.7536123193695;5155.690658560461;5166.43169251382;5173.896522069537;5177.352830896138;5216.634835561512;5204.401493828221;5232.110541208004;5233.712145831978;5249.711265880375;5251.658642188246;4773.379460670126;4897.755112244374;4935.62982776286;4946.307516947631;4998.775055122528;5402.081646120169;5440.156775699773;5447.128459446549;5455.754491047833;5459.344878614592;5007.29897814299;5245.475452454801;5247.134222853263;5252.763625636855;5294.841154765363;5189.532942035235;5222.529972302435;5230.790768369223;5253.080710875582;5253.395859476209;5081.441041485434;5153.768080436314;5173.896522069537;5218.2955301034635;5255.921161182585;5226.268322434862;5233.738313084331;5234.26720259164;5244.396894357198;5282;4378.321360189176;4439.755813430228;4468.4637843458995;4476.798544065525;4488.820447182142;3865.594112618191;3876.8643097491454;3877.6316249956208;3906.8632597858937;3917;4337.1976184405985;4471.217536931024;4522.751248681354;4527.094581083797;4569.588737013684;5179.533841954167;5222.686638801684;5237.188235823453;5248.265242866002;5248.6325957182635;4458.130664520452;4483.417155769729;4493.460784705856;4496.460424748986;4511.593956543927;4637.675362724577;4651.720896746138;4697.201475749062;4712.5994290485005;4729.314249433813;4804.99095190007;4824.565789079;4841.903161936812;4847.684900481458;4895.167821470359;5204.661696989683;5218.060749065205;5218.608604354613;5223.582113430841;5278.102722537101;4833.951660483491;4841.1285968526;4860.684055536379;4891.755412229445;4920.778564964514;5183.3261675981885;5209.088409528393;5213.218017297436;5215.921761173661;5229.424763275961;5276.894462110813;5278;5285.471452854684;5287.947120528899;5347.919781203207;4926.2610608407595;5058;5078.390593128701;5099.949000509948;5157.252198431132;4861.1006963711825;4892.608591312757;4904.901901962012;4962.230854217602;4978.47725988766;4804.159272127434;4885.65800393969;4895.388076490439;4910.508949105204;4967;5122.923156152586;5137.974310128426;5151.562117220078;5151.8196863109615;5215.191645294985;4974.5771609413605;5057.165567681292;5076.238564215398;5083.491650834887;5090.770915308746 10:17:51 INFO - PROCESS | 21813 | |1;ext.html;524.1275497943841;573.6443405088844;590.1708100119331;594.1978329255505;617.2623714660982;33914;38388.23223535527;38587;38741.41887871681;38798.03004924878;38087.80956095223;38450.23099538007;38683;38841.417378739345;38892.22215555687;7620.542767433944;7744.41916856238;7771.300582947533;7777.727779527718;7781.1829757875175;7712.958750568658;7783.688652453895;7786.143524212361;7815.843683126334;7819.609019549028;7714.729984450545;7808.726694565663;7821.843563128734;7845.646945887449;7878.606069696492;7707.383409327241;7775.222477752208;7776.65005074773;7801.21987801221;7816.765497035041;7664.616769161519;7798.454108212427;7839.098503672094;7856.214378562156;7864.488808227504;37845.81077094624;37964;38251;38403.615963840566;38423.61576384228;3080.6457257415236;3127.1556679696355;3161.525771134325;3227.0641513960923;3474.8783792567137;29456.852715736284;29604;29689.109326720234;29792.70207297921;30225.395492090254;3157.7315928146136;3161.32031613202;3188;3208.9197770055703;3284.080457471912;252253;253845;254104;255116;255130.72434637893;31572;52417.47582524126;52688.73655631697;52728.20907686388;52830.735846320524;32150.83924580362;33864.66135338615;34025.48961765575;34039.829800850835;34474.31051378958;12951.870481295255;13049.739005219843;13076.346182690828;13086.541971030969;13098.934505327603;11275.210735248455;11401.315921044765;11422.14333924959;11507.424628768527;11524.193306468467;7933.9603301983125;7937.722179723797;7950.920490795018;7977.122516523178;8048.356131509465;3079.707427794356;3131.3580715953176;3137.13728724598;3142.5757522734593;3163.604549431321;817.358373676661;880.2781718990367;883.6112110671413;912.6760000199966;988.9813492103145;27900.65463994795;27974.44051119007;28051.719482805318;28544.71455285462;29087.709122908924;931.6133804471204;939.3330735177964;976.3068221562628;1003.1824063388461;1016.8474728790741;14449.566513004627;14669.266536673123;14738.705225895423;14786.260686965608;14798.556043318718;374394;374741;376604;377491;378105;49590;49637.75181124143;49783.004339913;49907.25139122916;49910.75044624826;1213.5509861351356;1213.7329787446747;1227.3863068465766;1237.826704261404;1251.730877861246;25968.610470842574;26876.59685104686;27287.59068614012;27339.99186693484;27577.86211068932;43017.78491107524;43194.568054319054;43898.561014389445;43957.90105247394;44277.33583996178;332786;334484;335715;336460;336853;25029.249122526355;25103.497930041663;25334;25488.872555637845;25498.362540936625;42151;42778;43147.13705725931;43209;44287.55712442834;35676.82161589176;37960;38008.80995595004;38440.80779596084;38937.07971902062;37029.81485092557;37619.81190094032;38047.809760951015;38140.618593813706;38261.234775304896;31482.212944676565;36114.45828312525;36336.818315908255;36509.817450912575;36747.44878826766;32430.351392971537;33752.66247337495;34471;34776.9566912993;34941;25343;25835.612465813403;25906.093286734875;25962.740372596032;26368.20895373142 10:17:51 INFO - PROCESS | 21813 | |2;jquery.html;370.3722190886448;373.5162963961669;375.83651111766386;380.64219633544485;385.2429975098932;15578.376864925403;17155.742663860052;17510.212040458176;17694.64610707785;17743.64512709745;16023.91988040061;16489.83510164901;17187.398441054567;17200.913995430037;17220.13899305033;4966.70199788013;5114.948850511484;5153.6392452528335;5163.561097306715;5165.870853228662;3693.372126738461;5676.631018983753;5993.250843644544;5994.910076348837;6094.603850749687;5079.1365467870555;6000.909986350208;6001.5198784097165;6004.729787159588;6009.429104235091;5389.110796718537;5415.187721841716;5460.535854452376;5499.835004949858;5502.752376143063;5173.275741396207;5434.701091439969;5458.754356053987;5466.890662186774;5468.152436372368;11971.820422693667;12242;12307.32309722965;16693.749593755983;20146.79853201464;1827.7898041725239;1880.8495320374336;1886.9055947550387;1887.4243355776482;1898.905054747271;9010.59452324647;9121.863172052424;9266.351355405124;9938.254630902711;13078;1684.6378028723761;1728.6629107324077;1745.5985123421683;1749.1079549429755;1797.8312351988034;66587.33412665859;71299.28700712978;71777;71851.28148718498;72502.27497725008;9707;9720;10070.59717611302;10113.595456181818;10391.688249352532;13508.459661613426;13654.522091726742;13699.041067125205;13752.93123534396;13759.587212383645;7474;7508.549487030796;7581.886271705929;7604;7831.6475758591005;7201.567905925661;7251.311125443074;7305.050343455317;7373.29953654402;7405.851882962311;4326.307790753464;4368.934465983013;4433.069055498317;4478.776061196927;4505.909881802346;1656.6686662667514;1718.1666891557584;1858.5911099558075;1868.5328667833041;1871.457277389569;752.3003606645763;790.8932294140218;847.766864112374;849.0660273699006;870.2950610005915;16212.270447829877;16469.670606587802;16748.330066797436;16779;16913.7462938056;814.7067055859885;844.2401838345538;861.440063958432;880.6389380354152;898.1467605774541;9043.638254469879;9556.283278753983;9646;9713.660021899199;9789.853152202722;376401;387547;388850;390944;391470;76636;78654.60672696715;78732;78890;79353.60323198348;901.9323550733722;906.6781292641017;910.7085732565515;916.4913473022403;917.156216281023;14856.777148342568;14961.251937403304;15183.392664293304;15682.843171568595;15834.129122898352;35395.82302088473;35459;35552.64447355493;35768.82115589405;35888.64111358853;49362;50267.49732502775;51164;51460.74269628778;51919.480805191466;6679.298673639392;6950.582965022115;7116.323949224816;7666.923330766621;7867.055953285413;11512.251703639236;11957.820632690691;11971.820422693841;12148;12310.630681079581;10126.544305506122;10169.389836609827;10171;10250.794984100126;10376;10351.171906247331;10414.323069000491;10641.414722190353;10702.411367374869;10812.621558245424;10330.121939635215;10494.68515944523;10536.367817930643;10622.309549879234;10745.623903163352;7023.05188799526;7067.57594544329;7070.222275549582;7096;7219.891701624375;9330.346875718906;10139.08748212635;10257.128144107834;10555.366677999038;10565.524551395052 10:17:51 INFO - PROCESS | 21813 | |3;mootools.html;1359.6464919121029;1408.3662950976868;1483.3399137383863;1616.749403842405;1669.0903457615598;6684.398404143626;7390.889136662948;7419.220981796914;7903.446758726885;7921.56431396273;7565.432592555567;7768.805779855506;7790.805229869256;7817.452778305521;7835.80410489738;2085.270155445597;2114.8731076135405;2116.4391436269325;2118.120979793384;2123.6389813731703;2136.647453170225;2151.2148065955894;2163.5348400093976;2166.4367264511184;2170.413988223179;2166.794154555315;2181.923632672857;2198.6152423325934;2202.1521714140013;2214.6013717530836;2098.7901209878964;2123.1507397041228;2134.231676596424;2150.688150218225;2152.4834039830407;2106.0733277357913;2140.1546389176187;2143.5605700831447;2154.0737482882355;2154.6875703022974;7812.804679883048;7897.328727058207;7902.841943161105;7914.525128492309;7918.683252669886;4417;4570.337301091323;4573.268277075652;4583.702059366131;4608.677392582487;2956.3348246644546;2968.317287023975;2981.4633365994114;3072.7541796656437;3085.120740588944;912.9726108216764;922.2529750901724;932.5849996751448;948.0519480519481;981.7938232971085;10436.686899393031;10452.32059916103;10460.738481537946;10494.947525262478;10505.369677819355;4112.897177570525;4145.440365550612;4224.894377640584;4317.762523061199;4326.3510473428605;9043.909560904438;9044.547772611342;9065.637374504946;9077.09229077087;9095;4535.569120933506;4577.908441831145;4588.95411045892;4596.839110631112;4598.494165641777;3434.708049815744;4117.279476091672;4227.894302642397;4281.892952676146;4312.547182545787;3637.2907283080076;3644.726645501545;3697.4268988306853;3755.7370984031404;3870.612938706107;1202.290648517379;1207.4626791077885;1211.6667916322906;1219.2257916223261;1235.1539195651008;717.2791344698545;724.2359310926918;806.9919300806916;810.6838333050115;870.303756994402;5031.345925029723;5036.672616280003;5064.240363945438;5080.314157588678;5136.357955255593;408.2630851313408;413.14272883766307;416.5688512389723;417.7030320853766;431.1786047579366;3487.9128021799656;3544.7518673692593;3590.784552926833;3592.9640703593154;3595.8741444049856;9122.817543649222;9519.190868776093;9523.476208808443;9575.616975321049;9612.903870961341;8768.386212965159;9438.244940404751;9458.054194580487;9494.240460763122;9495.097965693249;6970.965145174242;7218.963905180335;7277.563346199139;7282.308180722823;7297.635118244067;4970.478099799469;5234.581233501234;5259.342582177228;5261.421243663271;5279;8584.871226931726;8633.35249856276;8667.219950204511;8702.347323950855;8741.868871967054;8367.33061355078;8726.258268047033;8740.825183496421;8853.51305678194;8970.37207395476;5939.46544810969;6515.413612774873;6750.797476075725;6844.726210951506;7012.263712310338;7402.888956665762;7405.296496832792;7442.7395041173295;7447.590382529013;7482.401407887465;6567.507436942153;6783.694733737092;6788.796336109925;6834.931650683429;6909.378155965987;6530.771423000362;6582.736690532517;6615.768448104293;6669.233038200669;6691.0967019451755;5995.46040856325;6010.879782404415;6055.1220073090035;6057.151998720271;6097.17688112117;4330.805113769951;4420.403245561936;4488.102379524043;4491.887702807456;4593.425821772278;4500;4504.346869703809;4545.2954792007295;4545.318202269554;4563.703359281636 10:17:51 INFO - PROCESS | 21813 | |4;prototype.html;290.0602049360074;297.51208018849076;298.7833820480152;299.2936669460074;300.54917623564654;5049.444561098281;5122.487751224876;5130.410002849673;5132.717700526469;5146.819861304855;5002.549770520653;5037.949620503794;5047.77285022174;5081.9745901270535;5093.516115968986;3738.607446218142;3827.1771569112634;3925.5878132796074;3933.564249049091;3933.940990885139;3918.3534716771696;3927.194925040374;3935.822887970034;3942.5860284670125;3981.805458362494;3916.941245881314;3929.7817676520226;3938.2714197873483;3941.507311586052;3969.900752481197;3820.541535015788;3949.664278536328;3952.8023598819946;3970.364741641338;3982.2234664240627;3464.3244567309134;3469.2887957968555;3473.565804274466;3480.112571294329;3481.0775144586705;4862.319275301461;4899.142650036265;4938.358013458227;4945.67853089548;4959.404871415417;4373.584509471595;4481.932771008437;4488.551144885518;4525.321201819754;4527.932081018787;5256.395514515803;5267.525092973973;5294.338207724035;5294.947050529484;5303.363596368422;3749.1189570450924;3766.152615661454;3768.8869333920024;3800.20195758891;3800.3159431302356;5399.325084364455;5521.723913804334;5603.411641777636;5616.185653080281;5660.217031635022;3806.8667596633986;3822.1591249924973;3835.5013848200115;3859.112404147062;3867.845286188577;3901.0637447012514;3901.141748815256;3907.5897030811357;3922.941155882664;3964.7621142731527;4461.345499427835;4499.460064792181;4501.909961800811;4518.661100417482;4528.298113792367;5167.199084141964;5331.813386531453;5336.599755018312;5350.732463376816;5378.300820893259;1378.676011137382;1380.2822532283155;1386.681063355434;1388.5070799866105;1396.190209678384;850.753281548344;873.8470767615642;885.3050355470924;891.2736120062128;907.4237858959608;4475.820967161342;4606.792694328763;4614.884627884329;4623.583877451046;4624.5144259852905;5469.15228139639;5476.726163691799;5477.178423236467;5490.890182196334;5492.752826122834;4395.362672412482;4602.585767280961;4619.1685496610935;4629.328747331685;4633.374494443275;2904.956425653617;2918.5184444566407;2921.1966709155154;2926.941461170765;2935.7357837794275;5032.892763592004;5095.566876815512;5102.515261050195;5111.667741596784;5147.536721695065;5454.672719636835;5570.991664501205;5626.156076588462;5656.575756818255;5683.261176047087;5019.84940451787;5024.547790698854;5079.822206222764;5083.949160508421;5111.948880511147;5462.235287059735;5482.835514934558;5489.890202195854;5502.9174562380795;5519.806806761744;5259.4477579853565;5270.8945821084135;5379.843333683277;5387;5410.701431656453;5022;5062.721550314768;5075.467075956972;5113.360829896263;5117.641765076409;3932.174243408916;3944.5069366329208;3944.706170347677;3953.486046813896;3955.149642826806;5195.376554813447;5509.696966666872;5517.510272226396;5528.391876893619;5532.668039917457;5323.920141197963;5339.599530035185;5380.811671591476;5405.135178371599;5407.72961351923;5137.845864624067;5373.758180881791;5373.952079344646;5399.4600539945695;5412.56699464034;5306.761195746278;5328.60035497347;5331.3868905076415;5347.064263753905;5357.78568857257;5167.095758242368;5247.737613119252;5377.8117765878005;5398.217258497417;5407.783688652567;5205.973970130125;5228.895422091613;5258.947410525846;5267.157254839208;5291.523762861207 10:17:51 INFO - PROCESS | 21813 | |5;yui.html;647.0359164844381;657.6908852839164;713.750187434398;716.8494616130612;742.947993640445;12811.42348594313;13374.264415457146;13417.194968301896;13429.127106738055;15002.924985375084;14993.47522836701;15190.696186076271;15202.163880986542;15222.23888805558;15242.085474871516;612.3662009819838;766.2299389113932;771.5486440432339;792.2236208515658;795.1293333799509;778.7313376884994;786.3355464632376;789.4828887078972;789.936805055597;795.8567457857583;830.5265998380895;830.7009476588423;836.05943313772;836.4939211776879;836.9832603347929;815.4984684419039;824.1470078468756;829.5105887526328;830.6760363458226;831.9292860106868;595.9761609535614;600.8467840700637;602.6474512410201;603.0080517548652;604.782278379783;14475.42098316066;14634.975551711277;14751;14782.965192436533;14791.92604036973;13430.395632196476;13594.11638243511;13745.875738878212;13869.861301386958;13934.163950162922;11111.944440277828;11236.49435775384;11286.379249141293;11299.604513842058;11415.42922853854;3338.9499157512655;3420.7605467617277;3444.483327500895;3502.614712381636;3514.2268700885766;69035.65482172558;69224;69540.6522967387;70213;70499.2950070503;10452.790944181073;10540.15678745714;10657.573697052187;10745.14038876888;10932.56269749217;19646.11592478342;19802.90098549498;19941.302054428026;19958;19995.200191992448;6869.072675188885;6927.965360173167;7144.24985376528;7185.137783465913;7205.423566114699;3798.582155962842;3804;3917.882463526099;3923.1761330120426;3938.0154961259686;2949;3052.9236769080508;3058.9235269118003;3061.8162910225456;3065.049834551296;501.07301492239793;504.2738456622452;508.7583397885975;522.3522831688679;522.6837763153237;445.243086752522;454.50231995964367;532.4010488200774;543.1120118606108;562.6455333140177;7307.634618269065;7391.8152046199275;7570.16728159902;7710.807229819187;8131.14622964592;529.9761510732027;530.8195213627386;532.9067413202674;547.1683041776478;561.166667498764;3535.063208249816;3553.147244661263;3648.872289469909;3661.2860492203763;3768.9623103768613;91505;106209;106908;112873;113191.86808131979;91978.54010730037;92495.53752231196;93154;97294;97517;80463.59768201239;83424.58287708645;83476.58261708653;84299.15700843035;84745;7005.638441195631;7223.313785190398;7235.674394652148;7391.593462359407;7816.804579885548;34168;36494.45258321074;41693.16613667649;42928.57071429246;43739.78130109329;65174.34825651683;66886.66556667186;67709.3229067703;67769;68392;10864.619738309122;10963.83554246671;11309.038731707897;11363.48864301125;11390.829137562778;11156.386398748147;11486.712832178928;12404.069694772748;13181;13380.330983450984;11214.495347709535;11251.718707032389;11498.425078745862;11778.587749428729;11830;10903.182261330274;11168.441577921234;11239.66281011571;11296.322220666787;12549.372531373578;10859.891401085888;10971.451427428437;11254.774904502028;11383.829242561535;11395.886041139482;9202.953985230299;9655.758606034906;9701.126898579161;10064.647737329158;10164.24353694245;9422.387544809566;9482.38364506305;9720.864342863939;9921.65274215399;10013.549390277309 10:17:51 INFO - PROCESS | 21813 | __end_tp_report 10:17:51 INFO - PROCESS | 21813 | __start_cc_report 10:17:51 INFO - PROCESS | 21813 | _x_x_mozilla_cycle_collect,394 10:17:51 INFO - PROCESS | 21813 | __end_cc_report 10:17:51 INFO - PROCESS | 21813 | __startTimestamp1466788671948__endTimestamp 10:17:51 INFO - PROCESS | 21813 | 10:17:51 INFO - PROCESS | 21813 | ------- Summary: start ------- 10:17:51 INFO - PROCESS | 21813 | Number of tests: 6 10:17:51 INFO - PROCESS | 21813 | 10:17:51 INFO - PROCESS | 21813 | [#0] dojo.html Cycles:165 Average:4834.35 Median:4926.26 stddev:506.61 (10.3%) stddev-sans-first:478.64 10:17:51 INFO - PROCESS | 21813 | Values: 2661.7 2701.4 2724.8 2751.6 2754.5 4844.1 4898.0 4950.2 4967.0 4969.4 4803.0 4918.3 4932.9 4946.1 5050.9 4456.8 4465.2 4500.7 4596.4 4637.9 4510.6 4625.8 4629.3 4680.8 4689.1 4401.3 4474.2 4587.3 4592.5 4628.5 4480.5 4490.4 4493.7 4498.3 4539.1 4505.1 4519.8 4530.7 4534.6 4587.3 4764.4 4801.3 4801.4 4915.5 4927.8 5155.7 5166.4 5173.9 5177.4 5216.6 5204.4 5232.1 5233.7 5249.7 5251.7 4773.4 4897.8 4935.6 4946.3 4998.8 5402.1 5440.2 5447.1 5455.8 5459.3 5007.3 5245.5 5247.1 5252.8 5294.8 5189.5 5222.5 5230.8 5253.1 5253.4 5081.4 5153.8 5173.9 5218.3 5255.9 5226.3 5233.7 5234.3 5244.4 5282.0 4378.3 4439.8 4468.5 4476.8 4488.8 3865.6 3876.9 3877.6 3906.9 3917.0 4337.2 4471.2 4522.8 4527.1 4569.6 5179.5 5222.7 5237.2 5248.3 5248.6 4458.1 4483.4 4493.5 4496.5 4511.6 4637.7 4651.7 4697.2 4712.6 4729.3 4805.0 4824.6 4841.9 4847.7 4895.2 5204.7 5218.1 5218.6 5223.6 5278.1 4834.0 4841.1 4860.7 4891.8 4920.8 5183.3 5209.1 5213.2 5215.9 5229.4 5276.9 5278.0 5285.5 5287.9 5347.9 4926.3 5058.0 5078.4 5099.9 5157.3 4861.1 4892.6 4904.9 4962.2 4978.5 4804.2 4885.7 4895.4 4910.5 4967.0 5122.9 5138.0 5151.6 5151.8 5215.2 4974.6 5057.2 5076.2 5083.5 5090.8 10:17:51 INFO - PROCESS | 21813 | 10:17:51 INFO - PROCESS | 21813 | [#1] ext.html Cycles:180 Average:46651.18 Median:205711.91 stddev:85921.05 (41.8%) stddev-sans-first:86092.28 10:17:51 INFO - PROCESS | 21813 | Values: 524.1 573.6 590.2 594.2 617.3 33914.0 38388.2 38587.0 38741.4 38798.0 38087.8 38450.2 38683.0 38841.4 38892.2 7620.5 7744.4 7771.3 7777.7 7781.2 7713.0 7783.7 7786.1 7815.8 7819.6 7714.7 7808.7 7821.8 7845.6 7878.6 7707.4 7775.2 7776.7 7801.2 7816.8 7664.6 7798.5 7839.1 7856.2 7864.5 37845.8 37964.0 38251.0 38403.6 38423.6 3080.6 3127.2 3161.5 3227.1 3474.9 29456.9 29604.0 29689.1 29792.7 30225.4 3157.7 3161.3 3188.0 3208.9 3284.1 252253.0 253845.0 254104.0 255116.0 255130.7 31572.0 52417.5 52688.7 52728.2 52830.7 32150.8 33864.7 34025.5 34039.8 34474.3 12951.9 13049.7 13076.3 13086.5 13098.9 11275.2 11401.3 11422.1 11507.4 11524.2 7934.0 7937.7 7950.9 7977.1 8048.4 3079.7 3131.4 3137.1 3142.6 3163.6 817.4 880.3 883.6 912.7 989.0 27900.7 27974.4 28051.7 28544.7 29087.7 931.6 939.3 976.3 1003.2 1016.8 14449.6 14669.3 14738.7 14786.3 14798.6 374394.0 374741.0 376604.0 377491.0 378105.0 49590.0 49637.8 49783.0 49907.3 49910.8 1213.6 1213.7 1227.4 1237.8 1251.7 25968.6 26876.6 27287.6 27340.0 27577.9 43017.8 43194.6 43898.6 43957.9 44277.3 332786.0 334484.0 335715.0 336460.0 336853.0 25029.2 25103.5 25334.0 25488.9 25498.4 42151.0 42778.0 43147.1 43209.0 44287.6 35676.8 37960.0 38008.8 38440.8 38937.1 37029.8 37619.8 38047.8 38140.6 38261.2 31482.2 36114.5 36336.8 36509.8 36747.4 32430.4 33752.7 34471.0 34777.0 34941.0 25343.0 25835.6 25906.1 25962.7 26368.2 10:17:51 INFO - PROCESS | 21813 | 10:17:51 INFO - PROCESS | 21813 | [#2] jquery.html Cycles:180 Average:24151.53 Median:4401.00 stddev:63998.08 (1454.2%) stddev-sans-first:64152.71 10:17:51 INFO - PROCESS | 21813 | Values: 370.4 373.5 375.8 380.6 385.2 15578.4 17155.7 17510.2 17694.6 17743.6 16023.9 16489.8 17187.4 17200.9 17220.1 4966.7 5114.9 5153.6 5163.6 5165.9 3693.4 5676.6 5993.3 5994.9 6094.6 5079.1 6000.9 6001.5 6004.7 6009.4 5389.1 5415.2 5460.5 5499.8 5502.8 5173.3 5434.7 5458.8 5466.9 5468.2 11971.8 12242.0 12307.3 16693.7 20146.8 1827.8 1880.8 1886.9 1887.4 1898.9 9010.6 9121.9 9266.4 9938.3 13078.0 1684.6 1728.7 1745.6 1749.1 1797.8 66587.3 71299.3 71777.0 71851.3 72502.3 9707.0 9720.0 10070.6 10113.6 10391.7 13508.5 13654.5 13699.0 13752.9 13759.6 7474.0 7508.5 7581.9 7604.0 7831.6 7201.6 7251.3 7305.1 7373.3 7405.9 4326.3 4368.9 4433.1 4478.8 4505.9 1656.7 1718.2 1858.6 1868.5 1871.5 752.3 790.9 847.8 849.1 870.3 16212.3 16469.7 16748.3 16779.0 16913.7 814.7 844.2 861.4 880.6 898.1 9043.6 9556.3 9646.0 9713.7 9789.9 376401.0 387547.0 388850.0 390944.0 391470.0 76636.0 78654.6 78732.0 78890.0 79353.6 901.9 906.7 910.7 916.5 917.2 14856.8 14961.3 15183.4 15682.8 15834.1 35395.8 35459.0 35552.6 35768.8 35888.6 49362.0 50267.5 51164.0 51460.7 51919.5 6679.3 6950.6 7116.3 7666.9 7867.1 11512.3 11957.8 11971.8 12148.0 12310.6 10126.5 10169.4 10171.0 10250.8 10376.0 10351.2 10414.3 10641.4 10702.4 10812.6 10330.1 10494.7 10536.4 10622.3 10745.6 7023.1 7067.6 7070.2 7096.0 7219.9 9330.3 10139.1 10257.1 10555.4 10565.5 10:17:51 INFO - PROCESS | 21813 | 10:17:51 INFO - PROCESS | 21813 | [#3] mootools.html Cycles:180 Average:5059.24 Median:5000.91 stddev:2836.09 (56.7%) stddev-sans-first:2830.42 10:17:51 INFO - PROCESS | 21813 | Values: 1359.6 1408.4 1483.3 1616.7 1669.1 6684.4 7390.9 7419.2 7903.4 7921.6 7565.4 7768.8 7790.8 7817.5 7835.8 2085.3 2114.9 2116.4 2118.1 2123.6 2136.6 2151.2 2163.5 2166.4 2170.4 2166.8 2181.9 2198.6 2202.2 2214.6 2098.8 2123.2 2134.2 2150.7 2152.5 2106.1 2140.2 2143.6 2154.1 2154.7 7812.8 7897.3 7902.8 7914.5 7918.7 4417.0 4570.3 4573.3 4583.7 4608.7 2956.3 2968.3 2981.5 3072.8 3085.1 913.0 922.3 932.6 948.1 981.8 10436.7 10452.3 10460.7 10494.9 10505.4 4112.9 4145.4 4224.9 4317.8 4326.4 9043.9 9044.5 9065.6 9077.1 9095.0 4535.6 4577.9 4589.0 4596.8 4598.5 3434.7 4117.3 4227.9 4281.9 4312.5 3637.3 3644.7 3697.4 3755.7 3870.6 1202.3 1207.5 1211.7 1219.2 1235.2 717.3 724.2 807.0 810.7 870.3 5031.3 5036.7 5064.2 5080.3 5136.4 408.3 413.1 416.6 417.7 431.2 3487.9 3544.8 3590.8 3593.0 3595.9 9122.8 9519.2 9523.5 9575.6 9612.9 8768.4 9438.2 9458.1 9494.2 9495.1 6971.0 7219.0 7277.6 7282.3 7297.6 4970.5 5234.6 5259.3 5261.4 5279.0 8584.9 8633.4 8667.2 8702.3 8741.9 8367.3 8726.3 8740.8 8853.5 8970.4 5939.5 6515.4 6750.8 6844.7 7012.3 7402.9 7405.3 7442.7 7447.6 7482.4 6567.5 6783.7 6788.8 6834.9 6909.4 6530.8 6582.7 6615.8 6669.2 6691.1 5995.5 6010.9 6055.1 6057.2 6097.2 4330.8 4420.4 4488.1 4491.9 4593.4 4500.0 4504.3 4545.3 4545.3 4563.7 10:17:51 INFO - PROCESS | 21813 | 10:17:51 INFO - PROCESS | 21813 | [#4] prototype.html Cycles:180 Average:4409.63 Median:5042.86 stddev:1285.98 (25.5%) stddev-sans-first:1251.86 10:17:51 INFO - PROCESS | 21813 | Values: 290.1 297.5 298.8 299.3 300.5 5049.4 5122.5 5130.4 5132.7 5146.8 5002.5 5037.9 5047.8 5082.0 5093.5 3738.6 3827.2 3925.6 3933.6 3933.9 3918.4 3927.2 3935.8 3942.6 3981.8 3916.9 3929.8 3938.3 3941.5 3969.9 3820.5 3949.7 3952.8 3970.4 3982.2 3464.3 3469.3 3473.6 3480.1 3481.1 4862.3 4899.1 4938.4 4945.7 4959.4 4373.6 4481.9 4488.6 4525.3 4527.9 5256.4 5267.5 5294.3 5294.9 5303.4 3749.1 3766.2 3768.9 3800.2 3800.3 5399.3 5521.7 5603.4 5616.2 5660.2 3806.9 3822.2 3835.5 3859.1 3867.8 3901.1 3901.1 3907.6 3922.9 3964.8 4461.3 4499.5 4501.9 4518.7 4528.3 5167.2 5331.8 5336.6 5350.7 5378.3 1378.7 1380.3 1386.7 1388.5 1396.2 850.8 873.8 885.3 891.3 907.4 4475.8 4606.8 4614.9 4623.6 4624.5 5469.2 5476.7 5477.2 5490.9 5492.8 4395.4 4602.6 4619.2 4629.3 4633.4 2905.0 2918.5 2921.2 2926.9 2935.7 5032.9 5095.6 5102.5 5111.7 5147.5 5454.7 5571.0 5626.2 5656.6 5683.3 5019.8 5024.5 5079.8 5083.9 5111.9 5462.2 5482.8 5489.9 5502.9 5519.8 5259.4 5270.9 5379.8 5387.0 5410.7 5022.0 5062.7 5075.5 5113.4 5117.6 3932.2 3944.5 3944.7 3953.5 3955.1 5195.4 5509.7 5517.5 5528.4 5532.7 5323.9 5339.6 5380.8 5405.1 5407.7 5137.8 5373.8 5374.0 5399.5 5412.6 5306.8 5328.6 5331.4 5347.1 5357.8 5167.1 5247.7 5377.8 5398.2 5407.8 5206.0 5228.9 5258.9 5267.2 5291.5 10:17:51 INFO - PROCESS | 21813 | 10:17:51 INFO - PROCESS | 21813 | [#5] yui.html Cycles:180 Average:18853.92 Median:43334.18 stddev:27917.21 (64.4%) stddev-sans-first:27962.06 10:17:51 INFO - PROCESS | 21813 | Values: 647.0 657.7 713.8 716.8 742.9 12811.4 13374.3 13417.2 13429.1 15002.9 14993.5 15190.7 15202.2 15222.2 15242.1 612.4 766.2 771.5 792.2 795.1 778.7 786.3 789.5 789.9 795.9 830.5 830.7 836.1 836.5 837.0 815.5 824.1 829.5 830.7 831.9 596.0 600.8 602.6 603.0 604.8 14475.4 14635.0 14751.0 14783.0 14791.9 13430.4 13594.1 13745.9 13869.9 13934.2 11111.9 11236.5 11286.4 11299.6 11415.4 3338.9 3420.8 3444.5 3502.6 3514.2 69035.7 69224.0 69540.7 70213.0 70499.3 10452.8 10540.2 10657.6 10745.1 10932.6 19646.1 19802.9 19941.3 19958.0 19995.2 6869.1 6928.0 7144.2 7185.1 7205.4 3798.6 3804.0 3917.9 3923.2 3938.0 2949.0 3052.9 3058.9 3061.8 3065.0 501.1 504.3 508.8 522.4 522.7 445.2 454.5 532.4 543.1 562.6 7307.6 7391.8 7570.2 7710.8 8131.1 530.0 530.8 532.9 547.2 561.2 3535.1 3553.1 3648.9 3661.3 3769.0 91505.0 106209.0 106908.0 112873.0 113191.9 91978.5 92495.5 93154.0 97294.0 97517.0 80463.6 83424.6 83476.6 84299.2 84745.0 7005.6 7223.3 7235.7 7391.6 7816.8 34168.0 36494.5 41693.2 42928.6 43739.8 65174.3 66886.7 67709.3 67769.0 68392.0 10864.6 10963.8 11309.0 11363.5 11390.8 11156.4 11486.7 12404.1 13181.0 13380.3 11214.5 11251.7 11498.4 11778.6 11830.0 10903.2 11168.4 11239.7 11296.3 12549.4 10859.9 10971.5 11254.8 11383.8 11395.9 9203.0 9655.8 9701.1 10064.6 10164.2 9422.4 9482.4 9720.9 9921.7 10013.5 10:17:51 INFO - PROCESS | 21813 | -------- Summary: end -------- 10:17:51 INFO - PROCESS | 21813 | 10:17:52 INFO - TEST-INFO | 21813: exit 0 10:17:52 INFO - TEST-OK | dromaeo_css | took 1116619ms 10:17:52 INFO - TEST-START | kraken 10:17:52 INFO - operating with platform_type : linux_ 10:17:52 INFO - Initialising browser for kraken test... 10:17:52 INFO - TEST-INFO | started process 22056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6P6hau/profile http://localhost:54222/getInfo.html) 10:17:57 INFO - PROCESS | 22056 | __metrics Screen width/height:1600/1200 10:17:57 INFO - PROCESS | 22056 | colorDepth:24 10:17:57 INFO - PROCESS | 22056 | Browser inner width/height: 1024/697 10:17:57 INFO - PROCESS | 22056 | __metrics 10:17:58 ERROR - PROCESS | 22056 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:17:59 INFO - TEST-INFO | 22056: exit 0 10:17:59 INFO - Browser initialized. 10:17:59 INFO - Running cycle 1/1 for kraken test... 10:17:59 INFO - TEST-INFO | started process 22178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6P6hau/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:11 INFO - PROCESS | 22178 | RSS: Main: 186286080 10:18:11 INFO - PROCESS | 22178 | 10:18:13 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54222/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:14 INFO - PROCESS | 22178 | RSS: Main: 190713856 10:18:14 INFO - PROCESS | 22178 | 10:18:17 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54222/tests/kraken/driver.html?testName=audio-dft) 10:18:18 INFO - PROCESS | 22178 | RSS: Main: 191160320 10:18:18 INFO - PROCESS | 22178 | 10:18:21 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54222/tests/kraken/driver.html?testName=audio-fft) 10:18:21 INFO - PROCESS | 22178 | RSS: Main: 186265600 10:18:21 INFO - PROCESS | 22178 | 10:18:24 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54222/tests/kraken/driver.html?testName=audio-oscillator) 10:18:24 INFO - PROCESS | 22178 | RSS: Main: 186494976 10:18:24 INFO - PROCESS | 22178 | 10:18:27 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:27 INFO - PROCESS | 22178 | RSS: Main: 186851328 10:18:27 INFO - PROCESS | 22178 | 10:18:30 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54222/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:31 INFO - PROCESS | 22178 | RSS: Main: 187199488 10:18:31 INFO - PROCESS | 22178 | 10:18:34 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54222/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:35 INFO - PROCESS | 22178 | RSS: Main: 184872960 10:18:35 INFO - PROCESS | 22178 | 10:18:38 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54222/tests/kraken/driver.html?testName=json-parse-financial) 10:18:39 INFO - PROCESS | 22178 | RSS: Main: 186212352 10:18:39 INFO - PROCESS | 22178 | 10:18:40 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:41 INFO - PROCESS | 22178 | RSS: Main: 186400768 10:18:41 INFO - PROCESS | 22178 | 10:18:43 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54222/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:44 INFO - PROCESS | 22178 | RSS: Main: 186433536 10:18:44 INFO - PROCESS | 22178 | 10:18:46 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:47 INFO - PROCESS | 22178 | RSS: Main: 186748928 10:18:47 INFO - PROCESS | 22178 | 10:18:49 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:50 INFO - PROCESS | 22178 | RSS: Main: 187142144 10:18:50 INFO - PROCESS | 22178 | 10:18:53 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:54 INFO - PROCESS | 22178 | RSS: Main: 187121664 10:18:54 INFO - PROCESS | 22178 | 10:18:55 INFO - PROCESS | 22178 | Cycle 1(1): loaded http://localhost:54222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54222/tests/kraken/driver.html?testName=ai-astar) 10:18:56 INFO - PROCESS | 22178 | RSS: Main: 188137472 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | __start_tp_report 10:18:56 INFO - PROCESS | 22178 | _x_x_mozilla_page_load 10:18:56 INFO - PROCESS | 22178 | _x_x_mozilla_page_load_details 10:18:56 INFO - PROCESS | 22178 | |i|pagename|runs| 10:18:56 INFO - PROCESS | 22178 | |0;ai-astar;105;115;106;115;113;116;115;113;115;113 10:18:56 INFO - PROCESS | 22178 | |1;audio-beat-detection;160;143;159;181;135;165;160;133;198;140 10:18:56 INFO - PROCESS | 22178 | |2;audio-dft;163;165;170;167;160;162;164;164;160;162 10:18:56 INFO - PROCESS | 22178 | |3;audio-fft;76;77;76;167;76;77;76;76;161;77 10:18:56 INFO - PROCESS | 22178 | |4;audio-oscillator;88;87;153;87;87;88;136;86;86;137 10:18:56 INFO - PROCESS | 22178 | |5;imaging-gaussian-blur;119;117;118;119;117;119;121;119;120;118 10:18:56 INFO - PROCESS | 22178 | |6;imaging-darkroom;149;148;149;148;147;148;148;148;147;148 10:18:56 INFO - PROCESS | 22178 | |7;imaging-desaturate;96;97;95;96;95;95;96;96;95;96 10:18:56 INFO - PROCESS | 22178 | |8;json-parse-financial;67;66;66;67;66;65;67;68;66;66 10:18:56 INFO - PROCESS | 22178 | |9;json-stringify-tinderbox;66;65;65;65;65;64;64;65;65;66 10:18:56 INFO - PROCESS | 22178 | |10;stanford-crypto-aes;82;87;89;82;89;88;88;82;103;89 10:18:56 INFO - PROCESS | 22178 | |11;stanford-crypto-ccm;133;132;150;134;134;132;151;140;135;133 10:18:56 INFO - PROCESS | 22178 | |12;stanford-crypto-pbkdf2;177;180;176;183;172;173;172;173;175;172 10:18:56 INFO - PROCESS | 22178 | |13;stanford-crypto-sha256-iterative;70;67;72;67;66;67;68;68;67;66 10:18:56 INFO - PROCESS | 22178 | __end_tp_report 10:18:56 INFO - PROCESS | 22178 | __start_cc_report 10:18:56 INFO - PROCESS | 22178 | _x_x_mozilla_cycle_collect,963 10:18:56 INFO - PROCESS | 22178 | __end_cc_report 10:18:56 INFO - PROCESS | 22178 | __startTimestamp1466788736078__endTimestamp 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | ------- Summary: start ------- 10:18:56 INFO - PROCESS | 22178 | Number of tests: 14 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#0] ai-astar Cycles:10 Average:112.60 Median:115.00 stddev:3.89 (3.4%) stddev-sans-first:3.00 10:18:56 INFO - PROCESS | 22178 | Values: 105.0 115.0 106.0 115.0 113.0 116.0 115.0 113.0 115.0 113.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:160.00 stddev:20.78 (13.0%) stddev-sans-first:22.02 10:18:56 INFO - PROCESS | 22178 | Values: 160.0 143.0 159.0 181.0 135.0 165.0 160.0 133.0 198.0 140.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:3.09 (1.9%) stddev-sans-first:3.27 10:18:56 INFO - PROCESS | 22178 | Values: 163.0 165.0 170.0 167.0 160.0 162.0 164.0 164.0 160.0 162.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:36.98 (48.7%) stddev-sans-first:38.65 10:18:56 INFO - PROCESS | 22178 | Values: 76.0 77.0 76.0 167.0 76.0 77.0 76.0 76.0 161.0 77.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:87.00 stddev:26.95 (31.0%) stddev-sans-first:28.00 10:18:56 INFO - PROCESS | 22178 | Values: 88.0 87.0 153.0 87.0 87.0 88.0 136.0 86.0 86.0 137.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:119.00 stddev:1.25 (1.1%) stddev-sans-first:1.32 10:18:56 INFO - PROCESS | 22178 | Values: 119.0 117.0 118.0 119.0 117.0 119.0 121.0 119.0 120.0 118.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 10:18:56 INFO - PROCESS | 22178 | Values: 149.0 148.0 149.0 148.0 147.0 148.0 148.0 148.0 147.0 148.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:18:56 INFO - PROCESS | 22178 | Values: 96.0 97.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 10:18:56 INFO - PROCESS | 22178 | Values: 67.0 66.0 66.0 67.0 66.0 65.0 67.0 68.0 66.0 66.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 10:18:56 INFO - PROCESS | 22178 | Values: 66.0 65.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 66.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.00 stddev:6.12 (7.0%) stddev-sans-first:6.11 10:18:56 INFO - PROCESS | 22178 | Values: 82.0 87.0 89.0 82.0 89.0 88.0 88.0 82.0 103.0 89.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:134.50 stddev:7.28 (5.4%) stddev-sans-first:7.54 10:18:56 INFO - PROCESS | 22178 | Values: 133.0 132.0 150.0 134.0 134.0 132.0 151.0 140.0 135.0 133.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:175.50 stddev:3.77 (2.1%) stddev-sans-first:3.95 10:18:56 INFO - PROCESS | 22178 | Values: 177.0 180.0 176.0 183.0 172.0 173.0 172.0 173.0 175.0 172.0 10:18:56 INFO - PROCESS | 22178 | 10:18:56 INFO - PROCESS | 22178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:1.87 (2.8%) stddev-sans-first:1.81 10:18:56 INFO - PROCESS | 22178 | Values: 70.0 67.0 72.0 67.0 66.0 67.0 68.0 68.0 67.0 66.0 10:18:56 INFO - PROCESS | 22178 | -------- Summary: end -------- 10:18:56 INFO - PROCESS | 22178 | 10:18:57 INFO - TEST-INFO | 22178: exit 0 10:18:57 INFO - TEST-OK | kraken | took 64414ms 10:18:57 INFO - SUITE-END | took 1181s 10:18:57 INFO - Completed test suite (00:19:41) 10:18:57 INFO - javascript benchmark 10:18:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6405.921327836134, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2661.747134022268, 2701.4191948731027, 2724.8365098094105, 2751.6422865027544, 2754.5317296059666, 4844.079624871272, 4898.0, 4950.2327139293375, 4967.0, 4969.378827646544, 4803.039392121581, 4918.336024636673, 4932.901341973158, 4946.084974279761, 5050.873728156798, 4456.777161141946, 4465.218586747306, 4500.684952053358, 4596.402467679214, 4637.930431043537, 4510.616597589209, 4625.79183936722, 4629.305604159386, 4680.812767489297, 4689.109069276844, 4401.339799030139, 4474.217012022883, 4587.288970209589, 4592.47186573545, 4628.490866004737, 4480.507144214133, 4490.416245888014, 4493.68544201906, 4498.257787465064, 4539.137563862855, 4505.07645932583, 4519.819207231707, 4530.682852200347, 4534.6372290216705, 4587.288970209623, 4764.380630518011, 4801.303810947393, 4801.447833499123, 4915.483874193194, 4927.7536123193695, 5155.690658560461, 5166.43169251382, 5173.896522069537, 5177.352830896138, 5216.634835561512, 5204.401493828221, 5232.110541208004, 5233.712145831978, 5249.711265880375, 5251.658642188246, 4773.379460670126, 4897.755112244374, 4935.62982776286, 4946.307516947631, 4998.775055122528, 5402.081646120169, 5440.156775699773, 5447.128459446549, 5455.754491047833, 5459.344878614592, 5007.29897814299, 5245.475452454801, 5247.134222853263, 5252.763625636855, 5294.841154765363, 5189.532942035235, 5222.529972302435, 5230.790768369223, 5253.080710875582, 5253.395859476209, 5081.441041485434, 5153.768080436314, 5173.896522069537, 5218.2955301034635, 5255.921161182585, 5226.268322434862, 5233.738313084331, 5234.26720259164, 5244.396894357198, 5282.0, 4378.321360189176, 4439.755813430228, 4468.4637843458995, 4476.798544065525, 4488.820447182142, 3865.594112618191, 3876.8643097491454, 3877.6316249956208, 3906.8632597858937, 3917.0, 4337.1976184405985, 4471.217536931024, 4522.751248681354, 4527.094581083797, 4569.588737013684, 5179.533841954167, 5222.686638801684, 5237.188235823453, 5248.265242866002, 5248.6325957182635, 4458.130664520452, 4483.417155769729, 4493.460784705856, 4496.460424748986, 4511.593956543927, 4637.675362724577, 4651.720896746138, 4697.201475749062, 4712.5994290485005, 4729.314249433813, 4804.99095190007, 4824.565789079, 4841.903161936812, 4847.684900481458, 4895.167821470359, 5204.661696989683, 5218.060749065205, 5218.608604354613, 5223.582113430841, 5278.102722537101, 4833.951660483491, 4841.1285968526, 4860.684055536379, 4891.755412229445, 4920.778564964514, 5183.3261675981885, 5209.088409528393, 5213.218017297436, 5215.921761173661, 5229.424763275961, 5276.894462110813, 5278.0, 5285.471452854684, 5287.947120528899, 5347.919781203207, 4926.2610608407595, 5058.0, 5078.390593128701, 5099.949000509948, 5157.252198431132, 4861.1006963711825, 4892.608591312757, 4904.901901962012, 4962.230854217602, 4978.47725988766, 4804.159272127434, 4885.65800393969, 4895.388076490439, 4910.508949105204, 4967.0, 5122.923156152586, 5137.974310128426, 5151.562117220078, 5151.8196863109615, 5215.191645294985, 4974.5771609413605, 5057.165567681292, 5076.238564215398, 5083.491650834887, 5090.770915308746], "value": 4801.96095781411, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.1275497943841, 573.6443405088844, 590.1708100119331, 594.1978329255505, 617.2623714660982, 33914.0, 38388.23223535527, 38587.0, 38741.41887871681, 38798.03004924878, 38087.80956095223, 38450.23099538007, 38683.0, 38841.417378739345, 38892.22215555687, 7620.542767433944, 7744.41916856238, 7771.300582947533, 7777.727779527718, 7781.1829757875175, 7712.958750568658, 7783.688652453895, 7786.143524212361, 7815.843683126334, 7819.609019549028, 7714.729984450545, 7808.726694565663, 7821.843563128734, 7845.646945887449, 7878.606069696492, 7707.383409327241, 7775.222477752208, 7776.65005074773, 7801.21987801221, 7816.765497035041, 7664.616769161519, 7798.454108212427, 7839.098503672094, 7856.214378562156, 7864.488808227504, 37845.81077094624, 37964.0, 38251.0, 38403.615963840566, 38423.61576384228, 3080.6457257415236, 3127.1556679696355, 3161.525771134325, 3227.0641513960923, 3474.8783792567137, 29456.852715736284, 29604.0, 29689.109326720234, 29792.70207297921, 30225.395492090254, 3157.7315928146136, 3161.32031613202, 3188.0, 3208.9197770055703, 3284.080457471912, 252253.0, 253845.0, 254104.0, 255116.0, 255130.72434637893, 31572.0, 52417.47582524126, 52688.73655631697, 52728.20907686388, 52830.735846320524, 32150.83924580362, 33864.66135338615, 34025.48961765575, 34039.829800850835, 34474.31051378958, 12951.870481295255, 13049.739005219843, 13076.346182690828, 13086.541971030969, 13098.934505327603, 11275.210735248455, 11401.315921044765, 11422.14333924959, 11507.424628768527, 11524.193306468467, 7933.9603301983125, 7937.722179723797, 7950.920490795018, 7977.122516523178, 8048.356131509465, 3079.707427794356, 3131.3580715953176, 3137.13728724598, 3142.5757522734593, 3163.604549431321, 817.358373676661, 880.2781718990367, 883.6112110671413, 912.6760000199966, 988.9813492103145, 27900.65463994795, 27974.44051119007, 28051.719482805318, 28544.71455285462, 29087.709122908924, 931.6133804471204, 939.3330735177964, 976.3068221562628, 1003.1824063388461, 1016.8474728790741, 14449.566513004627, 14669.266536673123, 14738.705225895423, 14786.260686965608, 14798.556043318718, 374394.0, 374741.0, 376604.0, 377491.0, 378105.0, 49590.0, 49637.75181124143, 49783.004339913, 49907.25139122916, 49910.75044624826, 1213.5509861351356, 1213.7329787446747, 1227.3863068465766, 1237.826704261404, 1251.730877861246, 25968.610470842574, 26876.59685104686, 27287.59068614012, 27339.99186693484, 27577.86211068932, 43017.78491107524, 43194.568054319054, 43898.561014389445, 43957.90105247394, 44277.33583996178, 332786.0, 334484.0, 335715.0, 336460.0, 336853.0, 25029.249122526355, 25103.497930041663, 25334.0, 25488.872555637845, 25498.362540936625, 42151.0, 42778.0, 43147.13705725931, 43209.0, 44287.55712442834, 35676.82161589176, 37960.0, 38008.80995595004, 38440.80779596084, 38937.07971902062, 37029.81485092557, 37619.81190094032, 38047.809760951015, 38140.618593813706, 38261.234775304896, 31482.212944676565, 36114.45828312525, 36336.818315908255, 36509.817450912575, 36747.44878826766, 32430.351392971537, 33752.66247337495, 34471.0, 34776.9566912993, 34941.0, 25343.0, 25835.612465813403, 25906.093286734875, 25962.740372596032, 26368.20895373142], "value": 16518.451212977277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.3722190886448, 373.5162963961669, 375.83651111766386, 380.64219633544485, 385.2429975098932, 15578.376864925403, 17155.742663860052, 17510.212040458176, 17694.64610707785, 17743.64512709745, 16023.91988040061, 16489.83510164901, 17187.398441054567, 17200.913995430037, 17220.13899305033, 4966.70199788013, 5114.948850511484, 5153.6392452528335, 5163.561097306715, 5165.870853228662, 3693.372126738461, 5676.631018983753, 5993.250843644544, 5994.910076348837, 6094.603850749687, 5079.1365467870555, 6000.909986350208, 6001.5198784097165, 6004.729787159588, 6009.429104235091, 5389.110796718537, 5415.187721841716, 5460.535854452376, 5499.835004949858, 5502.752376143063, 5173.275741396207, 5434.701091439969, 5458.754356053987, 5466.890662186774, 5468.152436372368, 11971.820422693667, 12242.0, 12307.32309722965, 16693.749593755983, 20146.79853201464, 1827.7898041725239, 1880.8495320374336, 1886.9055947550387, 1887.4243355776482, 1898.905054747271, 9010.59452324647, 9121.863172052424, 9266.351355405124, 9938.254630902711, 13078.0, 1684.6378028723761, 1728.6629107324077, 1745.5985123421683, 1749.1079549429755, 1797.8312351988034, 66587.33412665859, 71299.28700712978, 71777.0, 71851.28148718498, 72502.27497725008, 9707.0, 9720.0, 10070.59717611302, 10113.595456181818, 10391.688249352532, 13508.459661613426, 13654.522091726742, 13699.041067125205, 13752.93123534396, 13759.587212383645, 7474.0, 7508.549487030796, 7581.886271705929, 7604.0, 7831.6475758591005, 7201.567905925661, 7251.311125443074, 7305.050343455317, 7373.29953654402, 7405.851882962311, 4326.307790753464, 4368.934465983013, 4433.069055498317, 4478.776061196927, 4505.909881802346, 1656.6686662667514, 1718.1666891557584, 1858.5911099558075, 1868.5328667833041, 1871.457277389569, 752.3003606645763, 790.8932294140218, 847.766864112374, 849.0660273699006, 870.2950610005915, 16212.270447829877, 16469.670606587802, 16748.330066797436, 16779.0, 16913.7462938056, 814.7067055859885, 844.2401838345538, 861.440063958432, 880.6389380354152, 898.1467605774541, 9043.638254469879, 9556.283278753983, 9646.0, 9713.660021899199, 9789.853152202722, 376401.0, 387547.0, 388850.0, 390944.0, 391470.0, 76636.0, 78654.60672696715, 78732.0, 78890.0, 79353.60323198348, 901.9323550733722, 906.6781292641017, 910.7085732565515, 916.4913473022403, 917.156216281023, 14856.777148342568, 14961.251937403304, 15183.392664293304, 15682.843171568595, 15834.129122898352, 35395.82302088473, 35459.0, 35552.64447355493, 35768.82115589405, 35888.64111358853, 49362.0, 50267.49732502775, 51164.0, 51460.74269628778, 51919.480805191466, 6679.298673639392, 6950.582965022115, 7116.323949224816, 7666.923330766621, 7867.055953285413, 11512.251703639236, 11957.820632690691, 11971.820422693841, 12148.0, 12310.630681079581, 10126.544305506122, 10169.389836609827, 10171.0, 10250.794984100126, 10376.0, 10351.171906247331, 10414.323069000491, 10641.414722190353, 10702.411367374869, 10812.621558245424, 10330.121939635215, 10494.68515944523, 10536.367817930643, 10622.309549879234, 10745.623903163352, 7023.05188799526, 7067.57594544329, 7070.222275549582, 7096.0, 7219.891701624375, 9330.346875718906, 10139.08748212635, 10257.128144107834, 10555.366677999038, 10565.524551395052], "value": 8162.0268941235745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.6464919121029, 1408.3662950976868, 1483.3399137383863, 1616.749403842405, 1669.0903457615598, 6684.398404143626, 7390.889136662948, 7419.220981796914, 7903.446758726885, 7921.56431396273, 7565.432592555567, 7768.805779855506, 7790.805229869256, 7817.452778305521, 7835.80410489738, 2085.270155445597, 2114.8731076135405, 2116.4391436269325, 2118.120979793384, 2123.6389813731703, 2136.647453170225, 2151.2148065955894, 2163.5348400093976, 2166.4367264511184, 2170.413988223179, 2166.794154555315, 2181.923632672857, 2198.6152423325934, 2202.1521714140013, 2214.6013717530836, 2098.7901209878964, 2123.1507397041228, 2134.231676596424, 2150.688150218225, 2152.4834039830407, 2106.0733277357913, 2140.1546389176187, 2143.5605700831447, 2154.0737482882355, 2154.6875703022974, 7812.804679883048, 7897.328727058207, 7902.841943161105, 7914.525128492309, 7918.683252669886, 4417.0, 4570.337301091323, 4573.268277075652, 4583.702059366131, 4608.677392582487, 2956.3348246644546, 2968.317287023975, 2981.4633365994114, 3072.7541796656437, 3085.120740588944, 912.9726108216764, 922.2529750901724, 932.5849996751448, 948.0519480519481, 981.7938232971085, 10436.686899393031, 10452.32059916103, 10460.738481537946, 10494.947525262478, 10505.369677819355, 4112.897177570525, 4145.440365550612, 4224.894377640584, 4317.762523061199, 4326.3510473428605, 9043.909560904438, 9044.547772611342, 9065.637374504946, 9077.09229077087, 9095.0, 4535.569120933506, 4577.908441831145, 4588.95411045892, 4596.839110631112, 4598.494165641777, 3434.708049815744, 4117.279476091672, 4227.894302642397, 4281.892952676146, 4312.547182545787, 3637.2907283080076, 3644.726645501545, 3697.4268988306853, 3755.7370984031404, 3870.612938706107, 1202.290648517379, 1207.4626791077885, 1211.6667916322906, 1219.2257916223261, 1235.1539195651008, 717.2791344698545, 724.2359310926918, 806.9919300806916, 810.6838333050115, 870.303756994402, 5031.345925029723, 5036.672616280003, 5064.240363945438, 5080.314157588678, 5136.357955255593, 408.2630851313408, 413.14272883766307, 416.5688512389723, 417.7030320853766, 431.1786047579366, 3487.9128021799656, 3544.7518673692593, 3590.784552926833, 3592.9640703593154, 3595.8741444049856, 9122.817543649222, 9519.190868776093, 9523.476208808443, 9575.616975321049, 9612.903870961341, 8768.386212965159, 9438.244940404751, 9458.054194580487, 9494.240460763122, 9495.097965693249, 6970.965145174242, 7218.963905180335, 7277.563346199139, 7282.308180722823, 7297.635118244067, 4970.478099799469, 5234.581233501234, 5259.342582177228, 5261.421243663271, 5279.0, 8584.871226931726, 8633.35249856276, 8667.219950204511, 8702.347323950855, 8741.868871967054, 8367.33061355078, 8726.258268047033, 8740.825183496421, 8853.51305678194, 8970.37207395476, 5939.46544810969, 6515.413612774873, 6750.797476075725, 6844.726210951506, 7012.263712310338, 7402.888956665762, 7405.296496832792, 7442.7395041173295, 7447.590382529013, 7482.401407887465, 6567.507436942153, 6783.694733737092, 6788.796336109925, 6834.931650683429, 6909.378155965987, 6530.771423000362, 6582.736690532517, 6615.768448104293, 6669.233038200669, 6691.0967019451755, 5995.46040856325, 6010.879782404415, 6055.1220073090035, 6057.151998720271, 6097.17688112117, 4330.805113769951, 4420.403245561936, 4488.102379524043, 4491.887702807456, 4593.425821772278, 4500.0, 4504.346869703809, 4545.2954792007295, 4545.318202269554, 4563.703359281636], "value": 4016.990238372942, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.0602049360074, 297.51208018849076, 298.7833820480152, 299.2936669460074, 300.54917623564654, 5049.444561098281, 5122.487751224876, 5130.410002849673, 5132.717700526469, 5146.819861304855, 5002.549770520653, 5037.949620503794, 5047.77285022174, 5081.9745901270535, 5093.516115968986, 3738.607446218142, 3827.1771569112634, 3925.5878132796074, 3933.564249049091, 3933.940990885139, 3918.3534716771696, 3927.194925040374, 3935.822887970034, 3942.5860284670125, 3981.805458362494, 3916.941245881314, 3929.7817676520226, 3938.2714197873483, 3941.507311586052, 3969.900752481197, 3820.541535015788, 3949.664278536328, 3952.8023598819946, 3970.364741641338, 3982.2234664240627, 3464.3244567309134, 3469.2887957968555, 3473.565804274466, 3480.112571294329, 3481.0775144586705, 4862.319275301461, 4899.142650036265, 4938.358013458227, 4945.67853089548, 4959.404871415417, 4373.584509471595, 4481.932771008437, 4488.551144885518, 4525.321201819754, 4527.932081018787, 5256.395514515803, 5267.525092973973, 5294.338207724035, 5294.947050529484, 5303.363596368422, 3749.1189570450924, 3766.152615661454, 3768.8869333920024, 3800.20195758891, 3800.3159431302356, 5399.325084364455, 5521.723913804334, 5603.411641777636, 5616.185653080281, 5660.217031635022, 3806.8667596633986, 3822.1591249924973, 3835.5013848200115, 3859.112404147062, 3867.845286188577, 3901.0637447012514, 3901.141748815256, 3907.5897030811357, 3922.941155882664, 3964.7621142731527, 4461.345499427835, 4499.460064792181, 4501.909961800811, 4518.661100417482, 4528.298113792367, 5167.199084141964, 5331.813386531453, 5336.599755018312, 5350.732463376816, 5378.300820893259, 1378.676011137382, 1380.2822532283155, 1386.681063355434, 1388.5070799866105, 1396.190209678384, 850.753281548344, 873.8470767615642, 885.3050355470924, 891.2736120062128, 907.4237858959608, 4475.820967161342, 4606.792694328763, 4614.884627884329, 4623.583877451046, 4624.5144259852905, 5469.15228139639, 5476.726163691799, 5477.178423236467, 5490.890182196334, 5492.752826122834, 4395.362672412482, 4602.585767280961, 4619.1685496610935, 4629.328747331685, 4633.374494443275, 2904.956425653617, 2918.5184444566407, 2921.1966709155154, 2926.941461170765, 2935.7357837794275, 5032.892763592004, 5095.566876815512, 5102.515261050195, 5111.667741596784, 5147.536721695065, 5454.672719636835, 5570.991664501205, 5626.156076588462, 5656.575756818255, 5683.261176047087, 5019.84940451787, 5024.547790698854, 5079.822206222764, 5083.949160508421, 5111.948880511147, 5462.235287059735, 5482.835514934558, 5489.890202195854, 5502.9174562380795, 5519.806806761744, 5259.4477579853565, 5270.8945821084135, 5379.843333683277, 5387.0, 5410.701431656453, 5022.0, 5062.721550314768, 5075.467075956972, 5113.360829896263, 5117.641765076409, 3932.174243408916, 3944.5069366329208, 3944.706170347677, 3953.486046813896, 3955.149642826806, 5195.376554813447, 5509.696966666872, 5517.510272226396, 5528.391876893619, 5532.668039917457, 5323.920141197963, 5339.599530035185, 5380.811671591476, 5405.135178371599, 5407.72961351923, 5137.845864624067, 5373.758180881791, 5373.952079344646, 5399.4600539945695, 5412.56699464034, 5306.761195746278, 5328.60035497347, 5331.3868905076415, 5347.064263753905, 5357.78568857257, 5167.095758242368, 5247.737613119252, 5377.8117765878005, 5398.217258497417, 5407.783688652567, 5205.973970130125, 5228.895422091613, 5258.947410525846, 5267.157254839208, 5291.523762861207], "value": 3995.6051054753284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.0359164844381, 657.6908852839164, 713.750187434398, 716.8494616130612, 742.947993640445, 12811.42348594313, 13374.264415457146, 13417.194968301896, 13429.127106738055, 15002.924985375084, 14993.47522836701, 15190.696186076271, 15202.163880986542, 15222.23888805558, 15242.085474871516, 612.3662009819838, 766.2299389113932, 771.5486440432339, 792.2236208515658, 795.1293333799509, 778.7313376884994, 786.3355464632376, 789.4828887078972, 789.936805055597, 795.8567457857583, 830.5265998380895, 830.7009476588423, 836.05943313772, 836.4939211776879, 836.9832603347929, 815.4984684419039, 824.1470078468756, 829.5105887526328, 830.6760363458226, 831.9292860106868, 595.9761609535614, 600.8467840700637, 602.6474512410201, 603.0080517548652, 604.782278379783, 14475.42098316066, 14634.975551711277, 14751.0, 14782.965192436533, 14791.92604036973, 13430.395632196476, 13594.11638243511, 13745.875738878212, 13869.861301386958, 13934.163950162922, 11111.944440277828, 11236.49435775384, 11286.379249141293, 11299.604513842058, 11415.42922853854, 3338.9499157512655, 3420.7605467617277, 3444.483327500895, 3502.614712381636, 3514.2268700885766, 69035.65482172558, 69224.0, 69540.6522967387, 70213.0, 70499.2950070503, 10452.790944181073, 10540.15678745714, 10657.573697052187, 10745.14038876888, 10932.56269749217, 19646.11592478342, 19802.90098549498, 19941.302054428026, 19958.0, 19995.200191992448, 6869.072675188885, 6927.965360173167, 7144.24985376528, 7185.137783465913, 7205.423566114699, 3798.582155962842, 3804.0, 3917.882463526099, 3923.1761330120426, 3938.0154961259686, 2949.0, 3052.9236769080508, 3058.9235269118003, 3061.8162910225456, 3065.049834551296, 501.07301492239793, 504.2738456622452, 508.7583397885975, 522.3522831688679, 522.6837763153237, 445.243086752522, 454.50231995964367, 532.4010488200774, 543.1120118606108, 562.6455333140177, 7307.634618269065, 7391.8152046199275, 7570.16728159902, 7710.807229819187, 8131.14622964592, 529.9761510732027, 530.8195213627386, 532.9067413202674, 547.1683041776478, 561.166667498764, 3535.063208249816, 3553.147244661263, 3648.872289469909, 3661.2860492203763, 3768.9623103768613, 91505.0, 106209.0, 106908.0, 112873.0, 113191.86808131979, 91978.54010730037, 92495.53752231196, 93154.0, 97294.0, 97517.0, 80463.59768201239, 83424.58287708645, 83476.58261708653, 84299.15700843035, 84745.0, 7005.638441195631, 7223.313785190398, 7235.674394652148, 7391.593462359407, 7816.804579885548, 34168.0, 36494.45258321074, 41693.16613667649, 42928.57071429246, 43739.78130109329, 65174.34825651683, 66886.66556667186, 67709.3229067703, 67769.0, 68392.0, 10864.619738309122, 10963.83554246671, 11309.038731707897, 11363.48864301125, 11390.829137562778, 11156.386398748147, 11486.712832178928, 12404.069694772748, 13181.0, 13380.330983450984, 11214.495347709535, 11251.718707032389, 11498.425078745862, 11778.587749428729, 11830.0, 10903.182261330274, 11168.441577921234, 11239.66281011571, 11296.322220666787, 12549.372531373578, 10859.891401085888, 10971.451427428437, 11254.774904502028, 11383.829242561535, 11395.886041139482, 9202.953985230299, 9655.758606034906, 9701.126898579161, 10064.647737329158, 10164.24353694245, 9422.387544809566, 9482.38364506305, 9720.864342863939, 9921.65274215399, 10013.549390277309], "value": 6649.286136933411, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 106.0, 115.0, 113.0, 116.0, 115.0, 113.0, 115.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 143.0, 159.0, 181.0, 135.0, 165.0, 160.0, 133.0, 198.0, 140.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 170.0, 167.0, 160.0, 162.0, 164.0, 164.0, 160.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 167.0, 76.0, 77.0, 76.0, 76.0, 161.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 153.0, 87.0, 87.0, 88.0, 136.0, 86.0, 86.0, 137.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 119.0, 117.0, 119.0, 121.0, 119.0, 120.0, 118.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 66.0, 65.0, 67.0, 68.0, 66.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 89.0, 82.0, 89.0, 88.0, 88.0, 82.0, 103.0, 89.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 150.0, 134.0, 134.0, 132.0, 151.0, 140.0, 135.0, 133.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 180.0, 176.0, 183.0, 172.0, 173.0, 172.0, 173.0, 175.0, 172.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 72.0, 67.0, 66.0, 67.0, 68.0, 68.0, 67.0, 66.0], "value": 67.8, "unit": "score"}]}]} 10:18:57 INFO - Return code: 0 10:18:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:57 ERROR - # TBPL SUCCESS # 10:18:57 INFO - Running post-action listener: _resource_record_post_action 10:18:57 INFO - ##### 10:18:57 INFO - ##### Finished run-tests step (success) 10:18:57 INFO - ##### 10:18:57 INFO - Running post-run listener: _resource_record_post_run 10:18:57 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 544350208; Read time: 340; Write time: 431648 10:18:57 INFO - TinderboxPrint: CPU usage
13.4% 10:18:57 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 340 10:18:57 INFO - TinderboxPrint: I/O write bytes / time
544,350,208 / 431,648 10:18:57 INFO - TinderboxPrint: CPU idle
8,271.5 (86.5%) 10:18:57 INFO - TinderboxPrint: CPU user
1,231.3 (12.9%) 10:18:57 INFO - TinderboxPrint: Swap in / out
0 / 0 10:18:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 255959040; Read time: 140; Write time: 250292 10:18:57 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288391168; Read time: 200; Write time: 181356 10:18:58 INFO - Running post-run listener: _upload_blobber_files 10:18:58 INFO - Blob upload gear active. 10:18:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:58 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 10:18:58 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'] 10:18:58 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 10:18:58 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:19:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:02 INFO - (blobuploader) - INFO - Done attempting. 10:19:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:19:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:19:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:03 INFO - (blobuploader) - INFO - Done attempting. 10:19:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:19:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:04 INFO - (blobuploader) - INFO - Done attempting. 10:19:04 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:04 INFO - Return code: 0 10:19:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bb4c27c6feb45c073c32fa8aa17070c44c01047a99ae17a1a187421cb25025a3bb8c6218928dfb623187fca40de6bd0cd9ac04b1e65845b4b9c1aa880c3682a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c93642e40a7985a1bf3cf9a6f4e9f423e29fcc654919b0be09cfa2835b4e8e13102f801ec34903ca65b11cc05fcffe185e90ac2369e056e76c7079463e28efa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8260a1f82eb9fd805b69d224b342aafc99f4342f936aeea8eb9c8070494bd9b62fc2da4d7c9516908ebff2e65d0c7769f16044968e8d91292cd74de00d62056"} 10:19:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:04 INFO - Contents: 10:19:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bb4c27c6feb45c073c32fa8aa17070c44c01047a99ae17a1a187421cb25025a3bb8c6218928dfb623187fca40de6bd0cd9ac04b1e65845b4b9c1aa880c3682a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c93642e40a7985a1bf3cf9a6f4e9f423e29fcc654919b0be09cfa2835b4e8e13102f801ec34903ca65b11cc05fcffe185e90ac2369e056e76c7079463e28efa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8260a1f82eb9fd805b69d224b342aafc99f4342f936aeea8eb9c8070494bd9b62fc2da4d7c9516908ebff2e65d0c7769f16044968e8d91292cd74de00d62056"} 10:19:04 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:04 INFO - Copying logs to upload dir... 10:19:04 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.447148 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-24 10:19:04.732122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 10:19:04.735782) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bb4c27c6feb45c073c32fa8aa17070c44c01047a99ae17a1a187421cb25025a3bb8c6218928dfb623187fca40de6bd0cd9ac04b1e65845b4b9c1aa880c3682a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c93642e40a7985a1bf3cf9a6f4e9f423e29fcc654919b0be09cfa2835b4e8e13102f801ec34903ca65b11cc05fcffe185e90ac2369e056e76c7079463e28efa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8260a1f82eb9fd805b69d224b342aafc99f4342f936aeea8eb9c8070494bd9b62fc2da4d7c9516908ebff2e65d0c7769f16044968e8d91292cd74de00d62056"} build_url:https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/PghJu3WwS6Gd9iLiFGzDeA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bb4c27c6feb45c073c32fa8aa17070c44c01047a99ae17a1a187421cb25025a3bb8c6218928dfb623187fca40de6bd0cd9ac04b1e65845b4b9c1aa880c3682a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c93642e40a7985a1bf3cf9a6f4e9f423e29fcc654919b0be09cfa2835b4e8e13102f801ec34903ca65b11cc05fcffe185e90ac2369e056e76c7079463e28efa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8260a1f82eb9fd805b69d224b342aafc99f4342f936aeea8eb9c8070494bd9b62fc2da4d7c9516908ebff2e65d0c7769f16044968e8d91292cd74de00d62056"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 10:19:04.762544) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:19:04.762972) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466787499.406592-447289544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004645 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:19:04.852118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 10:19:04.852914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 10:19:04.853730) ========= ========= Total master_lag: 0.18 =========