builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1466600307.66 results: success (0) buildid: 20160622044704 builduid: 9eaf16374cb246a595ab1bcbe80722f5 revision: b7abc00e62564335865a87b97c7c24b60402dcb3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:27.662355) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:27.663253) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:27.663577) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:27.749575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:27.749870) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 05:58:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-06-22 05:58:28 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107152 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:27.905961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:27.906290) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018919 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:27.958973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:27.962390) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b7abc00e62564335865a87b97c7c24b60402dcb3 --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 b7abc00e62564335865a87b97c7c24b60402dcb3 --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=a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 05:58:28,831 truncating revision to first 12 chars 2016-06-22 05:58:28,831 Setting DEBUG logging. 2016-06-22 05:58:28,831 attempt 1/10 2016-06-22 05:58:28,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b7abc00e6256?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 05:58:29,128 unpacking tar archive at: fx-team-b7abc00e6256/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636716 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:28.615631) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:28.616217) ========= script_repo_revision: b7abc00e62564335865a87b97c7c24b60402dcb3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:28.616802) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:28.617192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:58:28.628772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-22 05:58:28.629113) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:29 INFO - MultiFileLogger online at 20160622 05:58:29 in /builds/slave/test 05:58:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:58:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:29 INFO - {'append_to_log': False, 05:58:29 INFO - 'base_work_dir': '/builds/slave/test', 05:58:29 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:58:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:29 INFO - 'branch': 'Fx-Team-Non-PGO', 05:58:29 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:29 INFO - 'config_files': ('talos/linux_config.py',), 05:58:29 INFO - 'default_actions': ('clobber', 05:58:29 INFO - 'read-buildbot-config', 05:58:29 INFO - 'download-and-extract', 05:58:29 INFO - 'populate-webroot', 05:58:29 INFO - 'create-virtualenv', 05:58:29 INFO - 'install', 05:58:29 INFO - 'run-tests'), 05:58:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:29 INFO - 'download_minidump_stackwalk': True, 05:58:29 INFO - 'download_symbols': 'ondemand', 05:58:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:29 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:29 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:29 INFO - 'installer_path': 'installer.exe', 05:58:29 INFO - 'log_level': 'info', 05:58:29 INFO - 'log_name': 'talos', 05:58:29 INFO - 'log_to_console': True, 05:58:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:29 INFO - 'opt_config_files': (), 05:58:29 INFO - 'pip_index': False, 05:58:29 INFO - 'sps_profile': False, 05:58:29 INFO - 'sps_profile_interval': 0, 05:58:29 INFO - 'suite': 'dromaeojs', 05:58:29 INFO - 'system_bits': '32', 05:58:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:29 INFO - 'title': 'talos-linux64-ix-002', 05:58:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:29 INFO - 'use_talos_json': True, 05:58:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:29 INFO - 'work_dir': 'build'} 05:58:29 INFO - ##### 05:58:29 INFO - ##### Running clobber step. 05:58:29 INFO - ##### 05:58:29 INFO - Running pre-action listener: _resource_record_pre_action 05:58:29 INFO - Running main action method: clobber 05:58:29 INFO - rmtree: /builds/slave/test/build 05:58:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:30 INFO - Running post-action listener: _resource_record_post_action 05:58:30 INFO - ##### 05:58:30 INFO - ##### Finished clobber step (success) 05:58:30 INFO - ##### 05:58:30 INFO - ##### 05:58:30 INFO - ##### Running read-buildbot-config step. 05:58:30 INFO - ##### 05:58:30 INFO - Running pre-action listener: _resource_record_pre_action 05:58:30 INFO - Running main action method: read_buildbot_config 05:58:30 INFO - Using buildbot properties: 05:58:30 INFO - { 05:58:30 INFO - "project": "", 05:58:30 INFO - "product": "firefox", 05:58:30 INFO - "script_repo_revision": "production", 05:58:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:58:30 INFO - "repository": "", 05:58:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:58:30 INFO - "buildid": "20160622044704", 05:58:30 INFO - "pgo_build": "False", 05:58:30 INFO - "basedir": "/builds/slave/test", 05:58:30 INFO - "buildnumber": 3101, 05:58:30 INFO - "slavename": "talos-linux64-ix-002", 05:58:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:58:30 INFO - "platform": "ubuntu64_hw", 05:58:30 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:58:30 INFO - "branch": "fx-team", 05:58:30 INFO - "repo_path": "integration/fx-team", 05:58:30 INFO - "revision": "b7abc00e62564335865a87b97c7c24b60402dcb3", 05:58:30 INFO - "stage_platform": "linux64", 05:58:30 INFO - "builduid": "9eaf16374cb246a595ab1bcbe80722f5", 05:58:30 INFO - "slavebuilddir": "test" 05:58:30 INFO - } 05:58:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:58:30 INFO - Running post-action listener: _resource_record_post_action 05:58:30 INFO - ##### 05:58:30 INFO - ##### Finished read-buildbot-config step (success) 05:58:30 INFO - ##### 05:58:30 INFO - ##### 05:58:30 INFO - ##### Running download-and-extract step. 05:58:30 INFO - ##### 05:58:30 INFO - Running pre-action listener: _resource_record_pre_action 05:58:30 INFO - Running main action method: download_and_extract 05:58:30 INFO - mkdir: /builds/slave/test/build/tests 05: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')]} 05:58:30 INFO - https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:33 INFO - Downloaded 1361 bytes. 05:58:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:58:33 INFO - Using the following test package requirements: 05:58:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:58:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:33 INFO - u'jsshell-linux-x86_64.zip'], 05:58:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:58:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:58:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:33 INFO - https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:34 INFO - Downloaded 22703251 bytes. 05:58:34 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'] 05:58:34 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 05:58:36 INFO - Return code: 0 05:58:36 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 05: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')]} 05:58:36 INFO - https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:37 INFO - Downloaded 22703251 bytes. 05:58:37 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'] 05:58:37 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 05:58:39 INFO - Return code: 0 05:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:39 INFO - https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:58:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:40 INFO - Downloaded 14405384 bytes. 05:58:40 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'] 05:58:40 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 05:58:40 INFO - Return code: 0 05:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:40 INFO - https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDEEvldwTe2Lu5e4NmqqZw/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 05:58:42 INFO - Downloaded 56269320 bytes. 05:58:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:58:42 INFO - mkdir: /builds/slave/test/properties 05:58:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:42 INFO - Contents: 05:58:42 INFO - build_url:https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:58:43 INFO - Running post-action listener: _resource_record_post_action 05:58:43 INFO - Running post-action listener: set_extra_try_arguments 05:58:43 INFO - ##### 05:58:43 INFO - ##### Finished download-and-extract step (success) 05:58:43 INFO - ##### 05:58:43 INFO - ##### 05:58:43 INFO - ##### Running populate-webroot step. 05:58:43 INFO - ##### 05:58:43 INFO - Running pre-action listener: _resource_record_pre_action 05:58:43 INFO - Running main action method: populate_webroot 05:58:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:43 INFO - '--tppagecycles', 05:58:43 INFO - '7'], 05:58:43 INFO - 'tests': ['tsvgm']}}, 05:58:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:43 INFO - 'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:43 INFO - 'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['damp', 'tps']}, 05:58:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:43 INFO - 'tests': ['damp', 'tps']}, 05:58:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['dromaeo_dom']}, 05:58:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['basic_compositor_video']}, 05:58:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:58:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['a11yr', 05:58:43 INFO - 'ts_paint', 05:58:43 INFO - 'tpaint', 05:58:43 INFO - 'sessionrestore', 05:58:43 INFO - 'sessionrestore_no_auto_restore', 05:58:43 INFO - 'tabpaint']}, 05:58:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:43 INFO - 'ts_paint', 05:58:43 INFO - 'tpaint', 05:58:43 INFO - 'sessionrestore', 05:58:43 INFO - 'sessionrestore_no_auto_restore', 05:58:43 INFO - 'tabpaint']}, 05:58:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:43 INFO - 'ts_paint', 05:58:43 INFO - 'tpaint', 05:58:43 INFO - 'sessionrestore', 05:58:43 INFO - 'sessionrestore_no_auto_restore', 05:58:43 INFO - 'tabpaint']}, 05:58:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:43 INFO - 'ts_paint', 05:58:43 INFO - 'tpaint', 05:58:43 INFO - 'sessionrestore', 05:58:43 INFO - 'sessionrestore_no_auto_restore', 05:58:43 INFO - 'tabpaint']}, 05:58:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['a11yr', 05:58:43 INFO - 'ts_paint', 05:58:43 INFO - 'tpaint', 05:58:43 INFO - 'sessionrestore', 05:58:43 INFO - 'sessionrestore_no_auto_restore', 05:58:43 INFO - 'tabpaint']}, 05:58:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['a11yr', 05:58:43 INFO - 'ts_paint', 05:58:43 INFO - 'tpaint', 05:58:43 INFO - 'sessionrestore', 05:58:43 INFO - 'sessionrestore_no_auto_restore', 05:58:43 INFO - 'tabpaint']}, 05:58:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['tsvgx', 05:58:43 INFO - 'tsvgr_opacity', 05:58:43 INFO - 'tart', 05:58:43 INFO - 'tscrollx', 05:58:43 INFO - 'cart']}, 05:58:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:43 INFO - 'tsvgr_opacity', 05:58:43 INFO - 'tart', 05:58:43 INFO - 'tscrollx', 05:58:43 INFO - 'cart']}, 05:58:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:43 INFO - 'talos_options': ['--disable-e10s'], 05:58:43 INFO - 'tests': ['tp5o']}, 05:58:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:43 INFO - 'tests': ['tp5o']}, 05:58:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:43 INFO - 'talos_options': ['--disable-e10s', 05:58:43 INFO - '--xperf_path', 05:58:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:43 INFO - 'tests': ['tp5n']}, 05:58:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:43 INFO - 'talos_options': ['--xperf_path', 05:58:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:43 INFO - 'tests': ['tp5n']}}, 05:58:43 INFO - 'talos.zip': {'path': '', 05:58:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:43 INFO - Running post-action listener: _resource_record_post_action 05:58:43 INFO - ##### 05:58:43 INFO - ##### Finished populate-webroot step (success) 05:58:43 INFO - ##### 05:58:43 INFO - ##### 05:58:43 INFO - ##### Running create-virtualenv step. 05:58:43 INFO - ##### 05:58:43 INFO - Running pre-action listener: _resource_record_pre_action 05:58:43 INFO - Running main action method: create_virtualenv 05:58:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:58:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:43 INFO - Using real prefix '/usr' 05:58:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:45 INFO - Installing pip.................done. 05:58:45 INFO - Return code: 0 05:58:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:45 INFO - Using env: {'DISPLAY': ':0', 05:58:45 INFO - 'HOME': '/home/cltbld', 05:58:45 INFO - 'LANG': 'en_US.UTF-8', 05:58:45 INFO - 'LANGUAGE': 'en_US:en', 05:58:45 INFO - 'LOGNAME': 'cltbld', 05:58:45 INFO - 'MAIL': '/var/mail/cltbld', 05:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:45 INFO - 'MOZ_NO_REMOTE': '1', 05:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:45 INFO - 'NO_EM_RESTART': '1', 05:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:45 INFO - 'PWD': '/builds/slave/test', 05:58:45 INFO - 'SHELL': '/bin/bash', 05:58:45 INFO - 'SHLVL': '1', 05:58:45 INFO - 'TERM': 'linux', 05:58:45 INFO - 'TMOUT': '86400', 05:58:45 INFO - 'USER': 'cltbld', 05:58:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:45 INFO - '_': '/tools/buildbot/bin/python'} 05:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:58:46 INFO - Cleaning up... 05:58:46 INFO - Return code: 0 05:58:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:46 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 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:58:46 INFO - Using env: {'DISPLAY': ':0', 05:58:46 INFO - 'HOME': '/home/cltbld', 05:58:46 INFO - 'LANG': 'en_US.UTF-8', 05:58:46 INFO - 'LANGUAGE': 'en_US:en', 05:58:46 INFO - 'LOGNAME': 'cltbld', 05:58:46 INFO - 'MAIL': '/var/mail/cltbld', 05:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:46 INFO - 'MOZ_NO_REMOTE': '1', 05:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:46 INFO - 'NO_EM_RESTART': '1', 05:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:46 INFO - 'PWD': '/builds/slave/test', 05:58:46 INFO - 'SHELL': '/bin/bash', 05:58:46 INFO - 'SHLVL': '1', 05:58:46 INFO - 'TERM': 'linux', 05:58:46 INFO - 'TMOUT': '86400', 05:58:46 INFO - 'USER': 'cltbld', 05:58:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:46 INFO - '_': '/tools/buildbot/bin/python'} 05:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:46 INFO - Downloading/unpacking psutil>=3.1.1 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:48 INFO - Installing collected packages: psutil 05:58:48 INFO - Running setup.py install for psutil 05:58:48 INFO - building 'psutil._psutil_linux' extension 05:58:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:58:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:58:48 INFO - building 'psutil._psutil_posix' extension 05:58:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:58:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:58:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:48 INFO - Successfully installed psutil 05:58:48 INFO - Cleaning up... 05:58:48 INFO - Return code: 0 05:58:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:48 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 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:58:48 INFO - Using env: {'DISPLAY': ':0', 05:58:48 INFO - 'HOME': '/home/cltbld', 05:58:48 INFO - 'LANG': 'en_US.UTF-8', 05:58:48 INFO - 'LANGUAGE': 'en_US:en', 05:58:48 INFO - 'LOGNAME': 'cltbld', 05:58:48 INFO - 'MAIL': '/var/mail/cltbld', 05:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:48 INFO - 'MOZ_NO_REMOTE': '1', 05:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:48 INFO - 'NO_EM_RESTART': '1', 05:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:48 INFO - 'PWD': '/builds/slave/test', 05:58:48 INFO - 'SHELL': '/bin/bash', 05:58:48 INFO - 'SHLVL': '1', 05:58:48 INFO - 'TERM': 'linux', 05:58:48 INFO - 'TMOUT': '86400', 05:58:48 INFO - 'USER': 'cltbld', 05:58:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:48 INFO - '_': '/tools/buildbot/bin/python'} 05:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:50 INFO - Installing collected packages: mozsystemmonitor 05:58:50 INFO - Running setup.py install for mozsystemmonitor 05:58:51 INFO - Successfully installed mozsystemmonitor 05:58:51 INFO - Cleaning up... 05:58:51 INFO - Return code: 0 05:58:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 05:58:51 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 05:58:51 INFO - Using env: {'DISPLAY': ':0', 05:58:51 INFO - 'HOME': '/home/cltbld', 05:58:51 INFO - 'LANG': 'en_US.UTF-8', 05:58:51 INFO - 'LANGUAGE': 'en_US:en', 05:58:51 INFO - 'LOGNAME': 'cltbld', 05:58:51 INFO - 'MAIL': '/var/mail/cltbld', 05:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:51 INFO - 'MOZ_NO_REMOTE': '1', 05:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:51 INFO - 'NO_EM_RESTART': '1', 05:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:51 INFO - 'PWD': '/builds/slave/test', 05:58:51 INFO - 'SHELL': '/bin/bash', 05:58:51 INFO - 'SHLVL': '1', 05:58:51 INFO - 'TERM': 'linux', 05:58:51 INFO - 'TMOUT': '86400', 05:58:51 INFO - 'USER': 'cltbld', 05:58:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:51 INFO - '_': '/tools/buildbot/bin/python'} 05:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:51 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:53 INFO - warning: no files found matching '*.txt' 05:58:53 INFO - no previously-included directories found matching 'build' 05:58:53 INFO - no previously-included directories found matching 'dist' 05:58:53 INFO - no previously-included directories found matching '.git*' 05:58:53 INFO - Installing collected packages: jsonschema, functools32 05:58:53 INFO - Running setup.py install for functools32 05:58:53 INFO - warning: no files found matching '*.txt' 05:58:53 INFO - no previously-included directories found matching 'build' 05:58:53 INFO - no previously-included directories found matching 'dist' 05:58:53 INFO - no previously-included directories found matching '.git*' 05:58:53 INFO - Successfully installed jsonschema functools32 05:58:53 INFO - Cleaning up... 05:58:53 INFO - Return code: 0 05:58:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:53 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 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:58:53 INFO - Using env: {'DISPLAY': ':0', 05:58:53 INFO - 'HOME': '/home/cltbld', 05:58:53 INFO - 'LANG': 'en_US.UTF-8', 05:58:53 INFO - 'LANGUAGE': 'en_US:en', 05:58:53 INFO - 'LOGNAME': 'cltbld', 05:58:53 INFO - 'MAIL': '/var/mail/cltbld', 05:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:53 INFO - 'MOZ_NO_REMOTE': '1', 05:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:53 INFO - 'NO_EM_RESTART': '1', 05:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:53 INFO - 'PWD': '/builds/slave/test', 05:58:53 INFO - 'SHELL': '/bin/bash', 05:58:53 INFO - 'SHLVL': '1', 05:58:53 INFO - 'TERM': 'linux', 05:58:53 INFO - 'TMOUT': '86400', 05:58:53 INFO - 'USER': 'cltbld', 05:58:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:53 INFO - '_': '/tools/buildbot/bin/python'} 05:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:56 INFO - Downloading docopt-0.6.1.tar.gz 05:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:56 INFO - Running setup.py install for blobuploader 05:58:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:56 INFO - Running setup.py install for requests 05:58:57 INFO - Running setup.py install for docopt 05:58:57 INFO - Successfully installed blobuploader requests docopt 05:58:57 INFO - Cleaning up... 05:58:57 INFO - Return code: 0 05:58:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:57 INFO - Using env: {'DISPLAY': ':0', 05:58:57 INFO - 'HOME': '/home/cltbld', 05:58:57 INFO - 'LANG': 'en_US.UTF-8', 05:58:57 INFO - 'LANGUAGE': 'en_US:en', 05:58:57 INFO - 'LOGNAME': 'cltbld', 05:58:57 INFO - 'MAIL': '/var/mail/cltbld', 05:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:57 INFO - 'MOZ_NO_REMOTE': '1', 05:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:57 INFO - 'NO_EM_RESTART': '1', 05:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:57 INFO - 'PWD': '/builds/slave/test', 05:58:57 INFO - 'SHELL': '/bin/bash', 05:58:57 INFO - 'SHLVL': '1', 05:58:57 INFO - 'TERM': 'linux', 05:58:57 INFO - 'TMOUT': '86400', 05:58:57 INFO - 'USER': 'cltbld', 05:58:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:57 INFO - '_': '/tools/buildbot/bin/python'} 05:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:57 INFO - Running setup.py (path:/tmp/pip-xaBxQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:57 INFO - Running setup.py (path:/tmp/pip-mV7F2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:57 INFO - Running setup.py (path:/tmp/pip-p53Ecy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:57 INFO - Running setup.py (path:/tmp/pip-Awtgxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:57 INFO - Running setup.py (path:/tmp/pip-PXUshK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:57 INFO - Running setup.py (path:/tmp/pip-M6OkgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:57 INFO - Running setup.py (path:/tmp/pip-hp8LbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:58 INFO - Running setup.py (path:/tmp/pip-CCqnJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:58 INFO - Running setup.py (path:/tmp/pip-sI9Zpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:58 INFO - Running setup.py (path:/tmp/pip-WVk0hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:58 INFO - Running setup.py (path:/tmp/pip-QYGd3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:58 INFO - Running setup.py (path:/tmp/pip-sgkXj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:58 INFO - Running setup.py (path:/tmp/pip-NHqPIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:58 INFO - Running setup.py (path:/tmp/pip-w31g98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:58 INFO - Running setup.py (path:/tmp/pip-uY9Dj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:58 INFO - Running setup.py (path:/tmp/pip-ZphYrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:58 INFO - Running setup.py (path:/tmp/pip-PVqKzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:58 INFO - Running setup.py install for manifestparser 05:58:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:58 INFO - Running setup.py install for mozcrash 05:58:58 INFO - Running setup.py install for mozdebug 05:58:59 INFO - Running setup.py install for mozdevice 05:58:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for mozfile 05:58:59 INFO - Running setup.py install for mozhttpd 05:58:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for mozinfo 05:58:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for mozInstall 05:58:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for mozleak 05:58:59 INFO - Running setup.py install for mozlog 05:58:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for moznetwork 05:58:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for mozprocess 05:58:59 INFO - Running setup.py install for mozprofile 05:59:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:00 INFO - Running setup.py install for mozrunner 05:59:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:00 INFO - Running setup.py install for mozscreenshot 05:59:00 INFO - Running setup.py install for moztest 05:59:00 INFO - Running setup.py install for mozversion 05:59:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:00 INFO - Cleaning up... 05:59:00 INFO - Return code: 0 05:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:00 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 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:00 INFO - Using env: {'DISPLAY': ':0', 05:59:00 INFO - 'HOME': '/home/cltbld', 05:59:00 INFO - 'LANG': 'en_US.UTF-8', 05:59:00 INFO - 'LANGUAGE': 'en_US:en', 05:59:00 INFO - 'LOGNAME': 'cltbld', 05:59:00 INFO - 'MAIL': '/var/mail/cltbld', 05:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:00 INFO - 'MOZ_NO_REMOTE': '1', 05:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:00 INFO - 'NO_EM_RESTART': '1', 05:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:00 INFO - 'PWD': '/builds/slave/test', 05:59:00 INFO - 'SHELL': '/bin/bash', 05:59:00 INFO - 'SHLVL': '1', 05:59:00 INFO - 'TERM': 'linux', 05:59:00 INFO - 'TMOUT': '86400', 05:59:00 INFO - 'USER': 'cltbld', 05:59:00 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:00 INFO - '_': '/tools/buildbot/bin/python'} 05:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:00 INFO - Running setup.py (path:/tmp/pip-JlD8pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:00 INFO - Running setup.py (path:/tmp/pip-UdqrWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:00 INFO - Running setup.py (path:/tmp/pip-6MiZJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:00 INFO - Running setup.py (path:/tmp/pip-a7OJjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:01 INFO - Running setup.py (path:/tmp/pip-6Lahuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:01 INFO - Running setup.py (path:/tmp/pip-VOpOkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:01 INFO - Running setup.py (path:/tmp/pip-9qEOrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:01 INFO - Running setup.py (path:/tmp/pip-Hxq6H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:01 INFO - Running setup.py (path:/tmp/pip-fZWLL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:01 INFO - Running setup.py (path:/tmp/pip-45baXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:01 INFO - Running setup.py (path:/tmp/pip-a31gMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:01 INFO - Running setup.py (path:/tmp/pip-ht5etM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:01 INFO - Running setup.py (path:/tmp/pip-SgewcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:01 INFO - Running setup.py (path:/tmp/pip-W2fbsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:01 INFO - Running setup.py (path:/tmp/pip-I1henv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:01 INFO - Running setup.py (path:/tmp/pip-PXeNGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:01 INFO - Running setup.py (path:/tmp/pip-jCfQOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:03 INFO - Downloading blessings-1.6.tar.gz 05:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:03 INFO - Installing collected packages: blessings 05:59:03 INFO - Running setup.py install for blessings 05:59:04 INFO - Successfully installed blessings 05:59:04 INFO - Cleaning up... 05:59:04 INFO - Return code: 0 05:59:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:04 INFO - Reading from file tmpfile_stdout 05:59:04 INFO - Current package versions: 05:59:04 INFO - argparse == 1.2.1 05:59:04 INFO - blessings == 1.6 05:59:04 INFO - blobuploader == 1.2.4 05:59:04 INFO - docopt == 0.6.1 05:59:04 INFO - functools32 == 3.2.3-2 05:59:04 INFO - jsonschema == 2.5.1 05:59:04 INFO - manifestparser == 1.1 05:59:04 INFO - mozInstall == 1.12 05:59:04 INFO - mozcrash == 0.17 05:59:04 INFO - mozdebug == 0.1 05:59:04 INFO - mozdevice == 0.48 05:59:04 INFO - mozfile == 1.2 05:59:04 INFO - mozhttpd == 0.7 05:59:04 INFO - mozinfo == 0.9 05:59:04 INFO - mozleak == 0.1 05:59:04 INFO - mozlog == 3.2 05:59:04 INFO - moznetwork == 0.27 05:59:04 INFO - mozprocess == 0.22 05:59:04 INFO - mozprofile == 0.28 05:59:04 INFO - mozrunner == 6.11 05:59:04 INFO - mozscreenshot == 0.1 05:59:04 INFO - mozsystemmonitor == 0.3 05:59:04 INFO - moztest == 0.7 05:59:04 INFO - mozversion == 1.4 05:59:04 INFO - psutil == 3.1.1 05:59:04 INFO - requests == 1.2.3 05:59:04 INFO - wsgiref == 0.1.2 05:59:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 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 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:04 INFO - Using env: {'DISPLAY': ':0', 05:59:04 INFO - 'HOME': '/home/cltbld', 05:59:04 INFO - 'LANG': 'en_US.UTF-8', 05:59:04 INFO - 'LANGUAGE': 'en_US:en', 05:59:04 INFO - 'LOGNAME': 'cltbld', 05:59:04 INFO - 'MAIL': '/var/mail/cltbld', 05:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:04 INFO - 'MOZ_NO_REMOTE': '1', 05:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:04 INFO - 'NO_EM_RESTART': '1', 05:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:04 INFO - 'PWD': '/builds/slave/test', 05:59:04 INFO - 'SHELL': '/bin/bash', 05:59:04 INFO - 'SHLVL': '1', 05:59:04 INFO - 'TERM': 'linux', 05:59:04 INFO - 'TMOUT': '86400', 05:59:04 INFO - 'USER': 'cltbld', 05:59:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:04 INFO - '_': '/tools/buildbot/bin/python'} 05:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:04 INFO - Cleaning up... 05:59:04 INFO - Return code: 0 05:59:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 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 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:59:04 INFO - Using env: {'DISPLAY': ':0', 05:59:04 INFO - 'HOME': '/home/cltbld', 05:59:04 INFO - 'LANG': 'en_US.UTF-8', 05:59:04 INFO - 'LANGUAGE': 'en_US:en', 05:59:04 INFO - 'LOGNAME': 'cltbld', 05:59:04 INFO - 'MAIL': '/var/mail/cltbld', 05:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:04 INFO - 'MOZ_NO_REMOTE': '1', 05:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:04 INFO - 'NO_EM_RESTART': '1', 05:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:04 INFO - 'PWD': '/builds/slave/test', 05:59:04 INFO - 'SHELL': '/bin/bash', 05:59:04 INFO - 'SHLVL': '1', 05:59:04 INFO - 'TERM': 'linux', 05:59:04 INFO - 'TMOUT': '86400', 05:59:04 INFO - 'USER': 'cltbld', 05:59:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:04 INFO - '_': '/tools/buildbot/bin/python'} 05:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:59:04 INFO - Cleaning up... 05:59:04 INFO - Return code: 0 05:59:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 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 0x7fad73a20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1786350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:59:04 INFO - Using env: {'DISPLAY': ':0', 05:59:04 INFO - 'HOME': '/home/cltbld', 05:59:04 INFO - 'LANG': 'en_US.UTF-8', 05:59:04 INFO - 'LANGUAGE': 'en_US:en', 05:59:04 INFO - 'LOGNAME': 'cltbld', 05:59:04 INFO - 'MAIL': '/var/mail/cltbld', 05:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:04 INFO - 'MOZ_NO_REMOTE': '1', 05:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:04 INFO - 'NO_EM_RESTART': '1', 05:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:04 INFO - 'PWD': '/builds/slave/test', 05:59:04 INFO - 'SHELL': '/bin/bash', 05:59:04 INFO - 'SHLVL': '1', 05:59:04 INFO - 'TERM': 'linux', 05:59:04 INFO - 'TMOUT': '86400', 05:59:04 INFO - 'USER': 'cltbld', 05:59:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:04 INFO - '_': '/tools/buildbot/bin/python'} 05:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:05 INFO - Downloading/unpacking flake8 05:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:59:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:59:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:59:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:07 INFO - no previously-included directories found matching 'docs/_build' 05:59:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:59:07 INFO - Running setup.py install for pep8 05:59:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:07 INFO - no previously-included directories found matching 'docs/_build' 05:59:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:59:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:59:07 INFO - Cleaning up... 05:59:07 INFO - Return code: 0 05:59:07 INFO - Running post-action listener: _resource_record_post_action 05:59:07 INFO - Running post-action listener: _start_resource_monitoring 05:59:07 INFO - Starting resource monitoring. 05:59:07 INFO - ##### 05:59:07 INFO - ##### Finished create-virtualenv step (success) 05:59:07 INFO - ##### 05:59:07 INFO - ##### 05:59:07 INFO - ##### Running install step. 05:59:07 INFO - ##### 05:59:07 INFO - Running pre-action listener: _resource_record_pre_action 05:59:07 INFO - Running main action method: install 05:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:08 INFO - Reading from file tmpfile_stdout 05:59:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:08 INFO - Reading from file tmpfile_stdout 05:59:08 INFO - Output received: 05:59:08 INFO - Usage: mozinstall [options] installer 05:59:08 INFO - Options: 05:59:08 INFO - -h, --help show this help message and exit 05:59:08 INFO - -d DEST, --destination=DEST 05:59:08 INFO - Directory to install application into. [default: 05:59:08 INFO - "/builds/slave/test"] 05:59:08 INFO - --app=APP Application being installed. [default: firefox] 05:59:08 INFO - mkdir: /builds/slave/test/build/application 05:59:08 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'] 05:59:08 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 05:59:24 INFO - Reading from file tmpfile_stdout 05:59:24 INFO - Output received: 05:59:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:24 INFO - Running post-action listener: _resource_record_post_action 05:59:24 INFO - ##### 05:59:24 INFO - ##### Finished install step (success) 05:59:24 INFO - ##### 05:59:24 INFO - ##### 05:59:24 INFO - ##### Running run-tests step. 05:59:24 INFO - ##### 05:59:24 INFO - Running pre-action listener: _resource_record_pre_action 05:59:24 INFO - Running main action method: run_tests 05:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:24 INFO - Python 2.7.3 05:59:24 INFO - Return code: 0 05:59:24 INFO - grabbing minidump binary from tooltool 05:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:24 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 0x18151c0>, '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 0x18160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:59:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:59:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:59:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:24 INFO - Return code: 0 05:59:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:59:25 INFO - Return code: 0 05:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:59:25 INFO - Using env: {'DISPLAY': ':0', 05:59:25 INFO - 'HOME': '/home/cltbld', 05:59:25 INFO - 'LANG': 'en_US.UTF-8', 05:59:25 INFO - 'LANGUAGE': 'en_US:en', 05:59:25 INFO - 'LOGNAME': 'cltbld', 05:59:25 INFO - 'MAIL': '/var/mail/cltbld', 05:59:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:25 INFO - 'MOZ_NO_REMOTE': '1', 05:59:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:25 INFO - 'NO_EM_RESTART': '1', 05:59:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:25 INFO - 'PWD': '/builds/slave/test', 05:59:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:25 INFO - 'SHELL': '/bin/bash', 05:59:25 INFO - 'SHLVL': '1', 05:59:25 INFO - 'TERM': 'linux', 05:59:25 INFO - 'TMOUT': '86400', 05:59:25 INFO - 'USER': 'cltbld', 05:59:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310', 05:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:25 INFO - '_': '/tools/buildbot/bin/python'} 05:59:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:59:25 INFO - mozversion application_buildid: 20160622044704 05:59:25 INFO - mozversion application_changeset: b7abc00e62564335865a87b97c7c24b60402dcb3 05:59:25 INFO - mozversion application_display_name: Nightly 05:59:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:25 INFO - mozversion application_name: Firefox 05:59:25 INFO - mozversion application_remotingname: firefox 05:59:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:59:25 INFO - mozversion application_vendor: Mozilla 05:59:25 INFO - mozversion application_version: 50.0a1 05:59:25 INFO - mozversion platform_buildid: 20160622044704 05:59:25 INFO - mozversion platform_changeset: b7abc00e62564335865a87b97c7c24b60402dcb3 05:59:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:59:25 INFO - mozversion platform_version: 50.0a1 05:59:25 INFO - using testdate: 1466600365 05:59:25 INFO - actual date: 1466600365 05:59:25 INFO - starting webserver on 'localhost:49706' 05:59:25 INFO - SUITE-START | Running 2 tests 05:59:25 INFO - TEST-START | dromaeo_css 05:59:25 INFO - operating with platform_type : linux_ 05:59:25 INFO - Initialising browser for dromaeo_css test... 05:59:25 INFO - TEST-INFO | started process 24272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNZcvm/profile http://localhost:49706/getInfo.html) 05:59:30 INFO - PROCESS | 24272 | __metrics Screen width/height:1600/1200 05:59:30 INFO - PROCESS | 24272 | colorDepth:24 05:59:30 INFO - PROCESS | 24272 | Browser inner width/height: 1024/697 05:59:30 INFO - PROCESS | 24272 | __metrics 05:59:31 INFO - PROCESS | 24272 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:32 INFO - TEST-INFO | 24272: exit 0 05:59:32 INFO - Browser initialized. 05:59:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:32 INFO - TEST-INFO | started process 24351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNZcvm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:44 INFO - PROCESS | 24351 | RSS: Main: 175771648 05:59:44 INFO - PROCESS | 24351 | 06:00:35 INFO - PROCESS | 24351 | 1466600435233 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:02:48 INFO - PROCESS | 24351 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49706/tests/dromaeo/cssquery-ext.html) 06:02:49 INFO - PROCESS | 24351 | RSS: Main: 290078720 06:02:49 INFO - PROCESS | 24351 | 06:05:52 INFO - PROCESS | 24351 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-ext.html (next: http://localhost:49706/tests/dromaeo/cssquery-jquery.html) 06:05:52 INFO - PROCESS | 24351 | RSS: Main: 264056832 06:05:52 INFO - PROCESS | 24351 | 06:08:55 INFO - PROCESS | 24351 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49706/tests/dromaeo/cssquery-mootools.html) 06:08:55 INFO - PROCESS | 24351 | RSS: Main: 256139264 06:08:55 INFO - PROCESS | 24351 | 06:11:57 INFO - PROCESS | 24351 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49706/tests/dromaeo/cssquery-prototype.html) 06:11:58 INFO - PROCESS | 24351 | RSS: Main: 255631360 06:11:58 INFO - PROCESS | 24351 | 06:15:01 INFO - PROCESS | 24351 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49706/tests/dromaeo/cssquery-yui.html) 06:15:02 INFO - PROCESS | 24351 | RSS: Main: 240455680 06:15:02 INFO - PROCESS | 24351 | 06:18:04 INFO - PROCESS | 24351 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-yui.html (next: http://localhost:49706/tests/dromaeo/cssquery-dojo.html) 06:18:05 INFO - PROCESS | 24351 | RSS: Main: 308899840 06:18:05 INFO - PROCESS | 24351 | 06:18:05 INFO - PROCESS | 24351 | __start_tp_report 06:18:05 INFO - PROCESS | 24351 | _x_x_mozilla_page_load 06:18:05 INFO - PROCESS | 24351 | _x_x_mozilla_page_load_details 06:18:05 INFO - PROCESS | 24351 | |i|pagename|runs| 06:18:05 INFO - PROCESS | 24351 | |0;dojo.html;2600.882960266788;2618.751218634229;2653.641758362621;2664.160789351353;2669.319323572489;4746.264329029002;4754.096721622889;4805.327254184408;4907.214845624696;4957.578605818505;4812.614990800736;4834.903301933968;4852.878678033051;4853.902921941559;4883.365162528867;4356.346548017799;4445.711028783135;4458.509563947963;4521.140983213196;4600.401947746788;4500.392447019643;4538.886527836814;4553.908921821561;4555.658325625574;4576.8626941191815;4330.30715085588;4383.846565370229;4457.888552786174;4459.955400445986;4487.57368050038;4366.432363792718;4377.584129507692;4379.868603941887;4490.259107247301;4557.498675145731;4396.20868243716;4408.911821763547;4413.249747542925;4426.092651006536;4457.710248833848;4773.164696178155;4827.686200396998;4865.537773911473;4873.829415970459;4903;5298.470152984709;5307.575393968512;5335.146376579767;5335.626506144571;5336.519713225828;5271.0248604008;5272.630915835893;5280.656757310762;5317.175837745117;5318.042752304584;4804.351412559329;4839.056384005085;4859.611231101503;4902.313676085315;4908.190148625508;5341.62608617393;5355.303810504687;5404.243405923174;5433.809816656398;5434.945650543444;5243.659162154448;5249.763760630781;5257.8159764408065;5261.5264626183825;5269.710165940834;5100.056489549445;5259.710715910662;5302.337207849019;5315.176147697113;5327.440618734977;5285.207218917117;5286.603504737083;5293.338332708411;5295.602829787781;5297.470252974749;5041.420236672756;5286.127788914863;5290.312259406252;5291.947080529222;5329.520343169133;4378.978105109518;4392.736435813861;4450.065486247924;4451.421315228999;4452.487963884195;3837.76973381598;3840.0591854995146;3841.154945911895;3883.728139030241;3937.2125574885135;4435.068635586498;4441.933370999438;4443.37792709021;4484.394606728115;4486.327050942385;5094.363204599425;5199.142141546678;5207.7916883325;5243.187305967581;5257.421683614799;4498.280275155959;4501.617362524222;4504.436945381827;4536.478304994967;4541.069080838421;4723.669343146015;4735.597474214662;4738.241881298975;4745.0509898019845;4780.450248221429;4792.880177995578;4911.435184953776;4924.482929292516;4936.925946110811;4961.42943561495;5314.601404894571;5320.760565774472;5329.307190065267;5330.067238233216;5333.866653333543;5001;5001.4998500149695;5002.224655178453;5003.099442100457;5040.697558146523;5051.87370315745;5072.82245121419;5137.1010073237785;5149.871253218699;5167.328247327973;5175.430702622783;5204.9739751301;5208.687478751287;5210.713410762292;5268.868278293074;5007.524285192901;5062.443131255633;5066.721330326867;5066.923996139987;5072.061668591323;5033.697978121324;5039.017391608601;5087.008033433445;5087.821926232564;5114.156164233009;5030.320906677552;5031.169856973558;5050.116229659869;5070.188769796815;5087.982403519237;5011.423686275979;5085.135526960352;5135.768890400016;5141.357330333708;5184.248283998874;5030;5045.445001049955;5064.34163558735;5071.670341427795;5121.923171152361 06:18:05 INFO - PROCESS | 24351 | |1;ext.html;546.7139249889962;570.8687001989542;585.3385674188166;588.5968111843385;590.5098768022542;27268.727312726867;39887.80056099719;40939;41198.38202426959;41205.79397103018;40220.79889600548;40858.59141408585;40874.7956260219;40908.79545602275;40950.59049409505;7383.372413344872;7533.547987120763;7536.321731044205;7878.172791856859;8055.03339599246;7674.1942096079665;10153.949230253838;10384.688459346195;10385.376877387382;10709.518071686754;10392.220583456272;10401;10407.219458540601;10410.63562775303;10412.63555775548;7537.54774713519;10139.797204055878;10291;10374.79250414995;10387.065164135189;10210.2852800304;10279.126274266697;10285;10293.948530257376;10310.123639490652;38086.23827523462;38423.807880960696;38464.423033654515;38465;38487.807560962014;3145.9370812583848;3238.3361410910943;3239.985926032374;3255.625603055655;3280.9015729527914;28986;29122.70877291221;29459;29482;29604.40791184164;3525.460271196944;3536.345776031417;3536.6993805526563;3561.8753343633107;3625.329314076878;264943;268122.999999998;268169;268603;268764;31584.684153158174;32541.67458325434;54701;55032;55135;34342;34538;34580.82709586436;34610.48084278738;34611.653883460844;13164.60506184816;13379.331033448483;13387.866121338857;13423.463061477627;13437.529686460926;10466.52900619474;10486.318389304672;10487.842682359771;10524.158067354594;10734.516946737416;7900.881486777703;7915.643796029192;7937.285644292041;7942.205779422127;7967.402444816662;3078.8448086339654;3080.522519009557;3112.9844350778103;3137.748980081588;3163.2724473371254;887.8801361816202;998.4141074616778;999.7250756042147;1008.1934452438167;1013.9340942838692;26806.731932680425;26933.979951503716;27291.727082729314;27482.862585686944;27522;993.9850902236473;1032.1123833503182;1058.8888166742381;1061.0715623829149;1077.1651969723528;14048.438062477591;14451.710965780625;14614.561563153122;14710.485133020293;14858;311095;311997;313821;314078;316137;47349;48672.75663621659;48693.26960095602;48756.26865597019;48782.5121748778;1085.1264731890903;1185.1170877696172;1186.0985650905375;1189.143816452153;1200.5677955935682;27533.586996194674;28562.285942851595;29398;29481.852590737766;29577.556336654536;42555.7872210637;42910;43171.35242971421;43186;43433.78283108564;293313;294184;294681;294804;295004;23108.653370199125;23726.881365593752;25213.495730084927;26036.60945085787;26304.605430918935;42418.57581424146;42484.36273455839;42528;43325.133497330506;43338.78330608327;35322.470162947066;36781.63218367782;37157.81421092986;37203.62796372001;37306.44040339451;36066.4590031155;36147.819260903525;36540.080604583905;36690.63309366872;36694.633053669124;35581.46627800533;35929.28141437209;36344.63655363518;36372.27255454823;36889.26221475502;32160.83919580387;32205.35589288248;32588.83705581457;32782.18044548905;33053.33893322168;24985.625215621418;25170.874145629154;25280.241592752245;25351.746482534938;25407.711710282725 06:18:05 INFO - PROCESS | 24351 | |2;jquery.html;364.9124210189554;368.28001257541507;372.09023936475313;382.27558776119236;383.9865604703836;15374.461893833719;16189.595260118489;17000.4049858255;17002.489925302245;17054.82945170548;16030.919845400756;16091.83908160918;17478.475645730618;17482.737758933596;17490.300387984465;5075.416327122372;5251.369835619731;5280.735963201843;5285.445028272034;5285.550728188108;3756.5492140943124;3921.0785465415606;3924.9018774530723;3960.7425517341426;5179.378474583055;6076.118962750398;6191.659458729768;6200.565960382775;6202.224721909762;6204.0383740520065;6004.759809607611;6069.08963655453;6126.6017708849;6158;6187.81436556904;3365.8990230292884;4982.551570358649;5440.483154100354;5452.809151679712;5458.6724796512335;19366.4190074298;20357.898210508854;20589.588208235902;20896.328293736464;21151.47121321964;1942.2036964844488;1974.5458544534695;2040.1125510402874;2084.2392526727785;2085.2076211039857;13121;13220.33898305081;13238;13471.86528134716;13669.589912302547;1755.9210133831714;1768.4341010876524;1781.973270400945;1805.909704514769;1840.723891416285;66985.66507167481;67927.32072679308;68002.31997680009;68640.65679671669;69504;9573.569189386495;9635.325527213028;9905.60377584903;10002.549885255035;10343.327683700536;13654.317284135754;13738.381772820047;13751.174929504261;13764.655883602789;13773.862261377459;7116.110486189226;7216.386607138452;7233.132024157135;7301.37938275242;7357.852842943111;6923.411510021705;7026.754063607851;7093.113360829896;7197.4961752677855;7234.385077268491;6052.54605904559;6287.1512345832725;6297.96851015742;6298.937010629927;6374.458171055419;1583.6674298397465;1710.8545773609383;1721.7073097573443;1773.6098058427126;1874.7375367448567;742.2874040920668;844.4468872888268;894.3024440936081;991.3234366541482;1015.21320976244;16881.662366752596;17674.469765907044;17718.734218986727;17786.5553361167;18287.45137645873;891.5943245823134;909.9727008189765;917.660465627722;949.188443880486;952.5427794658602;9884.851727224097;10079.445630490394;10250;10262.384256944608;10277.075063244343;376269;376594;376884;378241;378652;55351;69131.65434172898;70090;74989.62505187439;75959;905.9003509613938;923.6443969071821;937.95310234488;947.7062110745691;955.3217215776876;15470.149141797308;15684.13737244417;15822.129782862054;15979.520614381587;16379.013546890012;37678.811605941795;37936.43095353627;38100.809495952344;38102;38671;48709.81440311686;51400.48599513957;53059;53441.732791335795;53851.73074134761;7819.765407037798;7824;7874.330681892104;8054.959725201336;8087.353011759163;11154.442277885912;11504.482298296763;11635.360055196707;11691.590794322157;11985.940070299594;9740.366876153028;10017.449040302854;10043.096121349114;10353.896461035294;10902.182336324966;10280.948595257276;10585.682429527127;10692.839607406051;10786.406747628957;10993.395363255098;10587.153027757915;10676.57293708243;10925.945370273097;10990.725231869268;11025.173112016791;7543.622818859145;7763.301302882767;7884.369250460064;7922.128565857636;8020.759377218693;8600.268977136762;9955.50222488887;10490.737731556772;10655.946720266349;10730 06:18:05 INFO - PROCESS | 24351 | |3;mootools.html;1223.2843786384965;1370.212128026385;1406.2476575032358;1488.3004987655797;1708.1117818734258;6835.897461538075;7717.8842317365215;7946.125926148119;7968.163342849004;8226.753197404072;7981.52110873348;8161.714339998101;8162.591870406471;8171.182881711826;8172.754817355489;1906.9618607627908;2169.642009068502;2192.243675931805;2239.876806775627;2241.7758224177614;2282.8744419056943;2301.2750983440246;2307.4923516826357;2308.6537019447132;2309.030207312924;2231.977680223193;2253.876036817974;2261.1520679745095;2262.321303608919;2265.207177487874;1854.091495167365;2116.8306535477127;2177.4338671945407;2178.18318130701;2187.8359123065834;2141.882196479193;2179.901904414289;2180.5965896309235;2180.8255339572797;2184.6176919039103;8038.316743076845;8056.194380561897;8075.555844428554;8090.474119182293;8106.756797296031;4439;4550.795214215368;4553.089382123555;4553.203189441834;4558.817647294104;2735.6306898568637;2887.2926133097317;2978.3596526746855;2978.553217017443;2989.8505074746176;922.2806211155242;924.6856068936527;929.772205809581;932.1843387036344;932.6430044285548;11130.944345278303;11137.665870023913;11142.49858756358;11143.108551315956;11172.329660220414;4276.48682158143;4395.450568678915;4454.710443821206;4481.775911204427;4488.842890498817;9238.538073096453;9306.2089722373;9316.20812230968;9320.813583728288;9326.533673316442;4819.469858315582;4825.10735513931;4826.7827947742435;4827.806887724522;4829.154897892855;3791.829367678461;4314.331278651814;4441.933370999438;4467.128909862546;4525.434320709911;3687.889363319051;3712.6844218241754;3771.0949372150485;3829.329867273216;3835.67396771272;1197.1081544249416;1198.9280643161437;1201.549418967887;1226.7975783995541;1243.384524660281;831.4096991136361;835.6991483066091;839.3495041343008;856.2636132925679;872.0886673426285;5123.692578445305;5219.086659834514;5226.111561034633;5427.538659214011;5427.674339539641;383.34256749674444;394.9506311711036;396.6707632664939;400.57939163877813;403.6266453530531;3561.4123669594746;3625.4380571011534;3640.690541304019;3643.7267204959735;3669.614690457517;9679.274054445945;9893.802123957481;9971.202303815677;9992.850107248398;9992.950035249924;9492.335536512515;9959.15347195482;9960.501974901226;9963.950180249198;9969.700908972742;7370.262973702587;7533.510321828954;7578.962105189549;7580.620968951531;7590.1650818409935;5023.146065168857;5153.587712982878;5365.839024829262;5397.78408863641;5434.891302174014;8945.552722363986;8966.372353935161;9226.861597076184;9691;9691.418514889128;9006.729798106067;9083.000869904174;9105.908940910505;9169.587368568296;9633.662821801203;6414.647194404166;6690.832729181615;6754.425873800782;6954.443644508326;7126.857462850818;7986.121526632182;8005.439619226599;8035.437519373588;8072.717454889051;8098.271155596025;7041.4014808739785;7219.60292183935;7224.096987876515;7320;7327.37717294036;7021.648917554204;7035.542689725152;7097.893531596927;7115.679794409368;7196.172440169447;6018.969905150446;6185.474234690102;6198.194234749454;6257.0614407837365;6261.937380626136;4342.761148136883;4419.955800442083;4438.378626992288;4535.501094879494;4539.568740969735;4377.190219809346;4380.890477737955;4416.447944006999;4432.869618247326;4481.148581769454 06:18:05 INFO - PROCESS | 24351 | |4;prototype.html;293.57724876178304;304.0938004745857;306.7821846488993;309.972102510774;310.6194911233739;4966.155753521901;5006.899862002758;5015.398152221734;5022.748862556876;5062.797488100477;4650.837220697276;4701.7792811923855;4820.204666230068;4846.34574332465;4957.900841983158;3823.617638236182;3833.4441505981617;3867.439221312908;3874.573796882348;3882.844686212548;3859.614038596146;3863.536375634928;3867.8839634811;3900.3564411872007;3901.258760835432;3635.927281454369;3734.9253014939823;3843.5195600549932;3862.2275544890995;3864.8260828262655;3807.5811660717436;3833.884983450501;3834.7699138051526;3842.769433833979;3850.942235866464;3428.4571942625917;3444.4661077533024;3448.6551344865566;3449.482577613378;3471.6528347165336;4582.679212455129;4817.710937343735;4845.079434907391;4850;4878.829240976549;4315.719478233905;4343.652507799368;4366.388705581221;4374.818798924272;4376.7811609419405;5133.640645154841;5150.845474635767;5164.45773193813;5180.248863914749;5181.818636347747;3584.623614520464;3635.818209089535;3640.381135207021;3642.4354225095153;3644.7630903991158;5371.140617501181;5380.677159370451;5399.649022813504;5458.590605704588;5475.698836563987;3759.962400376016;3767.9246415072093;3775.131719704483;3776.86780962665;3786.8863934082024;3821.5796262411113;3823.235352929425;3832.156925476391;3862.4550179928256;3866.2654095721723;4256.808443619982;4386.539413361615;4410.757408342572;4411.117776444724;4445.2887537993765;5159.781294043522;5201.713905735221;5212.687238765686;5219.712915789592;5226.712530810842;1254.4856608790353;1295.2099219476113;1303.3548393545066;1324.7681655710212;1342.6441992871896;832.7543374704477;837.0583094019229;842.1452225990624;851.4125253575013;856.2422256303216;4130.380442933584;4132.855350062733;4139.9793001035405;4145.647619952338;4152.771597562163;4645;4700;4739.7439678485225;4764.595009424169;4796.544328288876;4000.3998400639975;4071.3689378146437;4104.445899803548;4107.363358679409;4121.216968775923;2326.4998025424616;2466.161505088243;2515.4843257132243;2524.899004039818;2538.923832285034;4414.337849322563;4427.380166776654;4445.155100735532;4447.642749342854;4447.822087116479;4769.260764581495;4801.831935882227;4802.831900883522;4832.95167048332;4834;4431.135928493913;4433.763352752509;4670.626349892001;5101.336826212569;5104.285400044071;5372.221027951004;5375.1131063374105;5429.457054294539;5430.321209848769;5442.482964118402;5306.575473961997;5316.548093412103;5321.7759915220495;5358.705271210121;5364.865878353073;4952.182889823139;5031.6226283029655;5066.544011039025;5077.847664570068;5104.464031276662;3744;3746.2882052409955;3754.849806007729;3776.0937375030344;3780.5652349980105;5133.767895705078;5357.866053348697;5388.38033626138;5423.942331245369;5432.945670543402;4966.304717339648;5167.61242906776;5179.20323025577;5179.404368497671;5182.041322355376;5155.808781268021;5178.300929374486;5249.580033597379;5252.947470525399;5262.947370526399;4853.296272040464;5118.641695081308;5170.466471428897;5170.508801663836;5183.5593974512585;5203.843884683465;5206.609504287269;5207.114790485551;5213.765380557808;5233.450487698889;5107.336046313955;5114.9232761507865;5119.974400127976;5132.870768430939;5137.075326441127 06:18:05 INFO - PROCESS | 24351 | |5;yui.html;662.9966850165748;671.7648822911979;679.6329981809823;713.0302788208036;738.2654259012282;12394.132410731241;13356.59930202093;13358.866411335885;13363.131396459235;13388.397522111503;12065.276083435;12157.209781364205;12168.148229623908;12186.51253949841;12899.806502902464;787.3071696906715;796.8884356190138;797.4059325802285;797.5095316380442;797.6171437709903;632.1024145713076;769.2154002917022;782.86299897518;792.7938735928642;798.8202654402742;835.0897521701345;838.5429940682312;838.6393850644221;839.6011894350165;840.2060053249681;819.635262308273;820.1675299570941;821.3880658909151;821.6302663801254;822.173715416009;482.1201307613619;589.4164776870867;596.9522438204976;601.9488343490765;605.4339192854695;13119.47522099115;13147.211167329991;13280.269585172811;13298.800517992238;13370.665733356744;11251.54993800247;12202;12356.567520136752;12431.37843107841;12478.126531142823;11823.527058917633;11865.288082714978;11929.880701193051;11988.460519276654;12056.758864822654;4147.232761939051;4170.833166673329;4193.937090943638;4199.370094485821;4280.978595107004;57617.42382576162;58776.70611646957;60056.399436005515;60320.39679603191;60638;10133.543990520444;10171.64399246023;10206.642767503101;10254.6410875619;10381.532831022621;17767.28930842778;17777.644447110986;17788.110594470225;17828.10859457048;17852.01813900248;7034.120734908137;7261.927380726231;7331.523450975669;7388.44586656003;7395.8151046224275;3872.244912242086;3963.603639636013;4000.5599384067727;4060.045889216032;4097.180563887235;2926.9121926342245;3069.9539506907413;3070.4933685942015;3071.8617662205256;3074.6310442747013;507.8936796004346;518.5566340778655;526.3131613244676;527.9102552566073;547.6741338903425;554.4400155842628;637.3849235487777;643.6620774093639;653.4054010850103;655.7770358078276;8021.478603890729;8164.67341306353;8311.293540049042;8508.021577518664;8509.531975741269;544.3739699345705;599.307799491588;613.736093479808;615.4399496458202;623.1213988276598;3962.663173630216;4049.0687141957515;4178.415021896937;4204.621584057389;4252.766097864585;76217.23782762213;92089.53955230181;92175;95219;97092.51453742686;74863.62568187124;77393.61303193448;78934.605326973;79334.60332698416;79378.60310698525;69190;69214.65392673004;69607.65196173987;70301.64849175721;71044;8092.878606820785;8287;8358.205970432798;8419.8737018946;8428.45215061019;37562.81218593889;41850.37224441697;41865.58134418617;41892;43985.12029759451;39737.80131099326;51939.286678466095;53043.93912121813;57818.42181578299;58770;11413.258138220988;11491.482883270106;11572.132090093108;11798.115141364604;11989.880101199225;13151.34243287851;13177;13208.471661133448;13222.206667599974;13415.242733950643;11766.52933882635;12231.388430578258;12254.75490490203;12356.752864942471;12988;11525.079516776867;12284.447199875849;12386.62840114798;12494.125411221126;12693.682657933625;11864.881351186377;11983.400829958642;12020.879791201976;12140.817887731868;12584.056195785535;10119.241056920613;10129.544170512198;10358.948205258925;10448.582056717647;10508.947455262674;9703.369280996994;10211.285210035227;10453.163746900078;10494.895051049698;10536.947315263375 06:18:05 INFO - PROCESS | 24351 | __end_tp_report 06:18:05 INFO - PROCESS | 24351 | __start_cc_report 06:18:05 INFO - PROCESS | 24351 | _x_x_mozilla_cycle_collect,1084 06:18:05 INFO - PROCESS | 24351 | __end_cc_report 06:18:05 INFO - PROCESS | 24351 | __startTimestamp1466601485018__endTimestamp 06:18:05 INFO - PROCESS | 24351 | 06:18:05 INFO - PROCESS | 24351 | ------- Summary: start ------- 06:18:05 INFO - PROCESS | 24351 | Number of tests: 6 06:18:05 INFO - PROCESS | 24351 | 06:18:05 INFO - PROCESS | 24351 | [#0] dojo.html Cycles:165 Average:4834.63 Median:5002.22 stddev:534.29 (10.7%) stddev-sans-first:506.38 06:18:05 INFO - PROCESS | 24351 | Values: 2600.9 2618.8 2653.6 2664.2 2669.3 4746.3 4754.1 4805.3 4907.2 4957.6 4812.6 4834.9 4852.9 4853.9 4883.4 4356.3 4445.7 4458.5 4521.1 4600.4 4500.4 4538.9 4553.9 4555.7 4576.9 4330.3 4383.8 4457.9 4460.0 4487.6 4366.4 4377.6 4379.9 4490.3 4557.5 4396.2 4408.9 4413.2 4426.1 4457.7 4773.2 4827.7 4865.5 4873.8 4903.0 5298.5 5307.6 5335.1 5335.6 5336.5 5271.0 5272.6 5280.7 5317.2 5318.0 4804.4 4839.1 4859.6 4902.3 4908.2 5341.6 5355.3 5404.2 5433.8 5434.9 5243.7 5249.8 5257.8 5261.5 5269.7 5100.1 5259.7 5302.3 5315.2 5327.4 5285.2 5286.6 5293.3 5295.6 5297.5 5041.4 5286.1 5290.3 5291.9 5329.5 4379.0 4392.7 4450.1 4451.4 4452.5 3837.8 3840.1 3841.2 3883.7 3937.2 4435.1 4441.9 4443.4 4484.4 4486.3 5094.4 5199.1 5207.8 5243.2 5257.4 4498.3 4501.6 4504.4 4536.5 4541.1 4723.7 4735.6 4738.2 4745.1 4780.5 4792.9 4911.4 4924.5 4936.9 4961.4 5314.6 5320.8 5329.3 5330.1 5333.9 5001.0 5001.5 5002.2 5003.1 5040.7 5051.9 5072.8 5137.1 5149.9 5167.3 5175.4 5205.0 5208.7 5210.7 5268.9 5007.5 5062.4 5066.7 5066.9 5072.1 5033.7 5039.0 5087.0 5087.8 5114.2 5030.3 5031.2 5050.1 5070.2 5088.0 5011.4 5085.1 5135.8 5141.4 5184.2 5030.0 5045.4 5064.3 5071.7 5121.9 06:18:05 INFO - PROCESS | 24351 | 06:18:05 INFO - PROCESS | 24351 | [#1] ext.html Cycles:180 Average:44249.64 Median:159650.14 stddev:76585.10 (48.0%) stddev-sans-first:76729.65 06:18:05 INFO - PROCESS | 24351 | Values: 546.7 570.9 585.3 588.6 590.5 27268.7 39887.8 40939.0 41198.4 41205.8 40220.8 40858.6 40874.8 40908.8 40950.6 7383.4 7533.5 7536.3 7878.2 8055.0 7674.2 10153.9 10384.7 10385.4 10709.5 10392.2 10401.0 10407.2 10410.6 10412.6 7537.5 10139.8 10291.0 10374.8 10387.1 10210.3 10279.1 10285.0 10293.9 10310.1 38086.2 38423.8 38464.4 38465.0 38487.8 3145.9 3238.3 3240.0 3255.6 3280.9 28986.0 29122.7 29459.0 29482.0 29604.4 3525.5 3536.3 3536.7 3561.9 3625.3 264943.0 268123.0 268169.0 268603.0 268764.0 31584.7 32541.7 54701.0 55032.0 55135.0 34342.0 34538.0 34580.8 34610.5 34611.7 13164.6 13379.3 13387.9 13423.5 13437.5 10466.5 10486.3 10487.8 10524.2 10734.5 7900.9 7915.6 7937.3 7942.2 7967.4 3078.8 3080.5 3113.0 3137.7 3163.3 887.9 998.4 999.7 1008.2 1013.9 26806.7 26934.0 27291.7 27482.9 27522.0 994.0 1032.1 1058.9 1061.1 1077.2 14048.4 14451.7 14614.6 14710.5 14858.0 311095.0 311997.0 313821.0 314078.0 316137.0 47349.0 48672.8 48693.3 48756.3 48782.5 1085.1 1185.1 1186.1 1189.1 1200.6 27533.6 28562.3 29398.0 29481.9 29577.6 42555.8 42910.0 43171.4 43186.0 43433.8 293313.0 294184.0 294681.0 294804.0 295004.0 23108.7 23726.9 25213.5 26036.6 26304.6 42418.6 42484.4 42528.0 43325.1 43338.8 35322.5 36781.6 37157.8 37203.6 37306.4 36066.5 36147.8 36540.1 36690.6 36694.6 35581.5 35929.3 36344.6 36372.3 36889.3 32160.8 32205.4 32588.8 32782.2 33053.3 24985.6 25170.9 25280.2 25351.7 25407.7 06:18:05 INFO - PROCESS | 24351 | 06:18:05 INFO - PROCESS | 24351 | [#2] jquery.html Cycles:180 Average:24012.67 Median:38018.62 stddev:62172.17 (163.5%) stddev-sans-first:62321.22 06:18:05 INFO - PROCESS | 24351 | Values: 364.9 368.3 372.1 382.3 384.0 15374.5 16189.6 17000.4 17002.5 17054.8 16030.9 16091.8 17478.5 17482.7 17490.3 5075.4 5251.4 5280.7 5285.4 5285.6 3756.5 3921.1 3924.9 3960.7 5179.4 6076.1 6191.7 6200.6 6202.2 6204.0 6004.8 6069.1 6126.6 6158.0 6187.8 3365.9 4982.6 5440.5 5452.8 5458.7 19366.4 20357.9 20589.6 20896.3 21151.5 1942.2 1974.5 2040.1 2084.2 2085.2 13121.0 13220.3 13238.0 13471.9 13669.6 1755.9 1768.4 1782.0 1805.9 1840.7 66985.7 67927.3 68002.3 68640.7 69504.0 9573.6 9635.3 9905.6 10002.5 10343.3 13654.3 13738.4 13751.2 13764.7 13773.9 7116.1 7216.4 7233.1 7301.4 7357.9 6923.4 7026.8 7093.1 7197.5 7234.4 6052.5 6287.2 6298.0 6298.9 6374.5 1583.7 1710.9 1721.7 1773.6 1874.7 742.3 844.4 894.3 991.3 1015.2 16881.7 17674.5 17718.7 17786.6 18287.5 891.6 910.0 917.7 949.2 952.5 9884.9 10079.4 10250.0 10262.4 10277.1 376269.0 376594.0 376884.0 378241.0 378652.0 55351.0 69131.7 70090.0 74989.6 75959.0 905.9 923.6 938.0 947.7 955.3 15470.1 15684.1 15822.1 15979.5 16379.0 37678.8 37936.4 38100.8 38102.0 38671.0 48709.8 51400.5 53059.0 53441.7 53851.7 7819.8 7824.0 7874.3 8055.0 8087.4 11154.4 11504.5 11635.4 11691.6 11985.9 9740.4 10017.4 10043.1 10353.9 10902.2 10280.9 10585.7 10692.8 10786.4 10993.4 10587.2 10676.6 10925.9 10990.7 11025.2 7543.6 7763.3 7884.4 7922.1 8020.8 8600.3 9955.5 10490.7 10655.9 10730.0 06:18:05 INFO - PROCESS | 24351 | 06:18:05 INFO - PROCESS | 24351 | [#3] mootools.html Cycles:180 Average:5254.58 Median:5073.42 stddev:3017.24 (59.5%) stddev-sans-first:3010.49 06:18:05 INFO - PROCESS | 24351 | Values: 1223.3 1370.2 1406.2 1488.3 1708.1 6835.9 7717.9 7946.1 7968.2 8226.8 7981.5 8161.7 8162.6 8171.2 8172.8 1907.0 2169.6 2192.2 2239.9 2241.8 2282.9 2301.3 2307.5 2308.7 2309.0 2232.0 2253.9 2261.2 2262.3 2265.2 1854.1 2116.8 2177.4 2178.2 2187.8 2141.9 2179.9 2180.6 2180.8 2184.6 8038.3 8056.2 8075.6 8090.5 8106.8 4439.0 4550.8 4553.1 4553.2 4558.8 2735.6 2887.3 2978.4 2978.6 2989.9 922.3 924.7 929.8 932.2 932.6 11130.9 11137.7 11142.5 11143.1 11172.3 4276.5 4395.5 4454.7 4481.8 4488.8 9238.5 9306.2 9316.2 9320.8 9326.5 4819.5 4825.1 4826.8 4827.8 4829.2 3791.8 4314.3 4441.9 4467.1 4525.4 3687.9 3712.7 3771.1 3829.3 3835.7 1197.1 1198.9 1201.5 1226.8 1243.4 831.4 835.7 839.3 856.3 872.1 5123.7 5219.1 5226.1 5427.5 5427.7 383.3 395.0 396.7 400.6 403.6 3561.4 3625.4 3640.7 3643.7 3669.6 9679.3 9893.8 9971.2 9992.9 9993.0 9492.3 9959.2 9960.5 9964.0 9969.7 7370.3 7533.5 7579.0 7580.6 7590.2 5023.1 5153.6 5365.8 5397.8 5434.9 8945.6 8966.4 9226.9 9691.0 9691.4 9006.7 9083.0 9105.9 9169.6 9633.7 6414.6 6690.8 6754.4 6954.4 7126.9 7986.1 8005.4 8035.4 8072.7 8098.3 7041.4 7219.6 7224.1 7320.0 7327.4 7021.6 7035.5 7097.9 7115.7 7196.2 6019.0 6185.5 6198.2 6257.1 6261.9 4342.8 4420.0 4438.4 4535.5 4539.6 4377.2 4380.9 4416.4 4432.9 4481.1 06:18:05 INFO - PROCESS | 24351 | 06:18:05 INFO - PROCESS | 24351 | [#4] prototype.html Cycles:180 Average:4214.84 Median:4685.31 stddev:1241.15 (26.5%) stddev-sans-first:1209.24 06:18:05 INFO - PROCESS | 24351 | Values: 293.6 304.1 306.8 310.0 310.6 4966.2 5006.9 5015.4 5022.7 5062.8 4650.8 4701.8 4820.2 4846.3 4957.9 3823.6 3833.4 3867.4 3874.6 3882.8 3859.6 3863.5 3867.9 3900.4 3901.3 3635.9 3734.9 3843.5 3862.2 3864.8 3807.6 3833.9 3834.8 3842.8 3850.9 3428.5 3444.5 3448.7 3449.5 3471.7 4582.7 4817.7 4845.1 4850.0 4878.8 4315.7 4343.7 4366.4 4374.8 4376.8 5133.6 5150.8 5164.5 5180.2 5181.8 3584.6 3635.8 3640.4 3642.4 3644.8 5371.1 5380.7 5399.6 5458.6 5475.7 3760.0 3767.9 3775.1 3776.9 3786.9 3821.6 3823.2 3832.2 3862.5 3866.3 4256.8 4386.5 4410.8 4411.1 4445.3 5159.8 5201.7 5212.7 5219.7 5226.7 1254.5 1295.2 1303.4 1324.8 1342.6 832.8 837.1 842.1 851.4 856.2 4130.4 4132.9 4140.0 4145.6 4152.8 4645.0 4700.0 4739.7 4764.6 4796.5 4000.4 4071.4 4104.4 4107.4 4121.2 2326.5 2466.2 2515.5 2524.9 2538.9 4414.3 4427.4 4445.2 4447.6 4447.8 4769.3 4801.8 4802.8 4833.0 4834.0 4431.1 4433.8 4670.6 5101.3 5104.3 5372.2 5375.1 5429.5 5430.3 5442.5 5306.6 5316.5 5321.8 5358.7 5364.9 4952.2 5031.6 5066.5 5077.8 5104.5 3744.0 3746.3 3754.8 3776.1 3780.6 5133.8 5357.9 5388.4 5423.9 5432.9 4966.3 5167.6 5179.2 5179.4 5182.0 5155.8 5178.3 5249.6 5252.9 5262.9 4853.3 5118.6 5170.5 5170.5 5183.6 5203.8 5206.6 5207.1 5213.8 5233.5 5107.3 5114.9 5120.0 5132.9 5137.1 06:18:05 INFO - PROCESS | 24351 | 06:18:05 INFO - PROCESS | 24351 | [#5] yui.html Cycles:180 Average:16947.39 Median:4202.00 stddev:23255.30 (553.4%) stddev-sans-first:23288.39 06:18:05 INFO - PROCESS | 24351 | Values: 663.0 671.8 679.6 713.0 738.3 12394.1 13356.6 13358.9 13363.1 13388.4 12065.3 12157.2 12168.1 12186.5 12899.8 787.3 796.9 797.4 797.5 797.6 632.1 769.2 782.9 792.8 798.8 835.1 838.5 838.6 839.6 840.2 819.6 820.2 821.4 821.6 822.2 482.1 589.4 597.0 601.9 605.4 13119.5 13147.2 13280.3 13298.8 13370.7 11251.5 12202.0 12356.6 12431.4 12478.1 11823.5 11865.3 11929.9 11988.5 12056.8 4147.2 4170.8 4193.9 4199.4 4281.0 57617.4 58776.7 60056.4 60320.4 60638.0 10133.5 10171.6 10206.6 10254.6 10381.5 17767.3 17777.6 17788.1 17828.1 17852.0 7034.1 7261.9 7331.5 7388.4 7395.8 3872.2 3963.6 4000.6 4060.0 4097.2 2926.9 3070.0 3070.5 3071.9 3074.6 507.9 518.6 526.3 527.9 547.7 554.4 637.4 643.7 653.4 655.8 8021.5 8164.7 8311.3 8508.0 8509.5 544.4 599.3 613.7 615.4 623.1 3962.7 4049.1 4178.4 4204.6 4252.8 76217.2 92089.5 92175.0 95219.0 97092.5 74863.6 77393.6 78934.6 79334.6 79378.6 69190.0 69214.7 69607.7 70301.6 71044.0 8092.9 8287.0 8358.2 8419.9 8428.5 37562.8 41850.4 41865.6 41892.0 43985.1 39737.8 51939.3 53043.9 57818.4 58770.0 11413.3 11491.5 11572.1 11798.1 11989.9 13151.3 13177.0 13208.5 13222.2 13415.2 11766.5 12231.4 12254.8 12356.8 12988.0 11525.1 12284.4 12386.6 12494.1 12693.7 11864.9 11983.4 12020.9 12140.8 12584.1 10119.2 10129.5 10358.9 10448.6 10508.9 9703.4 10211.3 10453.2 10494.9 10536.9 06:18:05 INFO - PROCESS | 24351 | -------- Summary: end -------- 06:18:05 INFO - PROCESS | 24351 | 06:18:05 INFO - TEST-INFO | 24351: exit 0 06:18:05 INFO - TEST-OK | dromaeo_css | took 1120311ms 06:18:05 INFO - TEST-START | kraken 06:18:05 INFO - operating with platform_type : linux_ 06:18:05 INFO - Initialising browser for kraken test... 06:18:05 INFO - TEST-INFO | started process 24531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ4wUoC/profile http://localhost:49706/getInfo.html) 06:18:10 INFO - PROCESS | 24531 | __metrics Screen width/height:1600/1200 06:18:10 INFO - PROCESS | 24531 | colorDepth:24 06:18:10 INFO - PROCESS | 24531 | Browser inner width/height: 1024/697 06:18:10 INFO - PROCESS | 24531 | __metrics 06:18:11 INFO - PROCESS | 24531 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:18:12 INFO - TEST-INFO | 24531: exit 0 06:18:12 INFO - Browser initialized. 06:18:12 INFO - Running cycle 1/1 for kraken test... 06:18:12 INFO - TEST-INFO | started process 24611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ4wUoC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:24 INFO - PROCESS | 24611 | RSS: Main: 176046080 06:18:24 INFO - PROCESS | 24611 | 06:18:27 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:27 INFO - PROCESS | 24611 | RSS: Main: 233586688 06:18:27 INFO - PROCESS | 24611 | 06:18:30 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-dft) 06:18:31 INFO - PROCESS | 24611 | RSS: Main: 224432128 06:18:31 INFO - PROCESS | 24611 | 06:18:34 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-fft) 06:18:35 INFO - PROCESS | 24611 | RSS: Main: 289521664 06:18:35 INFO - PROCESS | 24611 | 06:18:37 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-oscillator) 06:18:38 INFO - PROCESS | 24611 | RSS: Main: 199831552 06:18:38 INFO - PROCESS | 24611 | 06:18:40 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49706/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:40 INFO - PROCESS | 24611 | RSS: Main: 203354112 06:18:40 INFO - PROCESS | 24611 | 06:18:44 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49706/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:44 INFO - PROCESS | 24611 | RSS: Main: 239497216 06:18:44 INFO - PROCESS | 24611 | 06:18:48 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49706/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:48 INFO - PROCESS | 24611 | RSS: Main: 240164864 06:18:48 INFO - PROCESS | 24611 | 06:18:51 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49706/tests/kraken/driver.html?testName=json-parse-financial) 06:18:52 INFO - PROCESS | 24611 | RSS: Main: 239390720 06:18:52 INFO - PROCESS | 24611 | 06:18:54 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49706/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:54 INFO - PROCESS | 24611 | RSS: Main: 225648640 06:18:54 INFO - PROCESS | 24611 | 06:18:56 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:57 INFO - PROCESS | 24611 | RSS: Main: 231063552 06:18:57 INFO - PROCESS | 24611 | 06:18:59 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:00 INFO - PROCESS | 24611 | RSS: Main: 239636480 06:19:00 INFO - PROCESS | 24611 | 06:19:02 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:03 INFO - PROCESS | 24611 | RSS: Main: 239300608 06:19:03 INFO - PROCESS | 24611 | 06:19:06 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:07 INFO - PROCESS | 24611 | RSS: Main: 238235648 06:19:07 INFO - PROCESS | 24611 | 06:19:08 INFO - PROCESS | 24611 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49706/tests/kraken/driver.html?testName=ai-astar) 06:19:09 INFO - PROCESS | 24611 | RSS: Main: 280825856 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | __start_tp_report 06:19:09 INFO - PROCESS | 24611 | _x_x_mozilla_page_load 06:19:09 INFO - PROCESS | 24611 | _x_x_mozilla_page_load_details 06:19:09 INFO - PROCESS | 24611 | |i|pagename|runs| 06:19:09 INFO - PROCESS | 24611 | |0;ai-astar;104;114;114;113;119;114;114;116;113;114 06:19:09 INFO - PROCESS | 24611 | |1;audio-beat-detection;173;131;135;193;131;132;152;134;188;129 06:19:09 INFO - PROCESS | 24611 | |2;audio-dft;163;162;165;161;162;161;163;160;161;160 06:19:09 INFO - PROCESS | 24611 | |3;audio-fft;78;76;76;105;76;83;74;76;100;74 06:19:09 INFO - PROCESS | 24611 | |4;audio-oscillator;86;85;116;93;86;86;123;84;87;124 06:19:09 INFO - PROCESS | 24611 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;118 06:19:09 INFO - PROCESS | 24611 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;145 06:19:09 INFO - PROCESS | 24611 | |7;imaging-desaturate;95;95;95;96;96;95;96;95;95;96 06:19:09 INFO - PROCESS | 24611 | |8;json-parse-financial;64;63;64;63;64;74;64;65;63;64 06:19:09 INFO - PROCESS | 24611 | |9;json-stringify-tinderbox;66;66;65;65;66;65;66;65;64;65 06:19:09 INFO - PROCESS | 24611 | |10;stanford-crypto-aes;83;82;80;82;82;83;84;83;92;88 06:19:09 INFO - PROCESS | 24611 | |11;stanford-crypto-ccm;135;132;140;145;128;140;132;130;142;135 06:19:09 INFO - PROCESS | 24611 | |12;stanford-crypto-pbkdf2;170;170;170;172;169;167;169;169;168;164 06:19:09 INFO - PROCESS | 24611 | |13;stanford-crypto-sha256-iterative;67;67;66;66;69;66;68;66;66;65 06:19:09 INFO - PROCESS | 24611 | __end_tp_report 06:19:09 INFO - PROCESS | 24611 | __start_cc_report 06:19:09 INFO - PROCESS | 24611 | _x_x_mozilla_cycle_collect,1886 06:19:09 INFO - PROCESS | 24611 | __end_cc_report 06:19:09 INFO - PROCESS | 24611 | __startTimestamp1466601549052__endTimestamp 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | ------- Summary: start ------- 06:19:09 INFO - PROCESS | 24611 | Number of tests: 14 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:3.78 (3.3%) stddev-sans-first:1.88 06:19:09 INFO - PROCESS | 24611 | Values: 104.0 114.0 114.0 113.0 119.0 114.0 114.0 116.0 113.0 114.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:143.50 stddev:25.37 (17.7%) stddev-sans-first:25.48 06:19:09 INFO - PROCESS | 24611 | Values: 173.0 131.0 135.0 193.0 131.0 132.0 152.0 134.0 188.0 129.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.55 (1.0%) stddev-sans-first:1.58 06:19:09 INFO - PROCESS | 24611 | Values: 163.0 162.0 165.0 161.0 162.0 161.0 163.0 160.0 161.0 160.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:11.26 (14.8%) stddev-sans-first:11.86 06:19:09 INFO - PROCESS | 24611 | Values: 78.0 76.0 76.0 105.0 76.0 83.0 74.0 76.0 100.0 74.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:86.00 stddev:16.86 (19.6%) stddev-sans-first:17.41 06:19:09 INFO - PROCESS | 24611 | Values: 86.0 85.0 116.0 93.0 86.0 86.0 123.0 84.0 87.0 124.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:19:09 INFO - PROCESS | 24611 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:19:09 INFO - PROCESS | 24611 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:19:09 INFO - PROCESS | 24611 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.00 stddev:3.29 (5.1%) stddev-sans-first:3.48 06:19:09 INFO - PROCESS | 24611 | Values: 64.0 63.0 64.0 63.0 64.0 74.0 64.0 65.0 63.0 64.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 06:19:09 INFO - PROCESS | 24611 | Values: 66.0 66.0 65.0 65.0 66.0 65.0 66.0 65.0 64.0 65.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:3.51 (4.2%) stddev-sans-first:3.71 06:19:09 INFO - PROCESS | 24611 | Values: 83.0 82.0 80.0 82.0 82.0 83.0 84.0 83.0 92.0 88.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:137.50 stddev:5.61 (4.1%) stddev-sans-first:5.94 06:19:09 INFO - PROCESS | 24611 | Values: 135.0 132.0 140.0 145.0 128.0 140.0 132.0 130.0 142.0 135.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:2.15 (1.3%) stddev-sans-first:2.24 06:19:09 INFO - PROCESS | 24611 | Values: 170.0 170.0 170.0 172.0 169.0 167.0 169.0 169.0 168.0 164.0 06:19:09 INFO - PROCESS | 24611 | 06:19:09 INFO - PROCESS | 24611 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.17 (1.8%) stddev-sans-first:1.24 06:19:09 INFO - PROCESS | 24611 | Values: 67.0 67.0 66.0 66.0 69.0 66.0 68.0 66.0 66.0 65.0 06:19:09 INFO - PROCESS | 24611 | -------- Summary: end -------- 06:19:09 INFO - PROCESS | 24611 | 06:19:10 INFO - TEST-INFO | 24611: exit 0 06:19:10 INFO - TEST-OK | kraken | took 64297ms 06:19:10 INFO - SUITE-END | took 1184s 06:19:10 INFO - Completed test suite (00:19:44) 06:19:10 INFO - javascript benchmark 06:19:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.882960266788, 2618.751218634229, 2653.641758362621, 2664.160789351353, 2669.319323572489, 4746.264329029002, 4754.096721622889, 4805.327254184408, 4907.214845624696, 4957.578605818505, 4812.614990800736, 4834.903301933968, 4852.878678033051, 4853.902921941559, 4883.365162528867, 4356.346548017799, 4445.711028783135, 4458.509563947963, 4521.140983213196, 4600.401947746788, 4500.392447019643, 4538.886527836814, 4553.908921821561, 4555.658325625574, 4576.8626941191815, 4330.30715085588, 4383.846565370229, 4457.888552786174, 4459.955400445986, 4487.57368050038, 4366.432363792718, 4377.584129507692, 4379.868603941887, 4490.259107247301, 4557.498675145731, 4396.20868243716, 4408.911821763547, 4413.249747542925, 4426.092651006536, 4457.710248833848, 4773.164696178155, 4827.686200396998, 4865.537773911473, 4873.829415970459, 4903.0, 5298.470152984709, 5307.575393968512, 5335.146376579767, 5335.626506144571, 5336.519713225828, 5271.0248604008, 5272.630915835893, 5280.656757310762, 5317.175837745117, 5318.042752304584, 4804.351412559329, 4839.056384005085, 4859.611231101503, 4902.313676085315, 4908.190148625508, 5341.62608617393, 5355.303810504687, 5404.243405923174, 5433.809816656398, 5434.945650543444, 5243.659162154448, 5249.763760630781, 5257.8159764408065, 5261.5264626183825, 5269.710165940834, 5100.056489549445, 5259.710715910662, 5302.337207849019, 5315.176147697113, 5327.440618734977, 5285.207218917117, 5286.603504737083, 5293.338332708411, 5295.602829787781, 5297.470252974749, 5041.420236672756, 5286.127788914863, 5290.312259406252, 5291.947080529222, 5329.520343169133, 4378.978105109518, 4392.736435813861, 4450.065486247924, 4451.421315228999, 4452.487963884195, 3837.76973381598, 3840.0591854995146, 3841.154945911895, 3883.728139030241, 3937.2125574885135, 4435.068635586498, 4441.933370999438, 4443.37792709021, 4484.394606728115, 4486.327050942385, 5094.363204599425, 5199.142141546678, 5207.7916883325, 5243.187305967581, 5257.421683614799, 4498.280275155959, 4501.617362524222, 4504.436945381827, 4536.478304994967, 4541.069080838421, 4723.669343146015, 4735.597474214662, 4738.241881298975, 4745.0509898019845, 4780.450248221429, 4792.880177995578, 4911.435184953776, 4924.482929292516, 4936.925946110811, 4961.42943561495, 5314.601404894571, 5320.760565774472, 5329.307190065267, 5330.067238233216, 5333.866653333543, 5001.0, 5001.4998500149695, 5002.224655178453, 5003.099442100457, 5040.697558146523, 5051.87370315745, 5072.82245121419, 5137.1010073237785, 5149.871253218699, 5167.328247327973, 5175.430702622783, 5204.9739751301, 5208.687478751287, 5210.713410762292, 5268.868278293074, 5007.524285192901, 5062.443131255633, 5066.721330326867, 5066.923996139987, 5072.061668591323, 5033.697978121324, 5039.017391608601, 5087.008033433445, 5087.821926232564, 5114.156164233009, 5030.320906677552, 5031.169856973558, 5050.116229659869, 5070.188769796815, 5087.982403519237, 5011.423686275979, 5085.135526960352, 5135.768890400016, 5141.357330333708, 5184.248283998874, 5030.0, 5045.445001049955, 5064.34163558735, 5071.670341427795, 5121.923171152361], "value": 4798.382940591479, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.7139249889962, 570.8687001989542, 585.3385674188166, 588.5968111843385, 590.5098768022542, 27268.727312726867, 39887.80056099719, 40939.0, 41198.38202426959, 41205.79397103018, 40220.79889600548, 40858.59141408585, 40874.7956260219, 40908.79545602275, 40950.59049409505, 7383.372413344872, 7533.547987120763, 7536.321731044205, 7878.172791856859, 8055.03339599246, 7674.1942096079665, 10153.949230253838, 10384.688459346195, 10385.376877387382, 10709.518071686754, 10392.220583456272, 10401.0, 10407.219458540601, 10410.63562775303, 10412.63555775548, 7537.54774713519, 10139.797204055878, 10291.0, 10374.79250414995, 10387.065164135189, 10210.2852800304, 10279.126274266697, 10285.0, 10293.948530257376, 10310.123639490652, 38086.23827523462, 38423.807880960696, 38464.423033654515, 38465.0, 38487.807560962014, 3145.9370812583848, 3238.3361410910943, 3239.985926032374, 3255.625603055655, 3280.9015729527914, 28986.0, 29122.70877291221, 29459.0, 29482.0, 29604.40791184164, 3525.460271196944, 3536.345776031417, 3536.6993805526563, 3561.8753343633107, 3625.329314076878, 264943.0, 268122.999999998, 268169.0, 268603.0, 268764.0, 31584.684153158174, 32541.67458325434, 54701.0, 55032.0, 55135.0, 34342.0, 34538.0, 34580.82709586436, 34610.48084278738, 34611.653883460844, 13164.60506184816, 13379.331033448483, 13387.866121338857, 13423.463061477627, 13437.529686460926, 10466.52900619474, 10486.318389304672, 10487.842682359771, 10524.158067354594, 10734.516946737416, 7900.881486777703, 7915.643796029192, 7937.285644292041, 7942.205779422127, 7967.402444816662, 3078.8448086339654, 3080.522519009557, 3112.9844350778103, 3137.748980081588, 3163.2724473371254, 887.8801361816202, 998.4141074616778, 999.7250756042147, 1008.1934452438167, 1013.9340942838692, 26806.731932680425, 26933.979951503716, 27291.727082729314, 27482.862585686944, 27522.0, 993.9850902236473, 1032.1123833503182, 1058.8888166742381, 1061.0715623829149, 1077.1651969723528, 14048.438062477591, 14451.710965780625, 14614.561563153122, 14710.485133020293, 14858.0, 311095.0, 311997.0, 313821.0, 314078.0, 316137.0, 47349.0, 48672.75663621659, 48693.26960095602, 48756.26865597019, 48782.5121748778, 1085.1264731890903, 1185.1170877696172, 1186.0985650905375, 1189.143816452153, 1200.5677955935682, 27533.586996194674, 28562.285942851595, 29398.0, 29481.852590737766, 29577.556336654536, 42555.7872210637, 42910.0, 43171.35242971421, 43186.0, 43433.78283108564, 293313.0, 294184.0, 294681.0, 294804.0, 295004.0, 23108.653370199125, 23726.881365593752, 25213.495730084927, 26036.60945085787, 26304.605430918935, 42418.57581424146, 42484.36273455839, 42528.0, 43325.133497330506, 43338.78330608327, 35322.470162947066, 36781.63218367782, 37157.81421092986, 37203.62796372001, 37306.44040339451, 36066.4590031155, 36147.819260903525, 36540.080604583905, 36690.63309366872, 36694.633053669124, 35581.46627800533, 35929.28141437209, 36344.63655363518, 36372.27255454823, 36889.26221475502, 32160.83919580387, 32205.35589288248, 32588.83705581457, 32782.18044548905, 33053.33893322168, 24985.625215621418, 25170.874145629154, 25280.241592752245, 25351.746482534938, 25407.711710282725], "value": 16874.831775951985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.9124210189554, 368.28001257541507, 372.09023936475313, 382.27558776119236, 383.9865604703836, 15374.461893833719, 16189.595260118489, 17000.4049858255, 17002.489925302245, 17054.82945170548, 16030.919845400756, 16091.83908160918, 17478.475645730618, 17482.737758933596, 17490.300387984465, 5075.416327122372, 5251.369835619731, 5280.735963201843, 5285.445028272034, 5285.550728188108, 3756.5492140943124, 3921.0785465415606, 3924.9018774530723, 3960.7425517341426, 5179.378474583055, 6076.118962750398, 6191.659458729768, 6200.565960382775, 6202.224721909762, 6204.0383740520065, 6004.759809607611, 6069.08963655453, 6126.6017708849, 6158.0, 6187.81436556904, 3365.8990230292884, 4982.551570358649, 5440.483154100354, 5452.809151679712, 5458.6724796512335, 19366.4190074298, 20357.898210508854, 20589.588208235902, 20896.328293736464, 21151.47121321964, 1942.2036964844488, 1974.5458544534695, 2040.1125510402874, 2084.2392526727785, 2085.2076211039857, 13121.0, 13220.33898305081, 13238.0, 13471.86528134716, 13669.589912302547, 1755.9210133831714, 1768.4341010876524, 1781.973270400945, 1805.909704514769, 1840.723891416285, 66985.66507167481, 67927.32072679308, 68002.31997680009, 68640.65679671669, 69504.0, 9573.569189386495, 9635.325527213028, 9905.60377584903, 10002.549885255035, 10343.327683700536, 13654.317284135754, 13738.381772820047, 13751.174929504261, 13764.655883602789, 13773.862261377459, 7116.110486189226, 7216.386607138452, 7233.132024157135, 7301.37938275242, 7357.852842943111, 6923.411510021705, 7026.754063607851, 7093.113360829896, 7197.4961752677855, 7234.385077268491, 6052.54605904559, 6287.1512345832725, 6297.96851015742, 6298.937010629927, 6374.458171055419, 1583.6674298397465, 1710.8545773609383, 1721.7073097573443, 1773.6098058427126, 1874.7375367448567, 742.2874040920668, 844.4468872888268, 894.3024440936081, 991.3234366541482, 1015.21320976244, 16881.662366752596, 17674.469765907044, 17718.734218986727, 17786.5553361167, 18287.45137645873, 891.5943245823134, 909.9727008189765, 917.660465627722, 949.188443880486, 952.5427794658602, 9884.851727224097, 10079.445630490394, 10250.0, 10262.384256944608, 10277.075063244343, 376269.0, 376594.0, 376884.0, 378241.0, 378652.0, 55351.0, 69131.65434172898, 70090.0, 74989.62505187439, 75959.0, 905.9003509613938, 923.6443969071821, 937.95310234488, 947.7062110745691, 955.3217215776876, 15470.149141797308, 15684.13737244417, 15822.129782862054, 15979.520614381587, 16379.013546890012, 37678.811605941795, 37936.43095353627, 38100.809495952344, 38102.0, 38671.0, 48709.81440311686, 51400.48599513957, 53059.0, 53441.732791335795, 53851.73074134761, 7819.765407037798, 7824.0, 7874.330681892104, 8054.959725201336, 8087.353011759163, 11154.442277885912, 11504.482298296763, 11635.360055196707, 11691.590794322157, 11985.940070299594, 9740.366876153028, 10017.449040302854, 10043.096121349114, 10353.896461035294, 10902.182336324966, 10280.948595257276, 10585.682429527127, 10692.839607406051, 10786.406747628957, 10993.395363255098, 10587.153027757915, 10676.57293708243, 10925.945370273097, 10990.725231869268, 11025.173112016791, 7543.622818859145, 7763.301302882767, 7884.369250460064, 7922.128565857636, 8020.759377218693, 8600.268977136762, 9955.50222488887, 10490.737731556772, 10655.946720266349, 10730.0], "value": 8429.832642870198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.2843786384965, 1370.212128026385, 1406.2476575032358, 1488.3004987655797, 1708.1117818734258, 6835.897461538075, 7717.8842317365215, 7946.125926148119, 7968.163342849004, 8226.753197404072, 7981.52110873348, 8161.714339998101, 8162.591870406471, 8171.182881711826, 8172.754817355489, 1906.9618607627908, 2169.642009068502, 2192.243675931805, 2239.876806775627, 2241.7758224177614, 2282.8744419056943, 2301.2750983440246, 2307.4923516826357, 2308.6537019447132, 2309.030207312924, 2231.977680223193, 2253.876036817974, 2261.1520679745095, 2262.321303608919, 2265.207177487874, 1854.091495167365, 2116.8306535477127, 2177.4338671945407, 2178.18318130701, 2187.8359123065834, 2141.882196479193, 2179.901904414289, 2180.5965896309235, 2180.8255339572797, 2184.6176919039103, 8038.316743076845, 8056.194380561897, 8075.555844428554, 8090.474119182293, 8106.756797296031, 4439.0, 4550.795214215368, 4553.089382123555, 4553.203189441834, 4558.817647294104, 2735.6306898568637, 2887.2926133097317, 2978.3596526746855, 2978.553217017443, 2989.8505074746176, 922.2806211155242, 924.6856068936527, 929.772205809581, 932.1843387036344, 932.6430044285548, 11130.944345278303, 11137.665870023913, 11142.49858756358, 11143.108551315956, 11172.329660220414, 4276.48682158143, 4395.450568678915, 4454.710443821206, 4481.775911204427, 4488.842890498817, 9238.538073096453, 9306.2089722373, 9316.20812230968, 9320.813583728288, 9326.533673316442, 4819.469858315582, 4825.10735513931, 4826.7827947742435, 4827.806887724522, 4829.154897892855, 3791.829367678461, 4314.331278651814, 4441.933370999438, 4467.128909862546, 4525.434320709911, 3687.889363319051, 3712.6844218241754, 3771.0949372150485, 3829.329867273216, 3835.67396771272, 1197.1081544249416, 1198.9280643161437, 1201.549418967887, 1226.7975783995541, 1243.384524660281, 831.4096991136361, 835.6991483066091, 839.3495041343008, 856.2636132925679, 872.0886673426285, 5123.692578445305, 5219.086659834514, 5226.111561034633, 5427.538659214011, 5427.674339539641, 383.34256749674444, 394.9506311711036, 396.6707632664939, 400.57939163877813, 403.6266453530531, 3561.4123669594746, 3625.4380571011534, 3640.690541304019, 3643.7267204959735, 3669.614690457517, 9679.274054445945, 9893.802123957481, 9971.202303815677, 9992.850107248398, 9992.950035249924, 9492.335536512515, 9959.15347195482, 9960.501974901226, 9963.950180249198, 9969.700908972742, 7370.262973702587, 7533.510321828954, 7578.962105189549, 7580.620968951531, 7590.1650818409935, 5023.146065168857, 5153.587712982878, 5365.839024829262, 5397.78408863641, 5434.891302174014, 8945.552722363986, 8966.372353935161, 9226.861597076184, 9691.0, 9691.418514889128, 9006.729798106067, 9083.000869904174, 9105.908940910505, 9169.587368568296, 9633.662821801203, 6414.647194404166, 6690.832729181615, 6754.425873800782, 6954.443644508326, 7126.857462850818, 7986.121526632182, 8005.439619226599, 8035.437519373588, 8072.717454889051, 8098.271155596025, 7041.4014808739785, 7219.60292183935, 7224.096987876515, 7320.0, 7327.37717294036, 7021.648917554204, 7035.542689725152, 7097.893531596927, 7115.679794409368, 7196.172440169447, 6018.969905150446, 6185.474234690102, 6198.194234749454, 6257.0614407837365, 6261.937380626136, 4342.761148136883, 4419.955800442083, 4438.378626992288, 4535.501094879494, 4539.568740969735, 4377.190219809346, 4380.890477737955, 4416.447944006999, 4432.869618247326, 4481.148581769454], "value": 4126.971356670005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.57724876178304, 304.0938004745857, 306.7821846488993, 309.972102510774, 310.6194911233739, 4966.155753521901, 5006.899862002758, 5015.398152221734, 5022.748862556876, 5062.797488100477, 4650.837220697276, 4701.7792811923855, 4820.204666230068, 4846.34574332465, 4957.900841983158, 3823.617638236182, 3833.4441505981617, 3867.439221312908, 3874.573796882348, 3882.844686212548, 3859.614038596146, 3863.536375634928, 3867.8839634811, 3900.3564411872007, 3901.258760835432, 3635.927281454369, 3734.9253014939823, 3843.5195600549932, 3862.2275544890995, 3864.8260828262655, 3807.5811660717436, 3833.884983450501, 3834.7699138051526, 3842.769433833979, 3850.942235866464, 3428.4571942625917, 3444.4661077533024, 3448.6551344865566, 3449.482577613378, 3471.6528347165336, 4582.679212455129, 4817.710937343735, 4845.079434907391, 4850.0, 4878.829240976549, 4315.719478233905, 4343.652507799368, 4366.388705581221, 4374.818798924272, 4376.7811609419405, 5133.640645154841, 5150.845474635767, 5164.45773193813, 5180.248863914749, 5181.818636347747, 3584.623614520464, 3635.818209089535, 3640.381135207021, 3642.4354225095153, 3644.7630903991158, 5371.140617501181, 5380.677159370451, 5399.649022813504, 5458.590605704588, 5475.698836563987, 3759.962400376016, 3767.9246415072093, 3775.131719704483, 3776.86780962665, 3786.8863934082024, 3821.5796262411113, 3823.235352929425, 3832.156925476391, 3862.4550179928256, 3866.2654095721723, 4256.808443619982, 4386.539413361615, 4410.757408342572, 4411.117776444724, 4445.2887537993765, 5159.781294043522, 5201.713905735221, 5212.687238765686, 5219.712915789592, 5226.712530810842, 1254.4856608790353, 1295.2099219476113, 1303.3548393545066, 1324.7681655710212, 1342.6441992871896, 832.7543374704477, 837.0583094019229, 842.1452225990624, 851.4125253575013, 856.2422256303216, 4130.380442933584, 4132.855350062733, 4139.9793001035405, 4145.647619952338, 4152.771597562163, 4645.0, 4700.0, 4739.7439678485225, 4764.595009424169, 4796.544328288876, 4000.3998400639975, 4071.3689378146437, 4104.445899803548, 4107.363358679409, 4121.216968775923, 2326.4998025424616, 2466.161505088243, 2515.4843257132243, 2524.899004039818, 2538.923832285034, 4414.337849322563, 4427.380166776654, 4445.155100735532, 4447.642749342854, 4447.822087116479, 4769.260764581495, 4801.831935882227, 4802.831900883522, 4832.95167048332, 4834.0, 4431.135928493913, 4433.763352752509, 4670.626349892001, 5101.336826212569, 5104.285400044071, 5372.221027951004, 5375.1131063374105, 5429.457054294539, 5430.321209848769, 5442.482964118402, 5306.575473961997, 5316.548093412103, 5321.7759915220495, 5358.705271210121, 5364.865878353073, 4952.182889823139, 5031.6226283029655, 5066.544011039025, 5077.847664570068, 5104.464031276662, 3744.0, 3746.2882052409955, 3754.849806007729, 3776.0937375030344, 3780.5652349980105, 5133.767895705078, 5357.866053348697, 5388.38033626138, 5423.942331245369, 5432.945670543402, 4966.304717339648, 5167.61242906776, 5179.20323025577, 5179.404368497671, 5182.041322355376, 5155.808781268021, 5178.300929374486, 5249.580033597379, 5252.947470525399, 5262.947370526399, 4853.296272040464, 5118.641695081308, 5170.466471428897, 5170.508801663836, 5183.5593974512585, 5203.843884683465, 5206.609504287269, 5207.114790485551, 5213.765380557808, 5233.450487698889, 5107.336046313955, 5114.9232761507865, 5119.974400127976, 5132.870768430939, 5137.075326441127], "value": 3821.1448142901554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.9966850165748, 671.7648822911979, 679.6329981809823, 713.0302788208036, 738.2654259012282, 12394.132410731241, 13356.59930202093, 13358.866411335885, 13363.131396459235, 13388.397522111503, 12065.276083435, 12157.209781364205, 12168.148229623908, 12186.51253949841, 12899.806502902464, 787.3071696906715, 796.8884356190138, 797.4059325802285, 797.5095316380442, 797.6171437709903, 632.1024145713076, 769.2154002917022, 782.86299897518, 792.7938735928642, 798.8202654402742, 835.0897521701345, 838.5429940682312, 838.6393850644221, 839.6011894350165, 840.2060053249681, 819.635262308273, 820.1675299570941, 821.3880658909151, 821.6302663801254, 822.173715416009, 482.1201307613619, 589.4164776870867, 596.9522438204976, 601.9488343490765, 605.4339192854695, 13119.47522099115, 13147.211167329991, 13280.269585172811, 13298.800517992238, 13370.665733356744, 11251.54993800247, 12202.0, 12356.567520136752, 12431.37843107841, 12478.126531142823, 11823.527058917633, 11865.288082714978, 11929.880701193051, 11988.460519276654, 12056.758864822654, 4147.232761939051, 4170.833166673329, 4193.937090943638, 4199.370094485821, 4280.978595107004, 57617.42382576162, 58776.70611646957, 60056.399436005515, 60320.39679603191, 60638.0, 10133.543990520444, 10171.64399246023, 10206.642767503101, 10254.6410875619, 10381.532831022621, 17767.28930842778, 17777.644447110986, 17788.110594470225, 17828.10859457048, 17852.01813900248, 7034.120734908137, 7261.927380726231, 7331.523450975669, 7388.44586656003, 7395.8151046224275, 3872.244912242086, 3963.603639636013, 4000.5599384067727, 4060.045889216032, 4097.180563887235, 2926.9121926342245, 3069.9539506907413, 3070.4933685942015, 3071.8617662205256, 3074.6310442747013, 507.8936796004346, 518.5566340778655, 526.3131613244676, 527.9102552566073, 547.6741338903425, 554.4400155842628, 637.3849235487777, 643.6620774093639, 653.4054010850103, 655.7770358078276, 8021.478603890729, 8164.67341306353, 8311.293540049042, 8508.021577518664, 8509.531975741269, 544.3739699345705, 599.307799491588, 613.736093479808, 615.4399496458202, 623.1213988276598, 3962.663173630216, 4049.0687141957515, 4178.415021896937, 4204.621584057389, 4252.766097864585, 76217.23782762213, 92089.53955230181, 92175.0, 95219.0, 97092.51453742686, 74863.62568187124, 77393.61303193448, 78934.605326973, 79334.60332698416, 79378.60310698525, 69190.0, 69214.65392673004, 69607.65196173987, 70301.64849175721, 71044.0, 8092.878606820785, 8287.0, 8358.205970432798, 8419.8737018946, 8428.45215061019, 37562.81218593889, 41850.37224441697, 41865.58134418617, 41892.0, 43985.12029759451, 39737.80131099326, 51939.286678466095, 53043.93912121813, 57818.42181578299, 58770.0, 11413.258138220988, 11491.482883270106, 11572.132090093108, 11798.115141364604, 11989.880101199225, 13151.34243287851, 13177.0, 13208.471661133448, 13222.206667599974, 13415.242733950643, 11766.52933882635, 12231.388430578258, 12254.75490490203, 12356.752864942471, 12988.0, 11525.079516776867, 12284.447199875849, 12386.62840114798, 12494.125411221126, 12693.682657933625, 11864.881351186377, 11983.400829958642, 12020.879791201976, 12140.817887731868, 12584.056195785535, 10119.241056920613, 10129.544170512198, 10358.948205258925, 10448.582056717647, 10508.947455262674, 9703.369280996994, 10211.285210035227, 10453.163746900078, 10494.895051049698, 10536.947315263375], "value": 6630.979173331179, "unit": "score"}], "name": "dromaeo_css", "value": 6440.71249596227, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 113.0, 119.0, 114.0, 114.0, 116.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 131.0, 135.0, 193.0, 131.0, 132.0, 152.0, 134.0, 188.0, 129.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 161.0, 162.0, 161.0, 163.0, 160.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 105.0, 76.0, 83.0, 74.0, 76.0, 100.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 116.0, 93.0, 86.0, 86.0, 123.0, 84.0, 87.0, 124.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 74.0, 64.0, 65.0, 63.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 64.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 80.0, 82.0, 82.0, 83.0, 84.0, 83.0, 92.0, 88.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 140.0, 145.0, 128.0, 140.0, 132.0, 130.0, 142.0, 135.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 170.0, 172.0, 169.0, 167.0, 169.0, 169.0, 168.0, 164.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 69.0, 66.0, 68.0, 66.0, 66.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1547.4, "alertThreshold": 2.0}]} 06:19:10 INFO - Return code: 0 06:19:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:19:10 INFO - # TBPL SUCCESS # 06:19:10 INFO - Running post-action listener: _resource_record_post_action 06:19:10 INFO - ##### 06:19:10 INFO - ##### Finished run-tests step (success) 06:19:10 INFO - ##### 06:19:10 INFO - Running post-run listener: _resource_record_post_run 06:19:10 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 560889856; Read time: 176; Write time: 584168 06:19:10 INFO - TinderboxPrint: CPU usage
13.2% 06:19:10 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 06:19:10 INFO - TinderboxPrint: I/O write bytes / time
560,889,856 / 584,168 06:19:10 INFO - TinderboxPrint: CPU idle
8,323.9 (86.8%) 06:19:10 INFO - TinderboxPrint: CPU user
1,219.7 (12.7%) 06:19:10 INFO - TinderboxPrint: Swap in / out
0 / 0 06:19:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 208367616; Read time: 0; Write time: 304524 06:19:10 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 298213376; Read time: 176; Write time: 262152 06:19:11 INFO - Running post-run listener: _upload_blobber_files 06:19:11 INFO - Blob upload gear active. 06:19:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:19:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:19:11 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'] 06:19:11 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 06:19:11 INFO - (blobuploader) - INFO - Open directory for files ... 06:19:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:19:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:19:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:12 INFO - (blobuploader) - INFO - Done attempting. 06:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:19:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:15 INFO - (blobuploader) - INFO - Done attempting. 06:19:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:19:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:19:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:16 INFO - (blobuploader) - INFO - Done attempting. 06:19:16 INFO - (blobuploader) - INFO - Iteration through files over. 06:19:16 INFO - Return code: 0 06:19:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:19:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:19:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc8bd23b393eea5adaa6a331b7d7f7122acf58483624e1e5310c50328e1838d30a48ff487ccc4113f5d8d343851e47b3f5aa635f6e75079b42f59ebbf0a5fcc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16e059cde2e218f3f7dd1cfd749cab411e8ad3c8b66cdf4ce81283f898dfd21b68a99a37ca35a607e539c564c6ac67dc37d5b7dac43fc6a64ef4aedb99dea559", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3da6708664ed6cb9d33c3a078fe4d374e6329e5d19e81ff1285cb2fd6dde5aa1b3fd58f335f9c98ab6443685b6a377096eb2e3ae820240414601a074397d6c36"} 06:19:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:19:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:19:16 INFO - Contents: 06:19:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc8bd23b393eea5adaa6a331b7d7f7122acf58483624e1e5310c50328e1838d30a48ff487ccc4113f5d8d343851e47b3f5aa635f6e75079b42f59ebbf0a5fcc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16e059cde2e218f3f7dd1cfd749cab411e8ad3c8b66cdf4ce81283f898dfd21b68a99a37ca35a607e539c564c6ac67dc37d5b7dac43fc6a64ef4aedb99dea559", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3da6708664ed6cb9d33c3a078fe4d374e6329e5d19e81ff1285cb2fd6dde5aa1b3fd58f335f9c98ab6443685b6a377096eb2e3ae820240414601a074397d6c36"} 06:19:16 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:16 INFO - Copying logs to upload dir... 06:19:16 INFO - mkdir: /builds/slave/test/build/upload/logs 06:19:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.602034 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-22 06:19:15.267881) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 06:19:15.272590) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc8bd23b393eea5adaa6a331b7d7f7122acf58483624e1e5310c50328e1838d30a48ff487ccc4113f5d8d343851e47b3f5aa635f6e75079b42f59ebbf0a5fcc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16e059cde2e218f3f7dd1cfd749cab411e8ad3c8b66cdf4ce81283f898dfd21b68a99a37ca35a607e539c564c6ac67dc37d5b7dac43fc6a64ef4aedb99dea559", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3da6708664ed6cb9d33c3a078fe4d374e6329e5d19e81ff1285cb2fd6dde5aa1b3fd58f335f9c98ab6443685b6a377096eb2e3ae820240414601a074397d6c36"} build_url:https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/YDEEvldwTe2Lu5e4NmqqZw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc8bd23b393eea5adaa6a331b7d7f7122acf58483624e1e5310c50328e1838d30a48ff487ccc4113f5d8d343851e47b3f5aa635f6e75079b42f59ebbf0a5fcc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16e059cde2e218f3f7dd1cfd749cab411e8ad3c8b66cdf4ce81283f898dfd21b68a99a37ca35a607e539c564c6ac67dc37d5b7dac43fc6a64ef4aedb99dea559", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3da6708664ed6cb9d33c3a078fe4d374e6329e5d19e81ff1285cb2fd6dde5aa1b3fd58f335f9c98ab6443685b6a377096eb2e3ae820240414601a074397d6c36"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 06:19:15.303675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:19:15.304026) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466600087.209793-1894438310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:19:15.386456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 06:19:15.386782) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 06:19:15.387163) ========= ========= Total master_lag: 0.23 =========