builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1465858119.04 results: success (0) buildid: 20160613143625 builduid: 60fd068ff89041ce9050672cf9ab21e0 revision: 511d102e76439b864de39dc6b9f7fff3155bfb2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:39.038706) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:39.039188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:39.039554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:39.077926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:39.078287) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 15:48:39-- 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% 218M=0s 2016-06-13 15:48:39 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:39.177277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:39.177621) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018657 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:39.227165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-13 15:48:39.227542) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 511d102e76439b864de39dc6b9f7fff3155bfb2a --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 511d102e76439b864de39dc6b9f7fff3155bfb2a --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=5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 15:48:39,825 truncating revision to first 12 chars 2016-06-13 15:48:39,825 Setting DEBUG logging. 2016-06-13 15:48:39,825 attempt 1/10 2016-06-13 15:48:39,825 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/511d102e7643?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 15:48:40,143 unpacking tar archive at: fx-team-511d102e7643/testing/mozharness/ program finished with exit code 0 elapsedTime=1.110259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-13 15:48:40.351813) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:40.352175) ========= script_repo_revision: 511d102e76439b864de39dc6b9f7fff3155bfb2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:40.352678) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:40.352997) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 15:48:40.362496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-13 15:48:40.362829) ========= /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=5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:48:41 INFO - MultiFileLogger online at 20160613 15:48:41 in /builds/slave/test 15:48:41 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 15:48:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:41 INFO - {'append_to_log': False, 15:48:41 INFO - 'base_work_dir': '/builds/slave/test', 15:48:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:48:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:41 INFO - 'branch': 'Fx-Team-Non-PGO', 15:48:41 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:41 INFO - 'config_files': ('talos/linux_config.py',), 15:48:41 INFO - 'default_actions': ('clobber', 15:48:41 INFO - 'read-buildbot-config', 15:48:41 INFO - 'download-and-extract', 15:48:41 INFO - 'populate-webroot', 15:48:41 INFO - 'create-virtualenv', 15:48:41 INFO - 'install', 15:48:41 INFO - 'run-tests'), 15:48:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:41 INFO - 'download_minidump_stackwalk': True, 15:48:41 INFO - 'download_symbols': 'ondemand', 15:48:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:48:41 INFO - 'tooltool.py': '/tools/tooltool.py', 15:48:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:48:41 INFO - '/tools/misc-python/virtualenv.py')}, 15:48:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:41 INFO - 'installer_path': 'installer.exe', 15:48:41 INFO - 'log_level': 'info', 15:48:41 INFO - 'log_name': 'talos', 15:48:41 INFO - 'log_to_console': True, 15:48:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:48:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:48:41 INFO - 'opt_config_files': (), 15:48:41 INFO - 'pip_index': False, 15:48:41 INFO - 'sps_profile': False, 15:48:41 INFO - 'sps_profile_interval': 0, 15:48:41 INFO - 'suite': 'dromaeojs', 15:48:41 INFO - 'system_bits': '32', 15:48:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:41 INFO - 'title': 'talos-linux64-ix-011', 15:48:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:41 INFO - 'use_talos_json': True, 15:48:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:41 INFO - 'work_dir': 'build'} 15:48:41 INFO - ##### 15:48:41 INFO - ##### Running clobber step. 15:48:41 INFO - ##### 15:48:41 INFO - Running pre-action listener: _resource_record_pre_action 15:48:41 INFO - Running main action method: clobber 15:48:41 INFO - rmtree: /builds/slave/test/build 15:48:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:41 INFO - Running post-action listener: _resource_record_post_action 15:48:41 INFO - ##### 15:48:41 INFO - ##### Finished clobber step (success) 15:48:41 INFO - ##### 15:48:41 INFO - ##### 15:48:41 INFO - ##### Running read-buildbot-config step. 15:48:41 INFO - ##### 15:48:41 INFO - Running pre-action listener: _resource_record_pre_action 15:48:41 INFO - Running main action method: read_buildbot_config 15:48:41 INFO - Using buildbot properties: 15:48:41 INFO - { 15:48:41 INFO - "project": "", 15:48:41 INFO - "product": "firefox", 15:48:41 INFO - "script_repo_revision": "production", 15:48:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:48:41 INFO - "repository": "", 15:48:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:48:41 INFO - "buildid": "20160613143625", 15:48:41 INFO - "pgo_build": "False", 15:48:41 INFO - "basedir": "/builds/slave/test", 15:48:41 INFO - "buildnumber": 3083, 15:48:41 INFO - "slavename": "talos-linux64-ix-011", 15:48:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:48:41 INFO - "platform": "ubuntu64_hw", 15:48:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:48:41 INFO - "branch": "fx-team", 15:48:41 INFO - "repo_path": "integration/fx-team", 15:48:41 INFO - "revision": "511d102e76439b864de39dc6b9f7fff3155bfb2a", 15:48:41 INFO - "stage_platform": "linux64", 15:48:41 INFO - "builduid": "60fd068ff89041ce9050672cf9ab21e0", 15:48:41 INFO - "slavebuilddir": "test" 15:48:41 INFO - } 15:48:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:48:41 INFO - Running post-action listener: _resource_record_post_action 15:48:41 INFO - ##### 15:48:41 INFO - ##### Finished read-buildbot-config step (success) 15:48:41 INFO - ##### 15:48:41 INFO - ##### 15:48:41 INFO - ##### Running download-and-extract step. 15:48:41 INFO - ##### 15:48:41 INFO - Running pre-action listener: _resource_record_pre_action 15:48:41 INFO - Running main action method: download_and_extract 15:48:41 INFO - mkdir: /builds/slave/test/build/tests 15:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:41 INFO - https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:48:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:42 INFO - Downloaded 1361 bytes. 15:48:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:42 INFO - Using the following test package requirements: 15:48:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:48:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:48:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:42 INFO - u'jsshell-linux-x86_64.zip'], 15:48:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:48:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:48:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:48:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:48:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:48:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:42 INFO - https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:44 INFO - Downloaded 22651503 bytes. 15:48:44 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'] 15:48:44 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 15:48:45 INFO - Return code: 0 15:48:45 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 15:48: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')]} 15:48:45 INFO - https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:53 INFO - Downloaded 22651503 bytes. 15:48:53 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'] 15:48:53 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 15:48:54 INFO - Return code: 0 15:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:54 INFO - https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:48:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:55 INFO - Downloaded 14405384 bytes. 15:48:55 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'] 15:48:55 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 15:48:56 INFO - Return code: 0 15:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:56 INFO - https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:48:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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 15:48:58 INFO - Downloaded 55398717 bytes. 15:48:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:58 INFO - mkdir: /builds/slave/test/properties 15:48:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:58 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:58 INFO - Contents: 15:48:58 INFO - build_url:https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:59 INFO - Running post-action listener: _resource_record_post_action 15:48:59 INFO - Running post-action listener: set_extra_try_arguments 15:48:59 INFO - ##### 15:48:59 INFO - ##### Finished download-and-extract step (success) 15:48:59 INFO - ##### 15:48:59 INFO - ##### 15:48:59 INFO - ##### Running populate-webroot step. 15:48:59 INFO - ##### 15:48:59 INFO - Running pre-action listener: _resource_record_pre_action 15:48:59 INFO - Running main action method: populate_webroot 15:48:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:48:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:48:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:48:59 INFO - '--tppagecycles', 15:48:59 INFO - '7'], 15:48:59 INFO - 'tests': ['tsvgm']}}, 15:48:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:48:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:48:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:59 INFO - 'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:59 INFO - 'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['damp', 'tps']}, 15:48:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:59 INFO - 'tests': ['damp', 'tps']}, 15:48:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['dromaeo_dom']}, 15:48:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['basic_compositor_video']}, 15:48:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:48:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['a11yr', 15:48:59 INFO - 'ts_paint', 15:48:59 INFO - 'tpaint', 15:48:59 INFO - 'sessionrestore', 15:48:59 INFO - 'sessionrestore_no_auto_restore', 15:48:59 INFO - 'tabpaint']}, 15:48:59 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:59 INFO - 'ts_paint', 15:48:59 INFO - 'tpaint', 15:48:59 INFO - 'sessionrestore', 15:48:59 INFO - 'sessionrestore_no_auto_restore', 15:48:59 INFO - 'tabpaint']}, 15:48:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:48:59 INFO - 'ts_paint', 15:48:59 INFO - 'tpaint', 15:48:59 INFO - 'sessionrestore', 15:48:59 INFO - 'sessionrestore_no_auto_restore', 15:48:59 INFO - 'tabpaint']}, 15:48:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:48:59 INFO - 'ts_paint', 15:48:59 INFO - 'tpaint', 15:48:59 INFO - 'sessionrestore', 15:48:59 INFO - 'sessionrestore_no_auto_restore', 15:48:59 INFO - 'tabpaint']}, 15:48:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['a11yr', 15:48:59 INFO - 'ts_paint', 15:48:59 INFO - 'tpaint', 15:48:59 INFO - 'sessionrestore', 15:48:59 INFO - 'sessionrestore_no_auto_restore', 15:48:59 INFO - 'tabpaint']}, 15:48:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['a11yr', 15:48:59 INFO - 'ts_paint', 15:48:59 INFO - 'tpaint', 15:48:59 INFO - 'sessionrestore', 15:48:59 INFO - 'sessionrestore_no_auto_restore', 15:48:59 INFO - 'tabpaint']}, 15:48:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['tsvgx', 15:48:59 INFO - 'tsvgr_opacity', 15:48:59 INFO - 'tart', 15:48:59 INFO - 'tscrollx', 15:48:59 INFO - 'cart']}, 15:48:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:59 INFO - 'tsvgr_opacity', 15:48:59 INFO - 'tart', 15:48:59 INFO - 'tscrollx', 15:48:59 INFO - 'cart']}, 15:48:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:59 INFO - 'talos_options': ['--disable-e10s'], 15:48:59 INFO - 'tests': ['tp5o']}, 15:48:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:59 INFO - 'tests': ['tp5o']}, 15:48:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:59 INFO - 'talos_options': ['--disable-e10s', 15:48:59 INFO - '--xperf_path', 15:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:59 INFO - 'tests': ['tp5n']}, 15:48:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:59 INFO - 'talos_options': ['--xperf_path', 15:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:59 INFO - 'tests': ['tp5n']}}, 15:48:59 INFO - 'talos.zip': {'path': '', 15:48:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:48:59 INFO - Running post-action listener: _resource_record_post_action 15:48:59 INFO - ##### 15:48:59 INFO - ##### Finished populate-webroot step (success) 15:48:59 INFO - ##### 15:48:59 INFO - ##### 15:48:59 INFO - ##### Running create-virtualenv step. 15:48:59 INFO - ##### 15:48:59 INFO - Running pre-action listener: _resource_record_pre_action 15:48:59 INFO - Running main action method: create_virtualenv 15:48:59 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:59 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 15:48:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:59 INFO - Using real prefix '/usr' 15:48:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:59 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:01 INFO - Installing pip.................done. 15:49:01 INFO - Return code: 0 15:49:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:01 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')]} 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:01 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')]} 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:01 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 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49:01 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 15:49:01 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 15:49:01 INFO - Using env: {'DISPLAY': ':0', 15:49:01 INFO - 'HOME': '/home/cltbld', 15:49:01 INFO - 'LANG': 'en_US.UTF-8', 15:49:01 INFO - 'LANGUAGE': 'en_US:en', 15:49:01 INFO - 'LOGNAME': 'cltbld', 15:49:01 INFO - 'MAIL': '/var/mail/cltbld', 15:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:01 INFO - 'MOZ_NO_REMOTE': '1', 15:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:01 INFO - 'NO_EM_RESTART': '1', 15:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:01 INFO - 'PWD': '/builds/slave/test', 15:49:01 INFO - 'SHELL': '/bin/bash', 15:49:01 INFO - 'SHLVL': '1', 15:49:01 INFO - 'TERM': 'linux', 15:49:01 INFO - 'TMOUT': '86400', 15:49:01 INFO - 'USER': 'cltbld', 15:49:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:01 INFO - '_': '/tools/buildbot/bin/python'} 15:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:01 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 15:49:01 INFO - Cleaning up... 15:49:01 INFO - Return code: 0 15:49:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:01 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')]} 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:01 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')]} 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:01 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 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49:01 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 15:49:01 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 15:49:01 INFO - Using env: {'DISPLAY': ':0', 15:49:01 INFO - 'HOME': '/home/cltbld', 15:49:01 INFO - 'LANG': 'en_US.UTF-8', 15:49:01 INFO - 'LANGUAGE': 'en_US:en', 15:49:01 INFO - 'LOGNAME': 'cltbld', 15:49:01 INFO - 'MAIL': '/var/mail/cltbld', 15:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:01 INFO - 'MOZ_NO_REMOTE': '1', 15:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:01 INFO - 'NO_EM_RESTART': '1', 15:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:01 INFO - 'PWD': '/builds/slave/test', 15:49:01 INFO - 'SHELL': '/bin/bash', 15:49:01 INFO - 'SHLVL': '1', 15:49:01 INFO - 'TERM': 'linux', 15:49:01 INFO - 'TMOUT': '86400', 15:49:01 INFO - 'USER': 'cltbld', 15:49:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:01 INFO - '_': '/tools/buildbot/bin/python'} 15:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:02 INFO - Downloading/unpacking psutil>=3.1.1 15:49:02 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 15:49:02 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 15:49:02 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 15:49:02 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 15:49:02 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 15:49:02 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 15:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:04 INFO - Installing collected packages: psutil 15:49:04 INFO - Running setup.py install for psutil 15:49:04 INFO - building 'psutil._psutil_linux' extension 15:49:04 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 15:49:04 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 15:49:04 INFO - building 'psutil._psutil_posix' extension 15:49:04 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 15:49:04 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 15:49:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:04 INFO - Successfully installed psutil 15:49:04 INFO - Cleaning up... 15:49:04 INFO - Return code: 0 15:49:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:49: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 mozsystemmonitor==0.3 15:49:04 INFO - Using env: {'DISPLAY': ':0', 15:49:04 INFO - 'HOME': '/home/cltbld', 15:49:04 INFO - 'LANG': 'en_US.UTF-8', 15:49:04 INFO - 'LANGUAGE': 'en_US:en', 15:49:04 INFO - 'LOGNAME': 'cltbld', 15:49:04 INFO - 'MAIL': '/var/mail/cltbld', 15:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:04 INFO - 'MOZ_NO_REMOTE': '1', 15:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:04 INFO - 'NO_EM_RESTART': '1', 15:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:04 INFO - 'PWD': '/builds/slave/test', 15:49:04 INFO - 'SHELL': '/bin/bash', 15:49:04 INFO - 'SHLVL': '1', 15:49:04 INFO - 'TERM': 'linux', 15:49:04 INFO - 'TMOUT': '86400', 15:49:04 INFO - 'USER': 'cltbld', 15:49:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:04 INFO - '_': '/tools/buildbot/bin/python'} 15:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:04 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 15:49:04 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 15:49:04 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 15:49:04 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 15:49:04 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 15:49:04 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 15:49:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:06 INFO - Installing collected packages: mozsystemmonitor 15:49:06 INFO - Running setup.py install for mozsystemmonitor 15:49:06 INFO - Successfully installed mozsystemmonitor 15:49:06 INFO - Cleaning up... 15:49:06 INFO - Return code: 0 15:49:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:06 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')]} 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:06 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')]} 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:06 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 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49:06 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 15:49:06 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 15:49:06 INFO - Using env: {'DISPLAY': ':0', 15:49:06 INFO - 'HOME': '/home/cltbld', 15:49:06 INFO - 'LANG': 'en_US.UTF-8', 15:49:06 INFO - 'LANGUAGE': 'en_US:en', 15:49:06 INFO - 'LOGNAME': 'cltbld', 15:49:06 INFO - 'MAIL': '/var/mail/cltbld', 15:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:06 INFO - 'MOZ_NO_REMOTE': '1', 15:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:06 INFO - 'NO_EM_RESTART': '1', 15:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:06 INFO - 'PWD': '/builds/slave/test', 15:49:06 INFO - 'SHELL': '/bin/bash', 15:49:06 INFO - 'SHLVL': '1', 15:49:06 INFO - 'TERM': 'linux', 15:49:06 INFO - 'TMOUT': '86400', 15:49:06 INFO - 'USER': 'cltbld', 15:49:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:06 INFO - '_': '/tools/buildbot/bin/python'} 15:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:07 INFO - Downloading/unpacking jsonschema==2.5.1 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:08 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 15:49:08 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 15:49:08 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 15:49:08 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 15:49:08 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 15:49:08 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 15:49:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:09 INFO - warning: no files found matching '*.txt' 15:49:09 INFO - no previously-included directories found matching 'build' 15:49:09 INFO - no previously-included directories found matching 'dist' 15:49:09 INFO - no previously-included directories found matching '.git*' 15:49:09 INFO - Installing collected packages: jsonschema, functools32 15:49:09 INFO - Running setup.py install for functools32 15:49:09 INFO - warning: no files found matching '*.txt' 15:49:09 INFO - no previously-included directories found matching 'build' 15:49:09 INFO - no previously-included directories found matching 'dist' 15:49:09 INFO - no previously-included directories found matching '.git*' 15:49:09 INFO - Successfully installed jsonschema functools32 15:49:09 INFO - Cleaning up... 15:49:09 INFO - Return code: 0 15:49:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:09 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')]} 15:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:09 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')]} 15:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:09 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 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49:09 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 15:49:09 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 15:49:09 INFO - Using env: {'DISPLAY': ':0', 15:49:09 INFO - 'HOME': '/home/cltbld', 15:49:09 INFO - 'LANG': 'en_US.UTF-8', 15:49:09 INFO - 'LANGUAGE': 'en_US:en', 15:49:09 INFO - 'LOGNAME': 'cltbld', 15:49:09 INFO - 'MAIL': '/var/mail/cltbld', 15:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:09 INFO - 'MOZ_NO_REMOTE': '1', 15:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:09 INFO - 'NO_EM_RESTART': '1', 15:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:09 INFO - 'PWD': '/builds/slave/test', 15:49:09 INFO - 'SHELL': '/bin/bash', 15:49:09 INFO - 'SHLVL': '1', 15:49:09 INFO - 'TERM': 'linux', 15:49:09 INFO - 'TMOUT': '86400', 15:49:09 INFO - 'USER': 'cltbld', 15:49:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:09 INFO - '_': '/tools/buildbot/bin/python'} 15:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:09 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:09 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 15:49:09 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 15:49:09 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 15:49:09 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 15:49:09 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 15:49:09 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 15:49:11 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:11 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 15:49:11 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 15:49:11 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 15:49:11 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 15:49:11 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 15:49:11 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 15:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:12 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 15:49:12 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 15:49:12 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 15:49:12 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 15:49:12 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 15:49:12 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 15:49:12 INFO - Downloading docopt-0.6.1.tar.gz 15:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:12 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:12 INFO - Running setup.py install for blobuploader 15:49:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:12 INFO - Running setup.py install for requests 15:49:12 INFO - Running setup.py install for docopt 15:49:12 INFO - Successfully installed blobuploader requests docopt 15:49:12 INFO - Cleaning up... 15:49:12 INFO - Return code: 0 15:49:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:12 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')]} 15:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:12 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')]} 15:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:12 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 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49:12 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 15:49:12 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 15:49:12 INFO - Using env: {'DISPLAY': ':0', 15:49:12 INFO - 'HOME': '/home/cltbld', 15:49:12 INFO - 'LANG': 'en_US.UTF-8', 15:49:12 INFO - 'LANGUAGE': 'en_US:en', 15:49:12 INFO - 'LOGNAME': 'cltbld', 15:49:12 INFO - 'MAIL': '/var/mail/cltbld', 15:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:12 INFO - 'MOZ_NO_REMOTE': '1', 15:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:12 INFO - 'NO_EM_RESTART': '1', 15:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:12 INFO - 'PWD': '/builds/slave/test', 15:49:12 INFO - 'SHELL': '/bin/bash', 15:49:12 INFO - 'SHLVL': '1', 15:49:12 INFO - 'TERM': 'linux', 15:49:12 INFO - 'TMOUT': '86400', 15:49:12 INFO - 'USER': 'cltbld', 15:49:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:12 INFO - '_': '/tools/buildbot/bin/python'} 15:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:13 INFO - Running setup.py (path:/tmp/pip-hZFjcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:13 INFO - Running setup.py (path:/tmp/pip-UeJldv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:13 INFO - Running setup.py (path:/tmp/pip-nZJPQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:13 INFO - Running setup.py (path:/tmp/pip-t4ddEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:13 INFO - Running setup.py (path:/tmp/pip-RNPRsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:13 INFO - Running setup.py (path:/tmp/pip-2oU3cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:13 INFO - Running setup.py (path:/tmp/pip-S4_VVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:13 INFO - Running setup.py (path:/tmp/pip-XyhoYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:13 INFO - Running setup.py (path:/tmp/pip-6pLaFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:13 INFO - Running setup.py (path:/tmp/pip-uNs3L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:13 INFO - Running setup.py (path:/tmp/pip-RrKOFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:13 INFO - Running setup.py (path:/tmp/pip-p2Jx72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:14 INFO - Running setup.py (path:/tmp/pip-Z7iJbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:14 INFO - Running setup.py (path:/tmp/pip-dOLr_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:14 INFO - Running setup.py (path:/tmp/pip-TFJ_7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:14 INFO - Running setup.py (path:/tmp/pip-3IDoaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:14 INFO - Running setup.py (path:/tmp/pip-LdHXob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:14 INFO - Running setup.py install for manifestparser 15:49:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:14 INFO - Running setup.py install for mozcrash 15:49:14 INFO - Running setup.py install for mozdebug 15:49:14 INFO - Running setup.py install for mozdevice 15:49:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:49:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:14 INFO - Running setup.py install for mozfile 15:49:14 INFO - Running setup.py install for mozhttpd 15:49:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:14 INFO - Running setup.py install for mozinfo 15:49:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Running setup.py install for mozInstall 15:49:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Running setup.py install for mozleak 15:49:15 INFO - Running setup.py install for mozlog 15:49:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Running setup.py install for moznetwork 15:49:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Running setup.py install for mozprocess 15:49:15 INFO - Running setup.py install for mozprofile 15:49:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Running setup.py install for mozrunner 15:49:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:15 INFO - Running setup.py install for mozscreenshot 15:49:15 INFO - Running setup.py install for moztest 15:49:16 INFO - Running setup.py install for mozversion 15:49:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:16 INFO - Cleaning up... 15:49:16 INFO - Return code: 0 15:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:16 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 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49:16 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 15:49:16 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 15:49:16 INFO - Using env: {'DISPLAY': ':0', 15:49:16 INFO - 'HOME': '/home/cltbld', 15:49:16 INFO - 'LANG': 'en_US.UTF-8', 15:49:16 INFO - 'LANGUAGE': 'en_US:en', 15:49:16 INFO - 'LOGNAME': 'cltbld', 15:49:16 INFO - 'MAIL': '/var/mail/cltbld', 15:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:16 INFO - 'MOZ_NO_REMOTE': '1', 15:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:16 INFO - 'NO_EM_RESTART': '1', 15:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:16 INFO - 'PWD': '/builds/slave/test', 15:49:16 INFO - 'SHELL': '/bin/bash', 15:49:16 INFO - 'SHLVL': '1', 15:49:16 INFO - 'TERM': 'linux', 15:49:16 INFO - 'TMOUT': '86400', 15:49:16 INFO - 'USER': 'cltbld', 15:49:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:16 INFO - '_': '/tools/buildbot/bin/python'} 15:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:16 INFO - Running setup.py (path:/tmp/pip-kBpmj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:16 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)) 15:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:16 INFO - Running setup.py (path:/tmp/pip-ZDfj9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:16 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)) 15:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:16 INFO - Running setup.py (path:/tmp/pip-wBbeeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:16 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)) 15:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:16 INFO - Running setup.py (path:/tmp/pip-Q9q1Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:16 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)) 15:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:16 INFO - Running setup.py (path:/tmp/pip-5rDtsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:16 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)) 15:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:16 INFO - Running setup.py (path:/tmp/pip-yXkz84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:16 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)) 15:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:16 INFO - Running setup.py (path:/tmp/pip-dOPn2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:16 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)) 15:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:16 INFO - Running setup.py (path:/tmp/pip-X30tBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:16 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)) 15:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:16 INFO - Running setup.py (path:/tmp/pip-X77zwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:17 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)) 15:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:17 INFO - Running setup.py (path:/tmp/pip-6D2RXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:17 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)) 15:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:17 INFO - Running setup.py (path:/tmp/pip-F00D1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:17 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)) 15:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:17 INFO - Running setup.py (path:/tmp/pip-VoK26N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:17 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)) 15:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:17 INFO - Running setup.py (path:/tmp/pip-_fEnb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:17 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)) 15:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:17 INFO - Running setup.py (path:/tmp/pip-AFMRbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:17 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)) 15:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:17 INFO - Running setup.py (path:/tmp/pip-5jW7Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:17 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)) 15:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:17 INFO - Running setup.py (path:/tmp/pip-sKBg_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:17 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)) 15:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:17 INFO - Running setup.py (path:/tmp/pip-opjZd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:17 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)) 15:49:17 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)) 15:49:17 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)) 15:49:17 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)) 15:49:17 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)) 15:49:17 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)) 15:49:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:17 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 15:49:17 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 15:49:17 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 15:49:17 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 15:49:17 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 15:49:17 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 15:49:19 INFO - Downloading blessings-1.6.tar.gz 15:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:19 INFO - Installing collected packages: blessings 15:49:19 INFO - Running setup.py install for blessings 15:49:19 INFO - Successfully installed blessings 15:49:19 INFO - Cleaning up... 15:49:19 INFO - Return code: 0 15:49:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:20 INFO - Reading from file tmpfile_stdout 15:49:20 INFO - Current package versions: 15:49:20 INFO - argparse == 1.2.1 15:49:20 INFO - blessings == 1.6 15:49:20 INFO - blobuploader == 1.2.4 15:49:20 INFO - docopt == 0.6.1 15:49:20 INFO - functools32 == 3.2.3-2 15:49:20 INFO - jsonschema == 2.5.1 15:49:20 INFO - manifestparser == 1.1 15:49:20 INFO - mozInstall == 1.12 15:49:20 INFO - mozcrash == 0.17 15:49:20 INFO - mozdebug == 0.1 15:49:20 INFO - mozdevice == 0.48 15:49:20 INFO - mozfile == 1.2 15:49:20 INFO - mozhttpd == 0.7 15:49:20 INFO - mozinfo == 0.9 15:49:20 INFO - mozleak == 0.1 15:49:20 INFO - mozlog == 3.2 15:49:20 INFO - moznetwork == 0.27 15:49:20 INFO - mozprocess == 0.22 15:49:20 INFO - mozprofile == 0.28 15:49:20 INFO - mozrunner == 6.11 15:49:20 INFO - mozscreenshot == 0.1 15:49:20 INFO - mozsystemmonitor == 0.3 15:49:20 INFO - moztest == 0.7 15:49:20 INFO - mozversion == 1.4 15:49:20 INFO - psutil == 3.1.1 15:49:20 INFO - requests == 1.2.3 15:49:20 INFO - wsgiref == 0.1.2 15:49:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:20 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')]} 15:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:20 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')]} 15:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:20 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 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49:20 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 15:49:20 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 15:49:20 INFO - Using env: {'DISPLAY': ':0', 15:49:20 INFO - 'HOME': '/home/cltbld', 15:49:20 INFO - 'LANG': 'en_US.UTF-8', 15:49:20 INFO - 'LANGUAGE': 'en_US:en', 15:49:20 INFO - 'LOGNAME': 'cltbld', 15:49:20 INFO - 'MAIL': '/var/mail/cltbld', 15:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:20 INFO - 'MOZ_NO_REMOTE': '1', 15:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:20 INFO - 'NO_EM_RESTART': '1', 15:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:20 INFO - 'PWD': '/builds/slave/test', 15:49:20 INFO - 'SHELL': '/bin/bash', 15:49:20 INFO - 'SHLVL': '1', 15:49:20 INFO - 'TERM': 'linux', 15:49:20 INFO - 'TMOUT': '86400', 15:49:20 INFO - 'USER': 'cltbld', 15:49:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:20 INFO - '_': '/tools/buildbot/bin/python'} 15:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:20 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)) 15:49:20 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)) 15:49:20 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)) 15:49:20 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)) 15:49:20 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)) 15:49:20 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)) 15:49:20 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)) 15:49:20 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)) 15:49:20 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)) 15:49:20 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)) 15:49:20 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)) 15:49:20 INFO - Cleaning up... 15:49:20 INFO - Return code: 0 15:49:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:20 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')]} 15:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:20 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')]} 15:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:20 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 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49:20 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 15:49:20 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 15:49:20 INFO - Using env: {'DISPLAY': ':0', 15:49:20 INFO - 'HOME': '/home/cltbld', 15:49:20 INFO - 'LANG': 'en_US.UTF-8', 15:49:20 INFO - 'LANGUAGE': 'en_US:en', 15:49:20 INFO - 'LOGNAME': 'cltbld', 15:49:20 INFO - 'MAIL': '/var/mail/cltbld', 15:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:20 INFO - 'MOZ_NO_REMOTE': '1', 15:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:20 INFO - 'NO_EM_RESTART': '1', 15:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:20 INFO - 'PWD': '/builds/slave/test', 15:49:20 INFO - 'SHELL': '/bin/bash', 15:49:20 INFO - 'SHLVL': '1', 15:49:20 INFO - 'TERM': 'linux', 15:49:20 INFO - 'TMOUT': '86400', 15:49:20 INFO - 'USER': 'cltbld', 15:49:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:20 INFO - '_': '/tools/buildbot/bin/python'} 15:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:20 INFO - Cleaning up... 15:49:20 INFO - Return code: 0 15:49:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:49:20 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')]} 15:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:20 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')]} 15:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:20 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 0x7fec8bcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', '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 15:49:20 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 15:49:20 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 15:49:20 INFO - Using env: {'DISPLAY': ':0', 15:49:20 INFO - 'HOME': '/home/cltbld', 15:49:20 INFO - 'LANG': 'en_US.UTF-8', 15:49:20 INFO - 'LANGUAGE': 'en_US:en', 15:49:20 INFO - 'LOGNAME': 'cltbld', 15:49:20 INFO - 'MAIL': '/var/mail/cltbld', 15:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:20 INFO - 'MOZ_NO_REMOTE': '1', 15:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:20 INFO - 'NO_EM_RESTART': '1', 15:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:20 INFO - 'PWD': '/builds/slave/test', 15:49:20 INFO - 'SHELL': '/bin/bash', 15:49:20 INFO - 'SHLVL': '1', 15:49:20 INFO - 'TERM': 'linux', 15:49:20 INFO - 'TMOUT': '86400', 15:49:20 INFO - 'USER': 'cltbld', 15:49:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:20 INFO - '_': '/tools/buildbot/bin/python'} 15:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:20 INFO - Downloading/unpacking flake8 15:49:20 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 15:49:20 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 15:49:20 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 15:49:20 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 15:49:20 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 15:49:20 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 15:49:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:49:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:49:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 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 15:49:22 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 15:49:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:49:23 INFO - no previously-included directories found matching 'docs/_build' 15:49:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:49:23 INFO - Running setup.py install for pep8 15:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:49:23 INFO - no previously-included directories found matching 'docs/_build' 15:49:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:49:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:49:23 INFO - Cleaning up... 15:49:23 INFO - Return code: 0 15:49:23 INFO - Running post-action listener: _resource_record_post_action 15:49:23 INFO - Running post-action listener: _start_resource_monitoring 15:49:23 INFO - Starting resource monitoring. 15:49:23 INFO - ##### 15:49:23 INFO - ##### Finished create-virtualenv step (success) 15:49:23 INFO - ##### 15:49:23 INFO - ##### 15:49:23 INFO - ##### Running install step. 15:49:23 INFO - ##### 15:49:23 INFO - Running pre-action listener: _resource_record_pre_action 15:49:23 INFO - Running main action method: install 15:49:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:23 INFO - Reading from file tmpfile_stdout 15:49:23 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:23 INFO - Reading from file tmpfile_stdout 15:49:23 INFO - Output received: 15:49:23 INFO - Usage: mozinstall [options] installer 15:49:23 INFO - Options: 15:49:23 INFO - -h, --help show this help message and exit 15:49:23 INFO - -d DEST, --destination=DEST 15:49:23 INFO - Directory to install application into. [default: 15:49:23 INFO - "/builds/slave/test"] 15:49:23 INFO - --app=APP Application being installed. [default: firefox] 15:49:23 INFO - mkdir: /builds/slave/test/build/application 15:49:23 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'] 15:49:23 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 15:49:39 INFO - Reading from file tmpfile_stdout 15:49:39 INFO - Output received: 15:49:39 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:39 INFO - Running post-action listener: _resource_record_post_action 15:49:39 INFO - ##### 15:49:39 INFO - ##### Finished install step (success) 15:49:39 INFO - ##### 15:49:39 INFO - ##### 15:49:39 INFO - ##### Running run-tests step. 15:49:39 INFO - ##### 15:49:39 INFO - Running pre-action listener: _resource_record_pre_action 15:49:39 INFO - Running main action method: run_tests 15:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:39 INFO - Python 2.7.3 15:49:39 INFO - Return code: 0 15:49:39 INFO - grabbing minidump binary from tooltool 15:49: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')]} 15:49:39 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 0xeda1c0>, '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 0xedb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:39 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 15:49:39 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 15:49:39 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 15:49:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:39 INFO - Return code: 0 15:49:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:49:40 INFO - Return code: 0 15:49:40 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/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:49:40 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/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 15:49:40 INFO - Using env: {'DISPLAY': ':0', 15:49:40 INFO - 'HOME': '/home/cltbld', 15:49:40 INFO - 'LANG': 'en_US.UTF-8', 15:49:40 INFO - 'LANGUAGE': 'en_US:en', 15:49:40 INFO - 'LOGNAME': 'cltbld', 15:49:40 INFO - 'MAIL': '/var/mail/cltbld', 15:49:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:40 INFO - 'MOZ_NO_REMOTE': '1', 15:49:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:40 INFO - 'NO_EM_RESTART': '1', 15:49:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:40 INFO - 'PWD': '/builds/slave/test', 15:49:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:40 INFO - 'SHELL': '/bin/bash', 15:49:40 INFO - 'SHLVL': '1', 15:49:40 INFO - 'TERM': 'linux', 15:49:40 INFO - 'TMOUT': '86400', 15:49:40 INFO - 'USER': 'cltbld', 15:49:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931', 15:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:40 INFO - '_': '/tools/buildbot/bin/python'} 15:49:40 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/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:49:41 INFO - mozversion application_buildid: 20160613143625 15:49:41 INFO - mozversion application_changeset: 511d102e76439b864de39dc6b9f7fff3155bfb2a 15:49:41 INFO - mozversion application_display_name: Nightly 15:49:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:41 INFO - mozversion application_name: Firefox 15:49:41 INFO - mozversion application_remotingname: firefox 15:49:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:49:41 INFO - mozversion application_vendor: Mozilla 15:49:41 INFO - mozversion application_version: 50.0a1 15:49:41 INFO - mozversion platform_buildid: 20160613143625 15:49:41 INFO - mozversion platform_changeset: 511d102e76439b864de39dc6b9f7fff3155bfb2a 15:49:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:49:41 INFO - mozversion platform_version: 50.0a1 15:49:41 INFO - using testdate: 1465858181 15:49:41 INFO - actual date: 1465858181 15:49:41 INFO - starting webserver on 'localhost:34729' 15:49:41 INFO - SUITE-START | Running 2 tests 15:49:41 INFO - TEST-START | dromaeo_css 15:49:41 INFO - operating with platform_type : linux_ 15:49:41 INFO - Initialising browser for dromaeo_css test... 15:49:41 INFO - TEST-INFO | started process 18666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2i_fmz/profile http://localhost:34729/getInfo.html) 15:49:46 INFO - PROCESS | 18666 | __metrics Screen width/height:1600/1200 15:49:46 INFO - PROCESS | 18666 | colorDepth:24 15:49:46 INFO - PROCESS | 18666 | Browser inner width/height: 1024/697 15:49:46 INFO - PROCESS | 18666 | __metrics 15:49:48 INFO - PROCESS | 18666 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:49:48 INFO - PROCESS | 18666 | console.error: PushService: 15:49:48 INFO - PROCESS | 18666 | stateChangeProcessEnqueue: Error transitioning state 15:49:48 INFO - PROCESS | 18666 | UnknownError 15:49:48 INFO - TEST-INFO | 18666: exit 0 15:49:48 INFO - Browser initialized. 15:49:48 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:48 INFO - TEST-INFO | started process 18747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2i_fmz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:01 INFO - PROCESS | 18747 | RSS: Main: 178642944 15:50:01 INFO - PROCESS | 18747 | 15:50:52 INFO - PROCESS | 18747 | 1465858252062 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] 15:53:05 INFO - PROCESS | 18747 | Cycle 1(1): loaded http://localhost:34729/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34729/tests/dromaeo/cssquery-ext.html) 15:53:06 INFO - PROCESS | 18747 | RSS: Main: 254468096 15:53:06 INFO - PROCESS | 18747 | 15:56:09 INFO - PROCESS | 18747 | Cycle 1(1): loaded http://localhost:34729/tests/dromaeo/cssquery-ext.html (next: http://localhost:34729/tests/dromaeo/cssquery-jquery.html) 15:56:09 INFO - PROCESS | 18747 | RSS: Main: 256876544 15:56:09 INFO - PROCESS | 18747 | 15:59:12 INFO - PROCESS | 18747 | Cycle 1(1): loaded http://localhost:34729/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34729/tests/dromaeo/cssquery-mootools.html) 15:59:12 INFO - PROCESS | 18747 | RSS: Main: 264835072 15:59:12 INFO - PROCESS | 18747 | 16:02:14 INFO - PROCESS | 18747 | Cycle 1(1): loaded http://localhost:34729/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34729/tests/dromaeo/cssquery-prototype.html) 16:02:15 INFO - PROCESS | 18747 | RSS: Main: 262008832 16:02:15 INFO - PROCESS | 18747 | 16:05:18 INFO - PROCESS | 18747 | Cycle 1(1): loaded http://localhost:34729/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34729/tests/dromaeo/cssquery-yui.html) 16:05:19 INFO - PROCESS | 18747 | RSS: Main: 237154304 16:05:19 INFO - PROCESS | 18747 | 16:08:22 INFO - PROCESS | 18747 | Cycle 1(1): loaded http://localhost:34729/tests/dromaeo/cssquery-yui.html (next: http://localhost:34729/tests/dromaeo/cssquery-dojo.html) 16:08:22 INFO - PROCESS | 18747 | RSS: Main: 325345280 16:08:22 INFO - PROCESS | 18747 | 16:08:22 INFO - PROCESS | 18747 | __start_tp_report 16:08:22 INFO - PROCESS | 18747 | _x_x_mozilla_page_load 16:08:22 INFO - PROCESS | 18747 | _x_x_mozilla_page_load_details 16:08:22 INFO - PROCESS | 18747 | |i|pagename|runs| 16:08:22 INFO - PROCESS | 18747 | |0;dojo.html;2623.5015347084054;2642.5111354399423;2667.5998600209973;2672.1449136276387;2677.491276657435;4641.048585040067;4707.62339012879;4736.2658787887885;4810.518948105183;4864.318995340651;4732.242841145408;4746.050789842028;4779.330893674888;4819.8795030124265;4824.831130910419;4337.175936572057;4409.074094440171;4420.955790442103;4449.26587113126;4611.1469378164975;4513.977430112861;4552.613027892633;4568.086382723469;4575.908481830362;4601.217792975185;4295.72077814941;4336.479622445327;4351.108022855307;4353.717008394444;4391.824327026915;4312.892177695583;4343.239933011742;4350.456192975878;4383.671224658164;4385.736855788663;4361.5856493633055;4374.321980093091;4386.210482113218;4416.80124394403;4431.556844315543;4629.467611224685;4680.695754775928;4776.355192049064;4777.450593181794;4859.1010663027455;5113.769880355393;5154.664946778447;5162.148245539482;5168.069747445458;5176.7411629418375;5094.108531007059;5163.3545806774155;5179.119549676564;5183.041137389595;5214.243934629458;4688.226442636995;4799.0401919616215;4825.95174048262;4879.2925025871045;4882.926756098661;5395.81114660985;5417.972910135424;5424.701641409761;5425.348958125051;5431.538319242909;5164.586833053347;5191.97404012985;5200.7919683213;5208.374995000624;5209.29674493946;4989.750512474362;5072.264521644341;5128.769205385766;5128.8461346159675;5200.453952335026;5099.337086178847;5101.20931255656;5102.336696229467;5105.591552675777;5120.718360490135;5081.695098294041;5086.491350864884;5086.694798312114;5088.643794934319;5128.512791284822;4180.623743863067;4218.8312467500955;4227.112306415687;4241.957580424218;4321.65426765858;3762.473253744478;3783.4135708965155;3801.904952376213;3804.0680033391995;3805.448210009533;4272.29507131326;4283;4285.935710964338;4287.228298906227;4289.099289149313;5130.666506677054;5164.1995490698255;5168.8966220675375;5171.63798534099;5202.167653175474;4290.699651024398;4322.524522302544;4354.477462704495;4373.387725718402;4406.845760398371;4525.864224073283;4609.815607375667;4612.7462989535225;4621.23749581322;4621.2837010263465;4807.158747219222;4842.370491836039;4849.903001940012;4851.442084160367;4901.534354236342;5165.276861239355;5182.481751824787;5189.532942035235;5190.532852043334;5240.266362709148;4697.13103075932;4814.398200224972;4841.709497430165;4842.322074909586;4899.093667671492;5117.078925793244;5126.512981266774;5129.615278854027;5139.2291156325355;5183.740812959412;5181.093308671043;5194.610404219774;5198.9740051299505;5200.193969934666;5228.215767634885;4898.4121905371585;4916.532929371704;4967.950320496749;4979.377577802775;5057.266696328938;4968.031233909497;4977.875553111201;4991.276264941635;4992.775325110306;5042.3949126103635;4879.219324907997;4915.97542012302;4966;4968.950310496849;4971.6022718183185;4903.656744027884;5000.874978125576;5004.549590536723;5065.062963351792;5083.2883396323805;4920.065187614342;4950.133726597903;4956;4979.128652485873;5023.196288593807 16:08:22 INFO - PROCESS | 18747 | |1;ext.html;552.8097024553882;585.5988647776273;590.9409059094091;595.2024287454809;602.1449541650856;28776.85611571942;38603.42094868576;39567;39678.60321396785;44144;40150;40418.59581404185;40447.59552404475;40460;40472.59527404725;7587.4688771785995;7802.492837965528;7945;7958.602069896511;9951.452670103141;10022.095801797635;10077.44574048427;10155.593776248941;10166.440845753481;10179.796404071914;10210.9489452553;10215.693529194099;10260.230482713789;10265.281430299881;10268.845967310497;7607.619619019027;9986.400815951067;10115.190784737204;10263.743406414826;10278.588856445807;10086.747831304276;10142.746431339201;10148.289619726622;10151.796964060752;10153.796924061551;37002.44496332557;37372;37381.43927841084;37414.25171496582;37416.812915935516;3135.4826453635123;3186.8725250989933;3225.8870939517005;3266.477363621833;3407.4037043517533;29144;29565.852170739225;29566.85216573925;29673.40653186924;29817.403651927056;3403.506491558735;3440.2947395784054;3453.4819777033395;3491.1097670093964;3511.9824400878088;260527;262086;262432;263256;263286;28279.575806362922;53840.730796345764;54046.459535404145;54558.45441545613;54602.72698636561;30018.84990575077;31768.682313177036;31775.205619859687;31869;31900.521492177635;12891.613251602466;13011.284379359036;13025.348732563334;13031.218126912416;13048.217106973612;8894.155055269739;10381.480925953672;10663.413512256746;10674.35953842772;10836;7771.844563108706;7772.65023073963;7793.552497959035;7881.724139655199;7893.407994400443;3060.127863558875;3098.4732595458827;3114.8442577871015;3143.795653282529;3171.6511183769767;882.9072947340566;896.8699538566872;958.9547393341292;982.6855406269925;1034.5861655337926;26550.203493895213;27633.309167270578;28085.43829123447;28182.85908570444;28345;923.1645360948353;994.8109859126743;1023.0383439566783;1026.9897301027042;1060.2631171335847;14451.49419770303;14855.702885942437;14865.182414967281;14988.175650339335;15093.849061509463;387355;387559;388069;389711;391701;47987.520124799004;48420.75789621029;48443.757781210865;48449;48529.27206091912;1069.2782371898936;1110.9333439993627;1199.5681554640496;1224.577520755338;1248.7814632439467;25426.364340891625;28455.28861778472;28563.714362856106;29022.709772902846;29079.563806542497;39938;40293.59706403016;40500.1899962005;40534.59465405308;40579.1884162321;282885;282978;283463.58268209355;284594;284935;22204.222852200095;23919.880400597885;24626.87686561556;24885.377865553506;25942.481150377265;40471.79764101161;40554;40898.1820363597;41643.58356416518;41880.58119418767;34605.653943460246;35097.47353789644;35570.82214589014;36059.63940360668;36265.81867090753;35432;35674.46488302626;35791.105222368606;35829.64170358367;36152.096197595274;34689.30621387609;35251.294974100885;35392.646073538934;35707.46438803368;35799.28401432009;30526.236844079074;31676.683233167372;31882.840585796923;32087.358252835278;32228.19429514281;24192;24582.754172458048;24701.135460258804;24714.876425617756;24859.254222373358 16:08:22 INFO - PROCESS | 18747 | |2;jquery.html;378.91219381209527;379.0864017717302;380.36668946204566;385.1891767828722;397.17982366413355;15646.706586826347;16926.23831927563;17226.88025278359;17480.999999999985;17494.562635934108;16066.437674681389;16627.168641567932;17062.232199551017;17083.06043167625;17102.401415950444;4595.471520775103;4728.976355118237;4758.738269395182;4761.523847615228;4765.26138448541;3451.758376913617;3636.4181730923056;5074.264231686403;5365.248865158881;5377.731113444332;5385.515303622673;5403.378611459673;5412;5453.072977593819;5454.91817622736;5240.29256050434;5337.439568845273;5371;5392.56859451243;5475.67145971241;5167.4057483389515;5204.4535323791215;5220.582353411718;5220.634555581073;5226.320578324831;12351.814722779165;12533.874661253452;12633;12642.683932901658;12665.430055647426;1861.5997560524552;1895.4976931113265;2044.1925439451481;2266.1542728101117;2425.0905910283645;9202;9282.582283797245;9587.472689002103;9801.362911410806;9816.558254878477;1766.443570275372;1775.698131317679;1827.0408035781188;1859.7489338939206;1863.7978503865068;60986;69083.65458172727;69330.65334673345;70460.64769676118;70615.64692176506;9066.592003359865;9340.252779777602;10258.17934565248;10304.587816487257;10352.844707329396;14148.292585370691;14265.78601320981;14275.929305301936;14317.92841035809;14329.426822926966;6924.099867017256;6974.16310042788;7125.394341481032;7233.710651573983;7384.667689953965;6300.30696623371;6445.129907462432;6467.482601391877;6473.158489396443;6583.210014798255;4372.497162826252;4454.866354009385;4456.665750068758;4470.441194850644;4536.705114167635;1641.8522332990087;1729.5935455168026;1823.5988082621802;1835.3928747675977;1844.492764489776;824.4640983360744;825.6821123867354;849.2993280543576;857.4640849469082;861.3798065392907;16645.167741613113;17226.96638201712;17230.827691722923;17577;17621.207045682975;845.9915400845913;869.2654706772767;876.4828751036919;889.1286539191628;906.9047749986156;9583;9658.75853103678;9826.557804898797;9907.54946302976;9907.554160062815;405902;407479;411235;412445;413616;71206;75649;77097.229027709;77826.61086694531;77935.61032194916;897.8383890899701;898.3711402018613;900.0369604523228;904.7014485219862;916.2029034739819;15249.23753812327;15366.615834604225;15394.692106158038;15526.534203973899;15782.289796958934;36534;36723.44914826333;36946.44580331351;37438.251234975694;37545.249095018495;44785.328220077376;46078.769606151756;49580;50397.24404134014;52115.47884521258;7515;7838.529688218725;7846.450748447553;7927.563983980936;8014.318782903519;10571.207159463225;11563.248388854698;11750.58872939443;11952.820707689565;12046.51813927433;9019;9246.537673116452;9307.06929307064;9955.153811926068;10006.249531285037;9387.530623468663;9962.452065136487;10125.291229613857;10209.897901020895;10468.895311046792;9368.203702685076;9610.855837162308;9685.757856053655;9969.950150249202;10168.644097456554;7531.887021694789;7664.80837979055;7810.062792464941;7921.485103468256;8119.878201826859;8806.515641639771;9444.858327125236;9658.79734509755;9714.805703886024;9769.218462523124 16:08:22 INFO - PROCESS | 18747 | |3;mootools.html;1181.686852983959;1375.456694605631;1380.5720226729713;1464.6265202373393;1694;6976.232614412417;7575.545467271968;7896.802579935505;7908.288254057141;8170;7991.800204994878;7992.960035199831;8052.355811535078;8054.91945080549;8057.234562716547;1878.8966606836618;2126.532162924162;2198.307533127064;2228.5097278598682;2232.486528098538;2168.27362833451;2209.5028618560855;2213.236433430464;2216.0360243294217;2217.7116974793253;2142.700021996922;2148.076327179312;2160.7191065161587;2190.6604476306197;2196.1544805249932;1866.206862083609;2080.8335333173463;2125.5961367340155;2133.935981920537;2171.7719639437946;2199.439143018536;2199.813015893635;2220.3560967319618;2225.2322948582714;2225.9109635614554;8055.718049868285;8115.3507719382305;8115.95942020292;8119.228673276029;8120.715774947848;4618.0763847230355;4722.220833562458;4732.479427262998;4734.2425211966265;4738.147133515966;2829.4579308127354;2872.3680790226117;2933.0760810344887;2940.162053814674;2944.8085874418093;845.218173189797;862.482510493705;885.0662551008684;889.3152272749946;890.9420887642283;10471;10526.894731052667;10532.684019479428;10549.578016879315;10554.525046372855;4150.315197992298;4202.705810593229;4292.742435453821;4295.3342231953475;4312.870613881526;9043.412178208395;9075.773105672279;9087.772805679911;9101.590428430736;9104.271658267322;4684.5549672781035;4697.31888876111;4697.577218050392;4702.529747025338;4703.435587729495;3889.9027524311555;4260.318349064135;4267.039916018933;4416.492103408149;4434.068845542472;3725.3108174987715;3728.9440658390145;3769.962300377016;3846.2307538492414;3852.075501879585;1200.6458094862037;1234.666640007193;1236.4003458322707;1244.55818184545;1244.7323825377587;838.0739283092096;843.2958479669422;845.9636944742764;861.9224269815621;871.4684042733927;5213.253560057347;5463.508284254357;5463.72681365938;5464.590155738256;5480.561555075585;432.56311125763204;434.99782501087293;441.69302334876954;850.4132148817296;950.7195377363694;3560.127768696634;3708.740388172856;3724.5158129443;3796.886093417202;3845.4616353710503;9839.754006149904;9979.850302245472;10002.849957250646;10099.545520451597;10116.59533618647;10042.246831487668;10060.195184385231;10071.093601575893;10077.143442807297;10081.294309398418;7304.561726296439;7367.152777430557;7533.397328213729;7536.397088232929;7538.660760265801;5238.659487133325;5256.842294731164;5352;5365.3293338332705;5497.862553436196;9058.50178240203;9220.585073671567;9238.9538052312;9322.673706420243;9353.39202951806;9107.635694572144;9299.535023248674;9432.717018489457;9439.622415103318;9442.669506567237;6720.630365329954;6773.221079575912;6906.37842594169;6917.23910369869;6920.688569014507;7324.340809327186;7333.303336183054;7364.15312239078;7368.889466658112;7384.815379615553;6974.825629359307;7024.789256322319;7042.964785176041;7138;7289.125304963226;6960.512764106464;6995.580265183901;7012.719491220294;7057.61183134912;7139.571625702474;6311.495080393649;6321.715522801393;6334.3665633436285;6371.585846919936;6374.394432528902;4586.610138138296;4597;4692.4369075709765;4706.858794236178;4782.545658162469;4585.082983403266;4626.1210370029585;4631.814727411001;4674.11191873543;4704.529547045268 16:08:22 INFO - PROCESS | 18747 | |4;prototype.html;297.7305538487668;304.32591809142747;306.43615747025467;313.8870006797554;315.34565776014773;4982.526659967301;4994.375703037121;4994.800207991676;4998;5020.246962955549;4895.559399654039;4929.7042177469375;4940.629452791046;4981.227909674007;4990.3762029746285;3652.2330310634734;3761.398176291794;3772.4155854541023;3883.8446462141483;3905.5508616509183;3855.7879316637573;3859.0931131184147;3864.9806750966345;3889.5527014393283;3906.980465097685;3648.908777280576;3837.424386342057;3838.5777564467885;3848.42273658952;3851.7111216658723;3672.5042119313816;3807.1814559869485;3840.6543411093135;3861.1891502784447;3863.594322596115;3405.8467368968454;3424.6061702904235;3426.9485957710654;3427.485877118452;3450.9654903450896;4824.758762061883;4843.4914333994775;4844.346013288232;4862.367892173995;4877.951220487821;4254.723442976197;4402.713823601455;4408.955910440886;4436.977815110936;4453.68408427619;5077.720725360104;5091.974540127313;5119.820806271762;5128.358955130609;5181.870453238662;3724.4971928789537;3726.925461490755;3738.719596030309;3756.7370284080125;3786.734928555002;5238.119034530992;5337.70642614656;5349.679019258857;5356.196570514454;5382.91925621116;3784.7918364489665;3785.848566057327;3796.430535419709;3802.1255111324;3812.8093595320124;3864.246471937945;3868.6324799144036;3870.1292209253256;3879.301725689403;3881.165549406891;4229.302165142717;4376.759278239664;4379.3649920761945;4406.810161256442;4422.943331350937;5119.491449189944;5165.690058596496;5170.302009228782;5182.6372153949615;5225.634205605571;1330.2351148089888;1343.1471015904776;1349.5479014530047;1355.153029356652;1366.6105160029344;876.2989608313324;901.5987885391069;918.4535201555065;947.4268067819008;948.4498990585582;4435.756033418128;4445.711028783118;4448.888777780517;4469.597736203757;4494.685372023927;5275.868103297448;5283.973580132151;5309.327561818015;5310.707911064928;5316.441773613792;4238.449001629769;4374.912501749947;4395.5714392822465;4430;4570;2787.3171073087224;2803.621511095976;2812.4656315300026;2836.7305106014896;2840.5881147233536;4935.185694360463;4953.374711402962;4958.330625365602;4988.176950803077;5015.147424937696;5259.789608415621;5446.514230892232;5456.427075157131;5523.585731070186;5557.527610153183;5008.69947803133;5044.672096313728;5047.671901326402;5054.7472626368535;5060.822871199491;5329.866753331198;5363.249145119608;5370.060239458157;5373.301470808926;5414.296141501737;5013.323201367769;5233.299177767317;5285.018118205673;5296.258523806593;5300.257963885137;4960.23116416956;4988.6757360771435;4998.6750861193905;5004.874878128076;5040.6471546992825;3771.642208804883;3802.372608519563;3802.4106263529197;3819.942700859545;3829.636184562462;5098.260752190986;5395.433479484597;5418.187271909245;5422.674639521641;5452.809151679672;5208.817691380784;5210.53105220532;5223.52988231061;5225.301776922592;5252.42223355423;5145.71698556568;5168.9741551292;5173.275741396283;5210.817621383233;5227.790888364423;4825.372701548777;4879;5040.823571174991;5096.694198348111;5118.181091025418;5059.873503162303;5182.352205974254;5271.71005594696;5277.815276465305;5320.44135365781;5099.311592935054;5103.8468845934685;5108.208227724708;5120.462351453044;5178.818741344035 16:08:22 INFO - PROCESS | 18747 | |5;yui.html;719.2447929673838;723.6707298179329;724.6738967464643;762.0893032825772;767.4436033875437;11533.65399038028;11900.285982841036;11984.340861252627;12290.385480725961;12673.49306027759;12700.237985720863;12781.105322627396;12920.806187907188;12922.999999999976;12956.805647915266;626.7618305044077;769.9153093159748;793.317746737805;804.6379129391768;806.0367860406816;798.0264077825044;801.6552882260626;805.899262592176;808.2321794295414;808.4219782855257;841.4194205997842;845.3701992015957;845.4208866926144;845.4884794699211;845.6490556419079;640.478010421505;800.803803068252;834.0825092398313;837.6691206973242;838.7777239031661;612.20107759374;612.8100288910452;612.9816105516842;613.1048668943304;613.1569092497815;12712.872871271262;12721.745565088739;12750.234985900875;12753.681157971032;12791.936040319832;11951.462184201644;12620.242785432903;12622;12845.421956011909;12910.225386476748;11343;11440;11487.885121148765;11544;11772.587959421378;4054.0878302382025;4153.54311025787;4187.350960601112;4197.391378250167;4233.174530966463;56493.152602710994;57372;57761.71119144419;57861.71069144669;57895;9976.45129517869;10005.149562287286;10017.348872323275;10103.51225384137;10153.13698335635;15951;16040.518784436486;16057.357705691642;16071.035737855766;16084.115373654327;6756.425703815231;6783.491238157059;6806.897896531556;6821.317868213139;7008.684609192598;3541.698955588804;3672.375696131664;3682.4660424238873;3720.3675375186285;3728.8694895678523;2797.9787377607436;2883.798134130591;2887.2637477443536;2891.3494463745487;2892.421515696869;504.2109099259647;513.9434662187157;526.6234642230747;530.5781903386817;531.8723506358446;491.54286513542746;556.4435564435564;563.6533531877866;568.4429259325884;576.9105788602774;6351.55539112267;6433.806985790434;6542.771003014872;7637.15991240963;7895.486793358528;498.6858279284028;527.6253859759614;544.6106034185497;552.2502209994095;559.580314763927;3497.1257185703575;3500.49242859789;3563.483294922222;3599.478075679064;3623.0580049186874;91649.54175229215;94474;96074;96149.51925240469;96974.51512742392;71450.2854971454;75653.24346756573;77026;78246.21753782502;79524.60237698775;73223.26776732164;73290.63354683299;74240.46234682972;75082.24917750862;75438.6228068867;7144.642767861482;7358.595277259588;7497.775066748006;7509.098908131059;7536.0956685198125;41597.79201103975;42379;43544;43576;44405.777971109936;61874.38125618686;61934.69032654808;62093;63076.684616576626;63717;9823.901760982299;9831.754206144618;9888.456134912649;9983.950080249553;10107.090361867467;10555.89444105549;10723.463826808784;10758.569657213937;10842.457877105955;10907.618233361794;9946.55240514193;10114.29199955996;10181;10305.690829275134;10631.149508039493;9663.27525435581;9787.951060244653;9797.804043918939;9822.55798489084;9932.00679932001;9019.278457723498;9318.440893546409;9510.667126650535;9516.048395160706;9519.952400237955;8000.759977200693;8139.674413023413;8226.62980165882;8587.355948303777;8779.209871111376;7954.070149580855;8758.82482350362;8766.167214114648;8933.553322333988;9102.635894564408 16:08:22 INFO - PROCESS | 18747 | __end_tp_report 16:08:22 INFO - PROCESS | 18747 | __start_cc_report 16:08:22 INFO - PROCESS | 18747 | _x_x_mozilla_cycle_collect,1109 16:08:22 INFO - PROCESS | 18747 | __end_cc_report 16:08:22 INFO - PROCESS | 18747 | __startTimestamp1465859302303__endTimestamp 16:08:22 INFO - PROCESS | 18747 | 16:08:22 INFO - PROCESS | 18747 | ------- Summary: start ------- 16:08:22 INFO - PROCESS | 18747 | Number of tests: 6 16:08:22 INFO - PROCESS | 18747 | 16:08:22 INFO - PROCESS | 18747 | [#0] dojo.html Cycles:165 Average:4745.42 Median:4879.29 stddev:522.52 (10.7%) stddev-sans-first:496.90 16:08:22 INFO - PROCESS | 18747 | Values: 2623.5 2642.5 2667.6 2672.1 2677.5 4641.0 4707.6 4736.3 4810.5 4864.3 4732.2 4746.1 4779.3 4819.9 4824.8 4337.2 4409.1 4421.0 4449.3 4611.1 4514.0 4552.6 4568.1 4575.9 4601.2 4295.7 4336.5 4351.1 4353.7 4391.8 4312.9 4343.2 4350.5 4383.7 4385.7 4361.6 4374.3 4386.2 4416.8 4431.6 4629.5 4680.7 4776.4 4777.5 4859.1 5113.8 5154.7 5162.1 5168.1 5176.7 5094.1 5163.4 5179.1 5183.0 5214.2 4688.2 4799.0 4826.0 4879.3 4882.9 5395.8 5418.0 5424.7 5425.3 5431.5 5164.6 5192.0 5200.8 5208.4 5209.3 4989.8 5072.3 5128.8 5128.8 5200.5 5099.3 5101.2 5102.3 5105.6 5120.7 5081.7 5086.5 5086.7 5088.6 5128.5 4180.6 4218.8 4227.1 4242.0 4321.7 3762.5 3783.4 3801.9 3804.1 3805.4 4272.3 4283.0 4285.9 4287.2 4289.1 5130.7 5164.2 5168.9 5171.6 5202.2 4290.7 4322.5 4354.5 4373.4 4406.8 4525.9 4609.8 4612.7 4621.2 4621.3 4807.2 4842.4 4849.9 4851.4 4901.5 5165.3 5182.5 5189.5 5190.5 5240.3 4697.1 4814.4 4841.7 4842.3 4899.1 5117.1 5126.5 5129.6 5139.2 5183.7 5181.1 5194.6 5199.0 5200.2 5228.2 4898.4 4916.5 4968.0 4979.4 5057.3 4968.0 4977.9 4991.3 4992.8 5042.4 4879.2 4916.0 4966.0 4969.0 4971.6 4903.7 5000.9 5004.5 5065.1 5083.3 4920.1 4950.1 4956.0 4979.1 5023.2 16:08:22 INFO - PROCESS | 18747 | 16:08:22 INFO - PROCESS | 18747 | [#1] ext.html Cycles:180 Average:45604.95 Median:31875.92 stddev:83375.37 (261.6%) stddev-sans-first:83540.65 16:08:22 INFO - PROCESS | 18747 | Values: 552.8 585.6 590.9 595.2 602.1 28776.9 38603.4 39567.0 39678.6 44144.0 40150.0 40418.6 40447.6 40460.0 40472.6 7587.5 7802.5 7945.0 7958.6 9951.5 10022.1 10077.4 10155.6 10166.4 10179.8 10210.9 10215.7 10260.2 10265.3 10268.8 7607.6 9986.4 10115.2 10263.7 10278.6 10086.7 10142.7 10148.3 10151.8 10153.8 37002.4 37372.0 37381.4 37414.3 37416.8 3135.5 3186.9 3225.9 3266.5 3407.4 29144.0 29565.9 29566.9 29673.4 29817.4 3403.5 3440.3 3453.5 3491.1 3512.0 260527.0 262086.0 262432.0 263256.0 263286.0 28279.6 53840.7 54046.5 54558.5 54602.7 30018.8 31768.7 31775.2 31869.0 31900.5 12891.6 13011.3 13025.3 13031.2 13048.2 8894.2 10381.5 10663.4 10674.4 10836.0 7771.8 7772.7 7793.6 7881.7 7893.4 3060.1 3098.5 3114.8 3143.8 3171.7 882.9 896.9 959.0 982.7 1034.6 26550.2 27633.3 28085.4 28182.9 28345.0 923.2 994.8 1023.0 1027.0 1060.3 14451.5 14855.7 14865.2 14988.2 15093.8 387355.0 387559.0 388069.0 389711.0 391701.0 47987.5 48420.8 48443.8 48449.0 48529.3 1069.3 1110.9 1199.6 1224.6 1248.8 25426.4 28455.3 28563.7 29022.7 29079.6 39938.0 40293.6 40500.2 40534.6 40579.2 282885.0 282978.0 283463.6 284594.0 284935.0 22204.2 23919.9 24626.9 24885.4 25942.5 40471.8 40554.0 40898.2 41643.6 41880.6 34605.7 35097.5 35570.8 36059.6 36265.8 35432.0 35674.5 35791.1 35829.6 36152.1 34689.3 35251.3 35392.6 35707.5 35799.3 30526.2 31676.7 31882.8 32087.4 32228.2 24192.0 24582.8 24701.1 24714.9 24859.3 16:08:22 INFO - PROCESS | 18747 | 16:08:22 INFO - PROCESS | 18747 | [#2] jquery.html Cycles:180 Average:24453.09 Median:5185.93 stddev:67579.61 (1303.1%) stddev-sans-first:67745.01 16:08:22 INFO - PROCESS | 18747 | Values: 378.9 379.1 380.4 385.2 397.2 15646.7 16926.2 17226.9 17481.0 17494.6 16066.4 16627.2 17062.2 17083.1 17102.4 4595.5 4729.0 4758.7 4761.5 4765.3 3451.8 3636.4 5074.3 5365.2 5377.7 5385.5 5403.4 5412.0 5453.1 5454.9 5240.3 5337.4 5371.0 5392.6 5475.7 5167.4 5204.5 5220.6 5220.6 5226.3 12351.8 12533.9 12633.0 12642.7 12665.4 1861.6 1895.5 2044.2 2266.2 2425.1 9202.0 9282.6 9587.5 9801.4 9816.6 1766.4 1775.7 1827.0 1859.7 1863.8 60986.0 69083.7 69330.7 70460.6 70615.6 9066.6 9340.3 10258.2 10304.6 10352.8 14148.3 14265.8 14275.9 14317.9 14329.4 6924.1 6974.2 7125.4 7233.7 7384.7 6300.3 6445.1 6467.5 6473.2 6583.2 4372.5 4454.9 4456.7 4470.4 4536.7 1641.9 1729.6 1823.6 1835.4 1844.5 824.5 825.7 849.3 857.5 861.4 16645.2 17227.0 17230.8 17577.0 17621.2 846.0 869.3 876.5 889.1 906.9 9583.0 9658.8 9826.6 9907.5 9907.6 405902.0 407479.0 411235.0 412445.0 413616.0 71206.0 75649.0 77097.2 77826.6 77935.6 897.8 898.4 900.0 904.7 916.2 15249.2 15366.6 15394.7 15526.5 15782.3 36534.0 36723.4 36946.4 37438.3 37545.2 44785.3 46078.8 49580.0 50397.2 52115.5 7515.0 7838.5 7846.5 7927.6 8014.3 10571.2 11563.2 11750.6 11952.8 12046.5 9019.0 9246.5 9307.1 9955.2 10006.2 9387.5 9962.5 10125.3 10209.9 10468.9 9368.2 9610.9 9685.8 9970.0 10168.6 7531.9 7664.8 7810.1 7921.5 8119.9 8806.5 9444.9 9658.8 9714.8 9769.2 16:08:22 INFO - PROCESS | 18747 | 16:08:22 INFO - PROCESS | 18747 | [#3] mootools.html Cycles:180 Average:5234.29 Median:4714.54 stddev:2965.38 (62.9%) stddev-sans-first:2958.06 16:08:22 INFO - PROCESS | 18747 | Values: 1181.7 1375.5 1380.6 1464.6 1694.0 6976.2 7575.5 7896.8 7908.3 8170.0 7991.8 7993.0 8052.4 8054.9 8057.2 1878.9 2126.5 2198.3 2228.5 2232.5 2168.3 2209.5 2213.2 2216.0 2217.7 2142.7 2148.1 2160.7 2190.7 2196.2 1866.2 2080.8 2125.6 2133.9 2171.8 2199.4 2199.8 2220.4 2225.2 2225.9 8055.7 8115.4 8116.0 8119.2 8120.7 4618.1 4722.2 4732.5 4734.2 4738.1 2829.5 2872.4 2933.1 2940.2 2944.8 845.2 862.5 885.1 889.3 890.9 10471.0 10526.9 10532.7 10549.6 10554.5 4150.3 4202.7 4292.7 4295.3 4312.9 9043.4 9075.8 9087.8 9101.6 9104.3 4684.6 4697.3 4697.6 4702.5 4703.4 3889.9 4260.3 4267.0 4416.5 4434.1 3725.3 3728.9 3770.0 3846.2 3852.1 1200.6 1234.7 1236.4 1244.6 1244.7 838.1 843.3 846.0 861.9 871.5 5213.3 5463.5 5463.7 5464.6 5480.6 432.6 435.0 441.7 850.4 950.7 3560.1 3708.7 3724.5 3796.9 3845.5 9839.8 9979.9 10002.8 10099.5 10116.6 10042.2 10060.2 10071.1 10077.1 10081.3 7304.6 7367.2 7533.4 7536.4 7538.7 5238.7 5256.8 5352.0 5365.3 5497.9 9058.5 9220.6 9239.0 9322.7 9353.4 9107.6 9299.5 9432.7 9439.6 9442.7 6720.6 6773.2 6906.4 6917.2 6920.7 7324.3 7333.3 7364.2 7368.9 7384.8 6974.8 7024.8 7043.0 7138.0 7289.1 6960.5 6995.6 7012.7 7057.6 7139.6 6311.5 6321.7 6334.4 6371.6 6374.4 4586.6 4597.0 4692.4 4706.9 4782.5 4585.1 4626.1 4631.8 4674.1 4704.5 16:08:22 INFO - PROCESS | 18747 | 16:08:22 INFO - PROCESS | 18747 | [#4] prototype.html Cycles:180 Average:4300.55 Median:4947.00 stddev:1244.02 (25.1%) stddev-sans-first:1210.68 16:08:22 INFO - PROCESS | 18747 | Values: 297.7 304.3 306.4 313.9 315.3 4982.5 4994.4 4994.8 4998.0 5020.2 4895.6 4929.7 4940.6 4981.2 4990.4 3652.2 3761.4 3772.4 3883.8 3905.6 3855.8 3859.1 3865.0 3889.6 3907.0 3648.9 3837.4 3838.6 3848.4 3851.7 3672.5 3807.2 3840.7 3861.2 3863.6 3405.8 3424.6 3426.9 3427.5 3451.0 4824.8 4843.5 4844.3 4862.4 4878.0 4254.7 4402.7 4409.0 4437.0 4453.7 5077.7 5092.0 5119.8 5128.4 5181.9 3724.5 3726.9 3738.7 3756.7 3786.7 5238.1 5337.7 5349.7 5356.2 5382.9 3784.8 3785.8 3796.4 3802.1 3812.8 3864.2 3868.6 3870.1 3879.3 3881.2 4229.3 4376.8 4379.4 4406.8 4422.9 5119.5 5165.7 5170.3 5182.6 5225.6 1330.2 1343.1 1349.5 1355.2 1366.6 876.3 901.6 918.5 947.4 948.4 4435.8 4445.7 4448.9 4469.6 4494.7 5275.9 5284.0 5309.3 5310.7 5316.4 4238.4 4374.9 4395.6 4430.0 4570.0 2787.3 2803.6 2812.5 2836.7 2840.6 4935.2 4953.4 4958.3 4988.2 5015.1 5259.8 5446.5 5456.4 5523.6 5557.5 5008.7 5044.7 5047.7 5054.7 5060.8 5329.9 5363.2 5370.1 5373.3 5414.3 5013.3 5233.3 5285.0 5296.3 5300.3 4960.2 4988.7 4998.7 5004.9 5040.6 3771.6 3802.4 3802.4 3819.9 3829.6 5098.3 5395.4 5418.2 5422.7 5452.8 5208.8 5210.5 5223.5 5225.3 5252.4 5145.7 5169.0 5173.3 5210.8 5227.8 4825.4 4879.0 5040.8 5096.7 5118.2 5059.9 5182.4 5271.7 5277.8 5320.4 5099.3 5103.8 5108.2 5120.5 5178.8 16:08:22 INFO - PROCESS | 18747 | 16:08:22 INFO - PROCESS | 18747 | [#5] yui.html Cycles:180 Average:16818.93 Median:612.90 stddev:24372.93 (3976.7%) stddev-sans-first:24411.32 16:08:22 INFO - PROCESS | 18747 | Values: 719.2 723.7 724.7 762.1 767.4 11533.7 11900.3 11984.3 12290.4 12673.5 12700.2 12781.1 12920.8 12923.0 12956.8 626.8 769.9 793.3 804.6 806.0 798.0 801.7 805.9 808.2 808.4 841.4 845.4 845.4 845.5 845.6 640.5 800.8 834.1 837.7 838.8 612.2 612.8 613.0 613.1 613.2 12712.9 12721.7 12750.2 12753.7 12791.9 11951.5 12620.2 12622.0 12845.4 12910.2 11343.0 11440.0 11487.9 11544.0 11772.6 4054.1 4153.5 4187.4 4197.4 4233.2 56493.2 57372.0 57761.7 57861.7 57895.0 9976.5 10005.1 10017.3 10103.5 10153.1 15951.0 16040.5 16057.4 16071.0 16084.1 6756.4 6783.5 6806.9 6821.3 7008.7 3541.7 3672.4 3682.5 3720.4 3728.9 2798.0 2883.8 2887.3 2891.3 2892.4 504.2 513.9 526.6 530.6 531.9 491.5 556.4 563.7 568.4 576.9 6351.6 6433.8 6542.8 7637.2 7895.5 498.7 527.6 544.6 552.3 559.6 3497.1 3500.5 3563.5 3599.5 3623.1 91649.5 94474.0 96074.0 96149.5 96974.5 71450.3 75653.2 77026.0 78246.2 79524.6 73223.3 73290.6 74240.5 75082.2 75438.6 7144.6 7358.6 7497.8 7509.1 7536.1 41597.8 42379.0 43544.0 43576.0 44405.8 61874.4 61934.7 62093.0 63076.7 63717.0 9823.9 9831.8 9888.5 9984.0 10107.1 10555.9 10723.5 10758.6 10842.5 10907.6 9946.6 10114.3 10181.0 10305.7 10631.1 9663.3 9788.0 9797.8 9822.6 9932.0 9019.3 9318.4 9510.7 9516.0 9520.0 8000.8 8139.7 8226.6 8587.4 8779.2 7954.1 8758.8 8766.2 8933.6 9102.6 16:08:22 INFO - PROCESS | 18747 | -------- Summary: end -------- 16:08:22 INFO - PROCESS | 18747 | 16:08:23 INFO - TEST-INFO | 18747: exit 0 16:08:23 INFO - TEST-OK | dromaeo_css | took 1122043ms 16:08:23 INFO - TEST-START | kraken 16:08:23 INFO - operating with platform_type : linux_ 16:08:23 INFO - Initialising browser for kraken test... 16:08:23 INFO - TEST-INFO | started process 18927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe_T_US/profile http://localhost:34729/getInfo.html) 16:08:28 INFO - PROCESS | 18927 | __metrics Screen width/height:1600/1200 16:08:28 INFO - PROCESS | 18927 | colorDepth:24 16:08:28 INFO - PROCESS | 18927 | Browser inner width/height: 1024/697 16:08:28 INFO - PROCESS | 18927 | __metrics 16:08:30 INFO - PROCESS | 18927 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:08:30 INFO - PROCESS | 18927 | console.error: PushService: 16:08:30 INFO - PROCESS | 18927 | stateChangeProcessEnqueue: Error transitioning state 16:08:30 INFO - PROCESS | 18927 | UnknownError 16:08:31 INFO - TEST-INFO | 18927: exit 0 16:08:31 INFO - Browser initialized. 16:08:31 INFO - Running cycle 1/1 for kraken test... 16:08:31 INFO - TEST-INFO | started process 19009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe_T_US/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:43 INFO - PROCESS | 19009 | RSS: Main: 175775744 16:08:43 INFO - PROCESS | 19009 | 16:08:46 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34729/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:47 INFO - PROCESS | 19009 | RSS: Main: 233885696 16:08:47 INFO - PROCESS | 19009 | 16:08:49 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34729/tests/kraken/driver.html?testName=audio-dft) 16:08:50 INFO - PROCESS | 19009 | RSS: Main: 222093312 16:08:50 INFO - PROCESS | 19009 | 16:08:53 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34729/tests/kraken/driver.html?testName=audio-fft) 16:08:54 INFO - PROCESS | 19009 | RSS: Main: 289189888 16:08:54 INFO - PROCESS | 19009 | 16:08:56 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34729/tests/kraken/driver.html?testName=audio-oscillator) 16:08:57 INFO - PROCESS | 19009 | RSS: Main: 199516160 16:08:57 INFO - PROCESS | 19009 | 16:08:59 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34729/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:59 INFO - PROCESS | 19009 | RSS: Main: 202649600 16:08:59 INFO - PROCESS | 19009 | 16:09:03 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34729/tests/kraken/driver.html?testName=imaging-darkroom) 16:09:03 INFO - PROCESS | 19009 | RSS: Main: 239513600 16:09:03 INFO - PROCESS | 19009 | 16:09:07 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34729/tests/kraken/driver.html?testName=imaging-desaturate) 16:09:07 INFO - PROCESS | 19009 | RSS: Main: 235483136 16:09:07 INFO - PROCESS | 19009 | 16:09:10 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34729/tests/kraken/driver.html?testName=json-parse-financial) 16:09:11 INFO - PROCESS | 19009 | RSS: Main: 237109248 16:09:11 INFO - PROCESS | 19009 | 16:09:13 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34729/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:09:13 INFO - PROCESS | 19009 | RSS: Main: 224288768 16:09:13 INFO - PROCESS | 19009 | 16:09:15 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34729/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:16 INFO - PROCESS | 19009 | RSS: Main: 229699584 16:09:16 INFO - PROCESS | 19009 | 16:09:18 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34729/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:19 INFO - PROCESS | 19009 | RSS: Main: 239472640 16:09:19 INFO - PROCESS | 19009 | 16:09:21 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:22 INFO - PROCESS | 19009 | RSS: Main: 240590848 16:09:22 INFO - PROCESS | 19009 | 16:09:25 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:26 INFO - PROCESS | 19009 | RSS: Main: 240607232 16:09:26 INFO - PROCESS | 19009 | 16:09:27 INFO - PROCESS | 19009 | Cycle 1(1): loaded http://localhost:34729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34729/tests/kraken/driver.html?testName=ai-astar) 16:09:28 INFO - PROCESS | 19009 | RSS: Main: 284573696 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | __start_tp_report 16:09:28 INFO - PROCESS | 19009 | _x_x_mozilla_page_load 16:09:28 INFO - PROCESS | 19009 | _x_x_mozilla_page_load_details 16:09:28 INFO - PROCESS | 19009 | |i|pagename|runs| 16:09:28 INFO - PROCESS | 19009 | |0;ai-astar;112;107;111;114;113;113;112;111;111;112 16:09:28 INFO - PROCESS | 19009 | |1;audio-beat-detection;165;131;137;179;134;174;165;131;188;133 16:09:28 INFO - PROCESS | 19009 | |2;audio-dft;162;163;160;161;163;162;162;161;162;163 16:09:28 INFO - PROCESS | 19009 | |3;audio-fft;75;76;75;117;76;76;74;74;99;75 16:09:28 INFO - PROCESS | 19009 | |4;audio-oscillator;87;85;111;85;84;85;119;86;86;129 16:09:28 INFO - PROCESS | 19009 | |5;imaging-gaussian-blur;116;117;117;117;116;118;117;117;118;116 16:09:28 INFO - PROCESS | 19009 | |6;imaging-darkroom;147;147;147;147;147;147;146;147;146;145 16:09:28 INFO - PROCESS | 19009 | |7;imaging-desaturate;95;95;95;95;96;96;95;95;95;95 16:09:28 INFO - PROCESS | 19009 | |8;json-parse-financial;63;62;63;63;62;64;62;62;62;62 16:09:28 INFO - PROCESS | 19009 | |9;json-stringify-tinderbox;65;65;65;65;65;65;66;66;65;66 16:09:28 INFO - PROCESS | 19009 | |10;stanford-crypto-aes;83;82;85;89;84;87;83;84;111;89 16:09:28 INFO - PROCESS | 19009 | |11;stanford-crypto-ccm;143;133;130;146;141;140;142;131;155;134 16:09:28 INFO - PROCESS | 19009 | |12;stanford-crypto-pbkdf2;170;170;166;169;166;170;169;176;170;170 16:09:28 INFO - PROCESS | 19009 | |13;stanford-crypto-sha256-iterative;67;70;71;65;65;66;67;66;66;66 16:09:28 INFO - PROCESS | 19009 | __end_tp_report 16:09:28 INFO - PROCESS | 19009 | __start_cc_report 16:09:28 INFO - PROCESS | 19009 | _x_x_mozilla_cycle_collect,1924 16:09:28 INFO - PROCESS | 19009 | __end_cc_report 16:09:28 INFO - PROCESS | 19009 | __startTimestamp1465859368033__endTimestamp 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | ------- Summary: start ------- 16:09:28 INFO - PROCESS | 19009 | Number of tests: 14 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.90 (1.7%) stddev-sans-first:2.01 16:09:28 INFO - PROCESS | 19009 | Values: 112.0 107.0 111.0 114.0 113.0 113.0 112.0 111.0 111.0 112.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:165.00 stddev:22.63 (13.7%) stddev-sans-first:23.63 16:09:28 INFO - PROCESS | 19009 | Values: 165.0 131.0 137.0 179.0 134.0 174.0 165.0 131.0 188.0 133.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 16:09:28 INFO - PROCESS | 19009 | Values: 162.0 163.0 160.0 161.0 163.0 162.0 162.0 161.0 162.0 163.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:14.51 (19.2%) stddev-sans-first:15.19 16:09:28 INFO - PROCESS | 19009 | Values: 75.0 76.0 75.0 117.0 76.0 76.0 74.0 74.0 99.0 75.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:85.00 stddev:17.09 (20.1%) stddev-sans-first:17.84 16:09:28 INFO - PROCESS | 19009 | Values: 87.0 85.0 111.0 85.0 84.0 85.0 119.0 86.0 86.0 129.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 16:09:28 INFO - PROCESS | 19009 | Values: 116.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 118.0 116.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:09:28 INFO - PROCESS | 19009 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 145.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:09:28 INFO - PROCESS | 19009 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 16:09:28 INFO - PROCESS | 19009 | Values: 63.0 62.0 63.0 63.0 62.0 64.0 62.0 62.0 62.0 62.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 16:09:28 INFO - PROCESS | 19009 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 65.0 66.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:84.50 stddev:8.55 (10.1%) stddev-sans-first:8.90 16:09:28 INFO - PROCESS | 19009 | Values: 83.0 82.0 85.0 89.0 84.0 87.0 83.0 84.0 111.0 89.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:141.50 stddev:7.74 (5.5%) stddev-sans-first:8.10 16:09:28 INFO - PROCESS | 19009 | Values: 143.0 133.0 130.0 146.0 141.0 140.0 142.0 131.0 155.0 134.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.00 stddev:2.76 (1.6%) stddev-sans-first:2.92 16:09:28 INFO - PROCESS | 19009 | Values: 170.0 170.0 166.0 169.0 166.0 170.0 169.0 176.0 170.0 170.0 16:09:28 INFO - PROCESS | 19009 | 16:09:28 INFO - PROCESS | 19009 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:2.02 (3.0%) stddev-sans-first:2.15 16:09:28 INFO - PROCESS | 19009 | Values: 67.0 70.0 71.0 65.0 65.0 66.0 67.0 66.0 66.0 66.0 16:09:28 INFO - PROCESS | 19009 | -------- Summary: end -------- 16:09:28 INFO - PROCESS | 19009 | 16:09:29 INFO - TEST-INFO | 19009: exit 0 16:09:29 INFO - TEST-OK | kraken | took 66074ms 16:09:29 INFO - SUITE-END | took 1188s 16:09:29 INFO - Completed test suite (00:19:48) 16:09:29 INFO - javascript benchmark 16:09:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.5015347084054, 2642.5111354399423, 2667.5998600209973, 2672.1449136276387, 2677.491276657435, 4641.048585040067, 4707.62339012879, 4736.2658787887885, 4810.518948105183, 4864.318995340651, 4732.242841145408, 4746.050789842028, 4779.330893674888, 4819.8795030124265, 4824.831130910419, 4337.175936572057, 4409.074094440171, 4420.955790442103, 4449.26587113126, 4611.1469378164975, 4513.977430112861, 4552.613027892633, 4568.086382723469, 4575.908481830362, 4601.217792975185, 4295.72077814941, 4336.479622445327, 4351.108022855307, 4353.717008394444, 4391.824327026915, 4312.892177695583, 4343.239933011742, 4350.456192975878, 4383.671224658164, 4385.736855788663, 4361.5856493633055, 4374.321980093091, 4386.210482113218, 4416.80124394403, 4431.556844315543, 4629.467611224685, 4680.695754775928, 4776.355192049064, 4777.450593181794, 4859.1010663027455, 5113.769880355393, 5154.664946778447, 5162.148245539482, 5168.069747445458, 5176.7411629418375, 5094.108531007059, 5163.3545806774155, 5179.119549676564, 5183.041137389595, 5214.243934629458, 4688.226442636995, 4799.0401919616215, 4825.95174048262, 4879.2925025871045, 4882.926756098661, 5395.81114660985, 5417.972910135424, 5424.701641409761, 5425.348958125051, 5431.538319242909, 5164.586833053347, 5191.97404012985, 5200.7919683213, 5208.374995000624, 5209.29674493946, 4989.750512474362, 5072.264521644341, 5128.769205385766, 5128.8461346159675, 5200.453952335026, 5099.337086178847, 5101.20931255656, 5102.336696229467, 5105.591552675777, 5120.718360490135, 5081.695098294041, 5086.491350864884, 5086.694798312114, 5088.643794934319, 5128.512791284822, 4180.623743863067, 4218.8312467500955, 4227.112306415687, 4241.957580424218, 4321.65426765858, 3762.473253744478, 3783.4135708965155, 3801.904952376213, 3804.0680033391995, 3805.448210009533, 4272.29507131326, 4283.0, 4285.935710964338, 4287.228298906227, 4289.099289149313, 5130.666506677054, 5164.1995490698255, 5168.8966220675375, 5171.63798534099, 5202.167653175474, 4290.699651024398, 4322.524522302544, 4354.477462704495, 4373.387725718402, 4406.845760398371, 4525.864224073283, 4609.815607375667, 4612.7462989535225, 4621.23749581322, 4621.2837010263465, 4807.158747219222, 4842.370491836039, 4849.903001940012, 4851.442084160367, 4901.534354236342, 5165.276861239355, 5182.481751824787, 5189.532942035235, 5190.532852043334, 5240.266362709148, 4697.13103075932, 4814.398200224972, 4841.709497430165, 4842.322074909586, 4899.093667671492, 5117.078925793244, 5126.512981266774, 5129.615278854027, 5139.2291156325355, 5183.740812959412, 5181.093308671043, 5194.610404219774, 5198.9740051299505, 5200.193969934666, 5228.215767634885, 4898.4121905371585, 4916.532929371704, 4967.950320496749, 4979.377577802775, 5057.266696328938, 4968.031233909497, 4977.875553111201, 4991.276264941635, 4992.775325110306, 5042.3949126103635, 4879.219324907997, 4915.97542012302, 4966.0, 4968.950310496849, 4971.6022718183185, 4903.656744027884, 5000.874978125576, 5004.549590536723, 5065.062963351792, 5083.2883396323805, 4920.065187614342, 4950.133726597903, 4956.0, 4979.128652485873, 5023.196288593807], "value": 4710.716839544872, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8097024553882, 585.5988647776273, 590.9409059094091, 595.2024287454809, 602.1449541650856, 28776.85611571942, 38603.42094868576, 39567.0, 39678.60321396785, 44144.0, 40150.0, 40418.59581404185, 40447.59552404475, 40460.0, 40472.59527404725, 7587.4688771785995, 7802.492837965528, 7945.0, 7958.602069896511, 9951.452670103141, 10022.095801797635, 10077.44574048427, 10155.593776248941, 10166.440845753481, 10179.796404071914, 10210.9489452553, 10215.693529194099, 10260.230482713789, 10265.281430299881, 10268.845967310497, 7607.619619019027, 9986.400815951067, 10115.190784737204, 10263.743406414826, 10278.588856445807, 10086.747831304276, 10142.746431339201, 10148.289619726622, 10151.796964060752, 10153.796924061551, 37002.44496332557, 37372.0, 37381.43927841084, 37414.25171496582, 37416.812915935516, 3135.4826453635123, 3186.8725250989933, 3225.8870939517005, 3266.477363621833, 3407.4037043517533, 29144.0, 29565.852170739225, 29566.85216573925, 29673.40653186924, 29817.403651927056, 3403.506491558735, 3440.2947395784054, 3453.4819777033395, 3491.1097670093964, 3511.9824400878088, 260527.0, 262086.0, 262432.0, 263256.0, 263286.0, 28279.575806362922, 53840.730796345764, 54046.459535404145, 54558.45441545613, 54602.72698636561, 30018.84990575077, 31768.682313177036, 31775.205619859687, 31869.0, 31900.521492177635, 12891.613251602466, 13011.284379359036, 13025.348732563334, 13031.218126912416, 13048.217106973612, 8894.155055269739, 10381.480925953672, 10663.413512256746, 10674.35953842772, 10836.0, 7771.844563108706, 7772.65023073963, 7793.552497959035, 7881.724139655199, 7893.407994400443, 3060.127863558875, 3098.4732595458827, 3114.8442577871015, 3143.795653282529, 3171.6511183769767, 882.9072947340566, 896.8699538566872, 958.9547393341292, 982.6855406269925, 1034.5861655337926, 26550.203493895213, 27633.309167270578, 28085.43829123447, 28182.85908570444, 28345.0, 923.1645360948353, 994.8109859126743, 1023.0383439566783, 1026.9897301027042, 1060.2631171335847, 14451.49419770303, 14855.702885942437, 14865.182414967281, 14988.175650339335, 15093.849061509463, 387355.0, 387559.0, 388069.0, 389711.0, 391701.0, 47987.520124799004, 48420.75789621029, 48443.757781210865, 48449.0, 48529.27206091912, 1069.2782371898936, 1110.9333439993627, 1199.5681554640496, 1224.577520755338, 1248.7814632439467, 25426.364340891625, 28455.28861778472, 28563.714362856106, 29022.709772902846, 29079.563806542497, 39938.0, 40293.59706403016, 40500.1899962005, 40534.59465405308, 40579.1884162321, 282885.0, 282978.0, 283463.58268209355, 284594.0, 284935.0, 22204.222852200095, 23919.880400597885, 24626.87686561556, 24885.377865553506, 25942.481150377265, 40471.79764101161, 40554.0, 40898.1820363597, 41643.58356416518, 41880.58119418767, 34605.653943460246, 35097.47353789644, 35570.82214589014, 36059.63940360668, 36265.81867090753, 35432.0, 35674.46488302626, 35791.105222368606, 35829.64170358367, 36152.096197595274, 34689.30621387609, 35251.294974100885, 35392.646073538934, 35707.46438803368, 35799.28401432009, 30526.236844079074, 31676.683233167372, 31882.840585796923, 32087.358252835278, 32228.19429514281, 24192.0, 24582.754172458048, 24701.135460258804, 24714.876425617756, 24859.254222373358], "value": 16771.213362101294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.91219381209527, 379.0864017717302, 380.36668946204566, 385.1891767828722, 397.17982366413355, 15646.706586826347, 16926.23831927563, 17226.88025278359, 17480.999999999985, 17494.562635934108, 16066.437674681389, 16627.168641567932, 17062.232199551017, 17083.06043167625, 17102.401415950444, 4595.471520775103, 4728.976355118237, 4758.738269395182, 4761.523847615228, 4765.26138448541, 3451.758376913617, 3636.4181730923056, 5074.264231686403, 5365.248865158881, 5377.731113444332, 5385.515303622673, 5403.378611459673, 5412.0, 5453.072977593819, 5454.91817622736, 5240.29256050434, 5337.439568845273, 5371.0, 5392.56859451243, 5475.67145971241, 5167.4057483389515, 5204.4535323791215, 5220.582353411718, 5220.634555581073, 5226.320578324831, 12351.814722779165, 12533.874661253452, 12633.0, 12642.683932901658, 12665.430055647426, 1861.5997560524552, 1895.4976931113265, 2044.1925439451481, 2266.1542728101117, 2425.0905910283645, 9202.0, 9282.582283797245, 9587.472689002103, 9801.362911410806, 9816.558254878477, 1766.443570275372, 1775.698131317679, 1827.0408035781188, 1859.7489338939206, 1863.7978503865068, 60986.0, 69083.65458172727, 69330.65334673345, 70460.64769676118, 70615.64692176506, 9066.592003359865, 9340.252779777602, 10258.17934565248, 10304.587816487257, 10352.844707329396, 14148.292585370691, 14265.78601320981, 14275.929305301936, 14317.92841035809, 14329.426822926966, 6924.099867017256, 6974.16310042788, 7125.394341481032, 7233.710651573983, 7384.667689953965, 6300.30696623371, 6445.129907462432, 6467.482601391877, 6473.158489396443, 6583.210014798255, 4372.497162826252, 4454.866354009385, 4456.665750068758, 4470.441194850644, 4536.705114167635, 1641.8522332990087, 1729.5935455168026, 1823.5988082621802, 1835.3928747675977, 1844.492764489776, 824.4640983360744, 825.6821123867354, 849.2993280543576, 857.4640849469082, 861.3798065392907, 16645.167741613113, 17226.96638201712, 17230.827691722923, 17577.0, 17621.207045682975, 845.9915400845913, 869.2654706772767, 876.4828751036919, 889.1286539191628, 906.9047749986156, 9583.0, 9658.75853103678, 9826.557804898797, 9907.54946302976, 9907.554160062815, 405902.0, 407479.0, 411235.0, 412445.0, 413616.0, 71206.0, 75649.0, 77097.229027709, 77826.61086694531, 77935.61032194916, 897.8383890899701, 898.3711402018613, 900.0369604523228, 904.7014485219862, 916.2029034739819, 15249.23753812327, 15366.615834604225, 15394.692106158038, 15526.534203973899, 15782.289796958934, 36534.0, 36723.44914826333, 36946.44580331351, 37438.251234975694, 37545.249095018495, 44785.328220077376, 46078.769606151756, 49580.0, 50397.24404134014, 52115.47884521258, 7515.0, 7838.529688218725, 7846.450748447553, 7927.563983980936, 8014.318782903519, 10571.207159463225, 11563.248388854698, 11750.58872939443, 11952.820707689565, 12046.51813927433, 9019.0, 9246.537673116452, 9307.06929307064, 9955.153811926068, 10006.249531285037, 9387.530623468663, 9962.452065136487, 10125.291229613857, 10209.897901020895, 10468.895311046792, 9368.203702685076, 9610.855837162308, 9685.757856053655, 9969.950150249202, 10168.644097456554, 7531.887021694789, 7664.80837979055, 7810.062792464941, 7921.485103468256, 8119.878201826859, 8806.515641639771, 9444.858327125236, 9658.79734509755, 9714.805703886024, 9769.218462523124], "value": 8017.704185293521, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1181.686852983959, 1375.456694605631, 1380.5720226729713, 1464.6265202373393, 1694.0, 6976.232614412417, 7575.545467271968, 7896.802579935505, 7908.288254057141, 8170.0, 7991.800204994878, 7992.960035199831, 8052.355811535078, 8054.91945080549, 8057.234562716547, 1878.8966606836618, 2126.532162924162, 2198.307533127064, 2228.5097278598682, 2232.486528098538, 2168.27362833451, 2209.5028618560855, 2213.236433430464, 2216.0360243294217, 2217.7116974793253, 2142.700021996922, 2148.076327179312, 2160.7191065161587, 2190.6604476306197, 2196.1544805249932, 1866.206862083609, 2080.8335333173463, 2125.5961367340155, 2133.935981920537, 2171.7719639437946, 2199.439143018536, 2199.813015893635, 2220.3560967319618, 2225.2322948582714, 2225.9109635614554, 8055.718049868285, 8115.3507719382305, 8115.95942020292, 8119.228673276029, 8120.715774947848, 4618.0763847230355, 4722.220833562458, 4732.479427262998, 4734.2425211966265, 4738.147133515966, 2829.4579308127354, 2872.3680790226117, 2933.0760810344887, 2940.162053814674, 2944.8085874418093, 845.218173189797, 862.482510493705, 885.0662551008684, 889.3152272749946, 890.9420887642283, 10471.0, 10526.894731052667, 10532.684019479428, 10549.578016879315, 10554.525046372855, 4150.315197992298, 4202.705810593229, 4292.742435453821, 4295.3342231953475, 4312.870613881526, 9043.412178208395, 9075.773105672279, 9087.772805679911, 9101.590428430736, 9104.271658267322, 4684.5549672781035, 4697.31888876111, 4697.577218050392, 4702.529747025338, 4703.435587729495, 3889.9027524311555, 4260.318349064135, 4267.039916018933, 4416.492103408149, 4434.068845542472, 3725.3108174987715, 3728.9440658390145, 3769.962300377016, 3846.2307538492414, 3852.075501879585, 1200.6458094862037, 1234.666640007193, 1236.4003458322707, 1244.55818184545, 1244.7323825377587, 838.0739283092096, 843.2958479669422, 845.9636944742764, 861.9224269815621, 871.4684042733927, 5213.253560057347, 5463.508284254357, 5463.72681365938, 5464.590155738256, 5480.561555075585, 432.56311125763204, 434.99782501087293, 441.69302334876954, 850.4132148817296, 950.7195377363694, 3560.127768696634, 3708.740388172856, 3724.5158129443, 3796.886093417202, 3845.4616353710503, 9839.754006149904, 9979.850302245472, 10002.849957250646, 10099.545520451597, 10116.59533618647, 10042.246831487668, 10060.195184385231, 10071.093601575893, 10077.143442807297, 10081.294309398418, 7304.561726296439, 7367.152777430557, 7533.397328213729, 7536.397088232929, 7538.660760265801, 5238.659487133325, 5256.842294731164, 5352.0, 5365.3293338332705, 5497.862553436196, 9058.50178240203, 9220.585073671567, 9238.9538052312, 9322.673706420243, 9353.39202951806, 9107.635694572144, 9299.535023248674, 9432.717018489457, 9439.622415103318, 9442.669506567237, 6720.630365329954, 6773.221079575912, 6906.37842594169, 6917.23910369869, 6920.688569014507, 7324.340809327186, 7333.303336183054, 7364.15312239078, 7368.889466658112, 7384.815379615553, 6974.825629359307, 7024.789256322319, 7042.964785176041, 7138.0, 7289.125304963226, 6960.512764106464, 6995.580265183901, 7012.719491220294, 7057.61183134912, 7139.571625702474, 6311.495080393649, 6321.715522801393, 6334.3665633436285, 6371.585846919936, 6374.394432528902, 4586.610138138296, 4597.0, 4692.4369075709765, 4706.858794236178, 4782.545658162469, 4585.082983403266, 4626.1210370029585, 4631.814727411001, 4674.11191873543, 4704.529547045268], "value": 4160.349756435641, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.7305538487668, 304.32591809142747, 306.43615747025467, 313.8870006797554, 315.34565776014773, 4982.526659967301, 4994.375703037121, 4994.800207991676, 4998.0, 5020.246962955549, 4895.559399654039, 4929.7042177469375, 4940.629452791046, 4981.227909674007, 4990.3762029746285, 3652.2330310634734, 3761.398176291794, 3772.4155854541023, 3883.8446462141483, 3905.5508616509183, 3855.7879316637573, 3859.0931131184147, 3864.9806750966345, 3889.5527014393283, 3906.980465097685, 3648.908777280576, 3837.424386342057, 3838.5777564467885, 3848.42273658952, 3851.7111216658723, 3672.5042119313816, 3807.1814559869485, 3840.6543411093135, 3861.1891502784447, 3863.594322596115, 3405.8467368968454, 3424.6061702904235, 3426.9485957710654, 3427.485877118452, 3450.9654903450896, 4824.758762061883, 4843.4914333994775, 4844.346013288232, 4862.367892173995, 4877.951220487821, 4254.723442976197, 4402.713823601455, 4408.955910440886, 4436.977815110936, 4453.68408427619, 5077.720725360104, 5091.974540127313, 5119.820806271762, 5128.358955130609, 5181.870453238662, 3724.4971928789537, 3726.925461490755, 3738.719596030309, 3756.7370284080125, 3786.734928555002, 5238.119034530992, 5337.70642614656, 5349.679019258857, 5356.196570514454, 5382.91925621116, 3784.7918364489665, 3785.848566057327, 3796.430535419709, 3802.1255111324, 3812.8093595320124, 3864.246471937945, 3868.6324799144036, 3870.1292209253256, 3879.301725689403, 3881.165549406891, 4229.302165142717, 4376.759278239664, 4379.3649920761945, 4406.810161256442, 4422.943331350937, 5119.491449189944, 5165.690058596496, 5170.302009228782, 5182.6372153949615, 5225.634205605571, 1330.2351148089888, 1343.1471015904776, 1349.5479014530047, 1355.153029356652, 1366.6105160029344, 876.2989608313324, 901.5987885391069, 918.4535201555065, 947.4268067819008, 948.4498990585582, 4435.756033418128, 4445.711028783118, 4448.888777780517, 4469.597736203757, 4494.685372023927, 5275.868103297448, 5283.973580132151, 5309.327561818015, 5310.707911064928, 5316.441773613792, 4238.449001629769, 4374.912501749947, 4395.5714392822465, 4430.0, 4570.0, 2787.3171073087224, 2803.621511095976, 2812.4656315300026, 2836.7305106014896, 2840.5881147233536, 4935.185694360463, 4953.374711402962, 4958.330625365602, 4988.176950803077, 5015.147424937696, 5259.789608415621, 5446.514230892232, 5456.427075157131, 5523.585731070186, 5557.527610153183, 5008.69947803133, 5044.672096313728, 5047.671901326402, 5054.7472626368535, 5060.822871199491, 5329.866753331198, 5363.249145119608, 5370.060239458157, 5373.301470808926, 5414.296141501737, 5013.323201367769, 5233.299177767317, 5285.018118205673, 5296.258523806593, 5300.257963885137, 4960.23116416956, 4988.6757360771435, 4998.6750861193905, 5004.874878128076, 5040.6471546992825, 3771.642208804883, 3802.372608519563, 3802.4106263529197, 3819.942700859545, 3829.636184562462, 5098.260752190986, 5395.433479484597, 5418.187271909245, 5422.674639521641, 5452.809151679672, 5208.817691380784, 5210.53105220532, 5223.52988231061, 5225.301776922592, 5252.42223355423, 5145.71698556568, 5168.9741551292, 5173.275741396283, 5210.817621383233, 5227.790888364423, 4825.372701548777, 4879.0, 5040.823571174991, 5096.694198348111, 5118.181091025418, 5059.873503162303, 5182.352205974254, 5271.71005594696, 5277.815276465305, 5320.44135365781, 5099.311592935054, 5103.8468845934685, 5108.208227724708, 5120.462351453044, 5178.818741344035], "value": 3909.194894532608, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.2447929673838, 723.6707298179329, 724.6738967464643, 762.0893032825772, 767.4436033875437, 11533.65399038028, 11900.285982841036, 11984.340861252627, 12290.385480725961, 12673.49306027759, 12700.237985720863, 12781.105322627396, 12920.806187907188, 12922.999999999976, 12956.805647915266, 626.7618305044077, 769.9153093159748, 793.317746737805, 804.6379129391768, 806.0367860406816, 798.0264077825044, 801.6552882260626, 805.899262592176, 808.2321794295414, 808.4219782855257, 841.4194205997842, 845.3701992015957, 845.4208866926144, 845.4884794699211, 845.6490556419079, 640.478010421505, 800.803803068252, 834.0825092398313, 837.6691206973242, 838.7777239031661, 612.20107759374, 612.8100288910452, 612.9816105516842, 613.1048668943304, 613.1569092497815, 12712.872871271262, 12721.745565088739, 12750.234985900875, 12753.681157971032, 12791.936040319832, 11951.462184201644, 12620.242785432903, 12622.0, 12845.421956011909, 12910.225386476748, 11343.0, 11440.0, 11487.885121148765, 11544.0, 11772.587959421378, 4054.0878302382025, 4153.54311025787, 4187.350960601112, 4197.391378250167, 4233.174530966463, 56493.152602710994, 57372.0, 57761.71119144419, 57861.71069144669, 57895.0, 9976.45129517869, 10005.149562287286, 10017.348872323275, 10103.51225384137, 10153.13698335635, 15951.0, 16040.518784436486, 16057.357705691642, 16071.035737855766, 16084.115373654327, 6756.425703815231, 6783.491238157059, 6806.897896531556, 6821.317868213139, 7008.684609192598, 3541.698955588804, 3672.375696131664, 3682.4660424238873, 3720.3675375186285, 3728.8694895678523, 2797.9787377607436, 2883.798134130591, 2887.2637477443536, 2891.3494463745487, 2892.421515696869, 504.2109099259647, 513.9434662187157, 526.6234642230747, 530.5781903386817, 531.8723506358446, 491.54286513542746, 556.4435564435564, 563.6533531877866, 568.4429259325884, 576.9105788602774, 6351.55539112267, 6433.806985790434, 6542.771003014872, 7637.15991240963, 7895.486793358528, 498.6858279284028, 527.6253859759614, 544.6106034185497, 552.2502209994095, 559.580314763927, 3497.1257185703575, 3500.49242859789, 3563.483294922222, 3599.478075679064, 3623.0580049186874, 91649.54175229215, 94474.0, 96074.0, 96149.51925240469, 96974.51512742392, 71450.2854971454, 75653.24346756573, 77026.0, 78246.21753782502, 79524.60237698775, 73223.26776732164, 73290.63354683299, 74240.46234682972, 75082.24917750862, 75438.6228068867, 7144.642767861482, 7358.595277259588, 7497.775066748006, 7509.098908131059, 7536.0956685198125, 41597.79201103975, 42379.0, 43544.0, 43576.0, 44405.777971109936, 61874.38125618686, 61934.69032654808, 62093.0, 63076.684616576626, 63717.0, 9823.901760982299, 9831.754206144618, 9888.456134912649, 9983.950080249553, 10107.090361867467, 10555.89444105549, 10723.463826808784, 10758.569657213937, 10842.457877105955, 10907.618233361794, 9946.55240514193, 10114.29199955996, 10181.0, 10305.690829275134, 10631.149508039493, 9663.27525435581, 9787.951060244653, 9797.804043918939, 9822.55798489084, 9932.00679932001, 9019.278457723498, 9318.440893546409, 9510.667126650535, 9516.048395160706, 9519.952400237955, 8000.759977200693, 8139.674413023413, 8226.62980165882, 8587.355948303777, 8779.209871111376, 7954.070149580855, 8758.82482350362, 8766.167214114648, 8933.553322333988, 9102.635894564408], "value": 6249.924120674716, "unit": "score"}], "name": "dromaeo_css", "value": 6331.012556144509, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 114.0, 113.0, 113.0, 112.0, 111.0, 111.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 131.0, 137.0, 179.0, 134.0, 174.0, 165.0, 131.0, 188.0, 133.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 160.0, 161.0, 163.0, 162.0, 162.0, 161.0, 162.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 117.0, 76.0, 76.0, 74.0, 74.0, 99.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 111.0, 85.0, 84.0, 85.0, 119.0, 86.0, 86.0, 129.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 118.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 85.0, 89.0, 84.0, 87.0, 83.0, 84.0, 111.0, 89.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 130.0, 146.0, 141.0, 140.0, 142.0, 131.0, 155.0, 134.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 166.0, 169.0, 166.0, 170.0, 169.0, 176.0, 170.0, 170.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 71.0, 65.0, 65.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1554.8, "alertThreshold": 2.0}]} 16:09:29 INFO - Return code: 0 16:09:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:29 INFO - # TBPL SUCCESS # 16:09:29 INFO - Running post-action listener: _resource_record_post_action 16:09:29 INFO - ##### 16:09:29 INFO - ##### Finished run-tests step (success) 16:09:29 INFO - ##### 16:09:29 INFO - Running post-run listener: _resource_record_post_run 16:09:29 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 12288; Write bytes: 538152960; Read time: 680; Write time: 1001320 16:09:29 INFO - TinderboxPrint: CPU usage
13.2% 16:09:29 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 680 16:09:29 INFO - TinderboxPrint: I/O write bytes / time
538,152,960 / 1,001,320 16:09:29 INFO - TinderboxPrint: CPU idle
8,354.2 (86.8%) 16:09:29 INFO - TinderboxPrint: CPU user
1,215.3 (12.6%) 16:09:29 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244486144; Read time: 192; Write time: 427532 16:09:29 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293027840; Read time: 488; Write time: 573748 16:09:30 INFO - Running post-run listener: _upload_blobber_files 16:09:30 INFO - Blob upload gear active. 16:09:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:30 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 16:09:30 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'] 16:09:30 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 16:09:30 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:09:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:09:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:31 INFO - (blobuploader) - INFO - Done attempting. 16:09:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:09:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:09:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:32 INFO - (blobuploader) - INFO - Done attempting. 16:09:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:36 INFO - (blobuploader) - INFO - Done attempting. 16:09:36 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:37 INFO - Return code: 0 16:09:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d47a9aa209fa2143d82e8a8ac4fab8110c3c1794730735b1e3f1eb7ce304b8a849caad48ae6327dc473779c54f3aac039227a8645621f5416919ae967288fa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53ca766a7c3cac6889a099cb4922c26d47b938a48cacca7f9388f441af189023e6bac3e91d6b75328de18b52df642f8e8065665d5bff1026bef57cbdb0378636", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33b9a6f74089bb917a93c6ebf0676d5982f3a2a7f80adaf313878efde2c5d9b4a83b8dbd93a6a841fa25f9eb91a25f645d811409a130ff4c34589523e1b6fe9d"} 16:09:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:37 INFO - Contents: 16:09:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d47a9aa209fa2143d82e8a8ac4fab8110c3c1794730735b1e3f1eb7ce304b8a849caad48ae6327dc473779c54f3aac039227a8645621f5416919ae967288fa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53ca766a7c3cac6889a099cb4922c26d47b938a48cacca7f9388f441af189023e6bac3e91d6b75328de18b52df642f8e8065665d5bff1026bef57cbdb0378636", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33b9a6f74089bb917a93c6ebf0676d5982f3a2a7f80adaf313878efde2c5d9b4a83b8dbd93a6a841fa25f9eb91a25f645d811409a130ff4c34589523e1b6fe9d"} 16:09:37 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:37 INFO - Copying logs to upload dir... 16:09:37 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.124383 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-13 16:09:36.508291) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 16:09:36.511980) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931 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/6d47a9aa209fa2143d82e8a8ac4fab8110c3c1794730735b1e3f1eb7ce304b8a849caad48ae6327dc473779c54f3aac039227a8645621f5416919ae967288fa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53ca766a7c3cac6889a099cb4922c26d47b938a48cacca7f9388f441af189023e6bac3e91d6b75328de18b52df642f8e8065665d5bff1026bef57cbdb0378636", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33b9a6f74089bb917a93c6ebf0676d5982f3a2a7f80adaf313878efde2c5d9b4a83b8dbd93a6a841fa25f9eb91a25f645d811409a130ff4c34589523e1b6fe9d"} build_url:https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/WWLPpTjRQOuvsE-aX1dzdg/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/6d47a9aa209fa2143d82e8a8ac4fab8110c3c1794730735b1e3f1eb7ce304b8a849caad48ae6327dc473779c54f3aac039227a8645621f5416919ae967288fa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53ca766a7c3cac6889a099cb4922c26d47b938a48cacca7f9388f441af189023e6bac3e91d6b75328de18b52df642f8e8065665d5bff1026bef57cbdb0378636", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33b9a6f74089bb917a93c6ebf0676d5982f3a2a7f80adaf313878efde2c5d9b4a83b8dbd93a6a841fa25f9eb91a25f645d811409a130ff4c34589523e1b6fe9d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 16:09:36.538227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:09:36.538605) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465840648.170335-1921070931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:09:36.622810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 16:09:36.623165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 16:09:36.623508) ========= ========= Total master_lag: 0.18 =========