builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1468323401.18 results: success (0) buildid: 20160712041226 builduid: e5a63682a24945fda34ef7788ea031a3 revision: 829e9870eb1d9cd4e5acb894350d4bfc12e3345d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:41.177806) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:41.178261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:41.178544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:41.194495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:41.194793) ========= 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=33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 04:36:42-- 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% 50.7M=0s 2016-07-12 04:36:42 (50.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:41.312589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:41.312918) ========= 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=33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020615 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:41.363183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:41.363558) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 829e9870eb1d9cd4e5acb894350d4bfc12e3345d --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 829e9870eb1d9cd4e5acb894350d4bfc12e3345d --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=33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 04:36:42,332 truncating revision to first 12 chars 2016-07-12 04:36:42,332 Setting DEBUG logging. 2016-07-12 04:36:42,332 attempt 1/10 2016-07-12 04:36:42,332 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/829e9870eb1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 04:36:42,672 unpacking tar archive at: fx-team-829e9870eb1d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680572 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:42.057488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:42.057795) ========= script_repo_revision: 829e9870eb1d9cd4e5acb894350d4bfc12e3345d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:42.058273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:42.058541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 04:36:42.067397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-12 04:36:42.067666) ========= /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=33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:36:43 INFO - MultiFileLogger online at 20160712 04:36:43 in /builds/slave/test 04:36:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:36:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:43 INFO - {'append_to_log': False, 04:36:43 INFO - 'base_work_dir': '/builds/slave/test', 04:36:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:36:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:43 INFO - 'branch': 'Fx-Team-Non-PGO', 04:36:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:43 INFO - 'config_files': ('talos/linux_config.py',), 04:36:43 INFO - 'default_actions': ('clobber', 04:36:43 INFO - 'read-buildbot-config', 04:36:43 INFO - 'download-and-extract', 04:36:43 INFO - 'populate-webroot', 04:36:43 INFO - 'create-virtualenv', 04:36:43 INFO - 'install', 04:36:43 INFO - 'run-tests'), 04:36:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:43 INFO - 'download_minidump_stackwalk': True, 04:36:43 INFO - 'download_symbols': 'ondemand', 04:36:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:43 INFO - 'installer_path': 'installer.exe', 04:36:43 INFO - 'log_level': 'info', 04:36:43 INFO - 'log_name': 'talos', 04:36:43 INFO - 'log_to_console': True, 04:36:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:36:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:36:43 INFO - 'opt_config_files': (), 04:36:43 INFO - 'pip_index': False, 04:36:43 INFO - 'sps_profile': False, 04:36:43 INFO - 'sps_profile_interval': 0, 04:36:43 INFO - 'suite': 'dromaeojs', 04:36:43 INFO - 'system_bits': '32', 04:36:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:43 INFO - 'title': 'talos-linux64-ix-063', 04:36:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:43 INFO - 'use_talos_json': True, 04:36:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:43 INFO - 'work_dir': 'build'} 04:36:43 INFO - ##### 04:36:43 INFO - ##### Running clobber step. 04:36:43 INFO - ##### 04:36:43 INFO - Running pre-action listener: _resource_record_pre_action 04:36:43 INFO - Running main action method: clobber 04:36:43 INFO - rmtree: /builds/slave/test/build 04:36:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:44 INFO - Running post-action listener: _resource_record_post_action 04:36:44 INFO - ##### 04:36:44 INFO - ##### Finished clobber step (success) 04:36:44 INFO - ##### 04:36:44 INFO - ##### 04:36:44 INFO - ##### Running read-buildbot-config step. 04:36:44 INFO - ##### 04:36:44 INFO - Running pre-action listener: _resource_record_pre_action 04:36:44 INFO - Running main action method: read_buildbot_config 04:36:44 INFO - Using buildbot properties: 04:36:44 INFO - { 04:36:44 INFO - "project": "", 04:36:44 INFO - "product": "firefox", 04:36:44 INFO - "script_repo_revision": "production", 04:36:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:36:44 INFO - "repository": "", 04:36:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:36:44 INFO - "buildid": "20160712041226", 04:36:44 INFO - "pgo_build": "False", 04:36:44 INFO - "basedir": "/builds/slave/test", 04:36:44 INFO - "buildnumber": 1798, 04:36:44 INFO - "slavename": "talos-linux64-ix-063", 04:36:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:36:44 INFO - "platform": "ubuntu64_hw", 04:36:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:36:44 INFO - "branch": "fx-team", 04:36:44 INFO - "repo_path": "integration/fx-team", 04:36:44 INFO - "revision": "829e9870eb1d9cd4e5acb894350d4bfc12e3345d", 04:36:44 INFO - "stage_platform": "linux64", 04:36:44 INFO - "builduid": "e5a63682a24945fda34ef7788ea031a3", 04:36:44 INFO - "slavebuilddir": "test" 04:36:44 INFO - } 04:36:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:36:44 INFO - Running post-action listener: _resource_record_post_action 04:36:44 INFO - ##### 04:36:44 INFO - ##### Finished read-buildbot-config step (success) 04:36:44 INFO - ##### 04:36:44 INFO - ##### 04:36:44 INFO - ##### Running download-and-extract step. 04:36:44 INFO - ##### 04:36:44 INFO - Running pre-action listener: _resource_record_pre_action 04:36:44 INFO - Running main action method: download_and_extract 04:36:44 INFO - mkdir: /builds/slave/test/build/tests 04:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:44 INFO - https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:44 INFO - Downloaded 1361 bytes. 04:36:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:36:44 INFO - Using the following test package requirements: 04:36:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:36:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:36:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:44 INFO - u'jsshell-linux-x86_64.zip'], 04:36:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:36:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:36:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:36:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:36:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:36:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:44 INFO - https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:45 INFO - Downloaded 22701091 bytes. 04:36:46 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'] 04:36:46 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 04:36:47 INFO - Return code: 0 04:36:47 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 04:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:47 INFO - https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:36:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:48 INFO - Downloaded 22701091 bytes. 04:36:48 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'] 04:36:48 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 04:36:49 INFO - Return code: 0 04:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:49 INFO - https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:36:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:50 INFO - Downloaded 14403317 bytes. 04:36:51 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'] 04:36:51 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 04:36:51 INFO - Return code: 0 04:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:51 INFO - https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:36:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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 04:36:52 INFO - Downloaded 56658295 bytes. 04:36:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:52 INFO - mkdir: /builds/slave/test/properties 04:36:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:52 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:52 INFO - Contents: 04:36:52 INFO - build_url:https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:53 INFO - Running post-action listener: _resource_record_post_action 04:36:53 INFO - Running post-action listener: set_extra_try_arguments 04:36:53 INFO - ##### 04:36:53 INFO - ##### Finished download-and-extract step (success) 04:36:53 INFO - ##### 04:36:53 INFO - ##### 04:36:53 INFO - ##### Running populate-webroot step. 04:36:53 INFO - ##### 04:36:53 INFO - Running pre-action listener: _resource_record_pre_action 04:36:53 INFO - Running main action method: populate_webroot 04:36:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:53 INFO - '--tppagecycles', 04:36:53 INFO - '7'], 04:36:53 INFO - 'tests': ['tsvgm']}}, 04:36:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['damp', 'tps']}, 04:36:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'tests': ['damp', 'tps']}, 04:36:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['dromaeo_dom']}, 04:36:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['basic_compositor_video']}, 04:36:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:36:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['tsvgx', 04:36:53 INFO - 'tsvgr_opacity', 04:36:53 INFO - 'tart', 04:36:53 INFO - 'tscrollx', 04:36:53 INFO - 'cart']}, 04:36:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:53 INFO - 'tsvgr_opacity', 04:36:53 INFO - 'tart', 04:36:53 INFO - 'tscrollx', 04:36:53 INFO - 'cart']}, 04:36:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--disable-e10s'], 04:36:53 INFO - 'tests': ['tp5o']}, 04:36:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'tests': ['tp5o']}, 04:36:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--disable-e10s', 04:36:53 INFO - '--xperf_path', 04:36:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:53 INFO - 'tests': ['tp5n']}, 04:36:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--xperf_path', 04:36:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:53 INFO - 'tests': ['tp5n']}}, 04:36:53 INFO - 'talos.zip': {'path': '', 04:36:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:53 INFO - Running post-action listener: _resource_record_post_action 04:36:53 INFO - ##### 04:36:53 INFO - ##### Finished populate-webroot step (success) 04:36:53 INFO - ##### 04:36:53 INFO - ##### 04:36:53 INFO - ##### Running create-virtualenv step. 04:36:53 INFO - ##### 04:36:53 INFO - Running pre-action listener: _resource_record_pre_action 04:36:53 INFO - Running main action method: create_virtualenv 04:36:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:36:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:53 INFO - Using real prefix '/usr' 04:36:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:56 INFO - Installing pip.................done. 04:36:56 INFO - Return code: 0 04:36:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, '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': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:36:56 INFO - Using env: {'DISPLAY': ':0', 04:36:56 INFO - 'HOME': '/home/cltbld', 04:36:56 INFO - 'LANG': 'en_US.UTF-8', 04:36:56 INFO - 'LANGUAGE': 'en_US:en', 04:36:56 INFO - 'LOGNAME': 'cltbld', 04:36:56 INFO - 'MAIL': '/var/mail/cltbld', 04:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:56 INFO - 'MOZ_NO_REMOTE': '1', 04:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:56 INFO - 'NO_EM_RESTART': '1', 04:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:56 INFO - 'PWD': '/builds/slave/test', 04:36:56 INFO - 'SHELL': '/bin/bash', 04:36:56 INFO - 'SHLVL': '1', 04:36:56 INFO - 'TERM': 'linux', 04:36:56 INFO - 'TMOUT': '86400', 04:36:56 INFO - 'USER': 'cltbld', 04:36:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:56 INFO - '_': '/tools/buildbot/bin/python'} 04:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:36:56 INFO - Cleaning up... 04:36:56 INFO - Return code: 0 04:36:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x199a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, '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': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:36:56 INFO - Using env: {'DISPLAY': ':0', 04:36:56 INFO - 'HOME': '/home/cltbld', 04:36:56 INFO - 'LANG': 'en_US.UTF-8', 04:36:56 INFO - 'LANGUAGE': 'en_US:en', 04:36:56 INFO - 'LOGNAME': 'cltbld', 04:36:56 INFO - 'MAIL': '/var/mail/cltbld', 04:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:56 INFO - 'MOZ_NO_REMOTE': '1', 04:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:56 INFO - 'NO_EM_RESTART': '1', 04:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:56 INFO - 'PWD': '/builds/slave/test', 04:36:56 INFO - 'SHELL': '/bin/bash', 04:36:56 INFO - 'SHLVL': '1', 04:36:56 INFO - 'TERM': 'linux', 04:36:56 INFO - 'TMOUT': '86400', 04:36:56 INFO - 'USER': 'cltbld', 04:36:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:56 INFO - '_': '/tools/buildbot/bin/python'} 04:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:56 INFO - Downloading/unpacking psutil>=3.1.1 04:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:58 INFO - Installing collected packages: psutil 04:36:58 INFO - Running setup.py install for psutil 04:36:58 INFO - building 'psutil._psutil_linux' extension 04:36:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:36:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:36:58 INFO - building 'psutil._psutil_posix' extension 04:36:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:36:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:36:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:59 INFO - Successfully installed psutil 04:36:59 INFO - Cleaning up... 04:36:59 INFO - Return code: 0 04:36:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:59 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 0x199a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, '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': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:36:59 INFO - Using env: {'DISPLAY': ':0', 04:36:59 INFO - 'HOME': '/home/cltbld', 04:36:59 INFO - 'LANG': 'en_US.UTF-8', 04:36:59 INFO - 'LANGUAGE': 'en_US:en', 04:36:59 INFO - 'LOGNAME': 'cltbld', 04:36:59 INFO - 'MAIL': '/var/mail/cltbld', 04:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:59 INFO - 'MOZ_NO_REMOTE': '1', 04:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:59 INFO - 'NO_EM_RESTART': '1', 04:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:59 INFO - 'PWD': '/builds/slave/test', 04:36:59 INFO - 'SHELL': '/bin/bash', 04:36:59 INFO - 'SHLVL': '1', 04:36:59 INFO - 'TERM': 'linux', 04:36:59 INFO - 'TMOUT': '86400', 04:36:59 INFO - 'USER': 'cltbld', 04:36:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:59 INFO - '_': '/tools/buildbot/bin/python'} 04:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:37:01 INFO - Installing collected packages: mozsystemmonitor 04:37:01 INFO - Running setup.py install for mozsystemmonitor 04:37:01 INFO - Successfully installed mozsystemmonitor 04:37:01 INFO - Cleaning up... 04:37:01 INFO - Return code: 0 04:37:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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', '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 0x199a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, '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': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:37: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:37: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 jsonschema==2.5.1 04:37:01 INFO - Using env: {'DISPLAY': ':0', 04:37:01 INFO - 'HOME': '/home/cltbld', 04:37:01 INFO - 'LANG': 'en_US.UTF-8', 04:37:01 INFO - 'LANGUAGE': 'en_US:en', 04:37:01 INFO - 'LOGNAME': 'cltbld', 04:37:01 INFO - 'MAIL': '/var/mail/cltbld', 04:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:01 INFO - 'MOZ_NO_REMOTE': '1', 04:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:01 INFO - 'NO_EM_RESTART': '1', 04:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:01 INFO - 'PWD': '/builds/slave/test', 04:37:01 INFO - 'SHELL': '/bin/bash', 04:37:01 INFO - 'SHLVL': '1', 04:37:01 INFO - 'TERM': 'linux', 04:37:01 INFO - 'TMOUT': '86400', 04:37:01 INFO - 'USER': 'cltbld', 04:37:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:01 INFO - '_': '/tools/buildbot/bin/python'} 04:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:01 INFO - Downloading/unpacking jsonschema==2.5.1 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:37:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:37:03 INFO - warning: no files found matching '*.txt' 04:37:03 INFO - no previously-included directories found matching 'build' 04:37:03 INFO - no previously-included directories found matching 'dist' 04:37:03 INFO - no previously-included directories found matching '.git*' 04:37:03 INFO - Installing collected packages: jsonschema, functools32 04:37:04 INFO - Running setup.py install for functools32 04:37:04 INFO - warning: no files found matching '*.txt' 04:37:04 INFO - no previously-included directories found matching 'build' 04:37:04 INFO - no previously-included directories found matching 'dist' 04:37:04 INFO - no previously-included directories found matching '.git*' 04:37:04 INFO - Successfully installed jsonschema functools32 04:37:04 INFO - Cleaning up... 04:37:04 INFO - Return code: 0 04:37:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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', '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 0x199a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, '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': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:37: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:37: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 blobuploader==1.2.4 04:37:04 INFO - Using env: {'DISPLAY': ':0', 04:37:04 INFO - 'HOME': '/home/cltbld', 04:37:04 INFO - 'LANG': 'en_US.UTF-8', 04:37:04 INFO - 'LANGUAGE': 'en_US:en', 04:37:04 INFO - 'LOGNAME': 'cltbld', 04:37:04 INFO - 'MAIL': '/var/mail/cltbld', 04:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:04 INFO - 'MOZ_NO_REMOTE': '1', 04:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:04 INFO - 'NO_EM_RESTART': '1', 04:37:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:04 INFO - 'PWD': '/builds/slave/test', 04:37:04 INFO - 'SHELL': '/bin/bash', 04:37:04 INFO - 'SHLVL': '1', 04:37:04 INFO - 'TERM': 'linux', 04:37:04 INFO - 'TMOUT': '86400', 04:37:04 INFO - 'USER': 'cltbld', 04:37:04 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:04 INFO - '_': '/tools/buildbot/bin/python'} 04:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:07 INFO - Downloading docopt-0.6.1.tar.gz 04:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:07 INFO - Running setup.py install for blobuploader 04:37:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:07 INFO - Running setup.py install for requests 04:37:07 INFO - Running setup.py install for docopt 04:37:07 INFO - Successfully installed blobuploader requests docopt 04:37:07 INFO - Cleaning up... 04:37:07 INFO - Return code: 0 04:37:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:07 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 0x199a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, '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': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:37:07 INFO - Using env: {'DISPLAY': ':0', 04:37:07 INFO - 'HOME': '/home/cltbld', 04:37:07 INFO - 'LANG': 'en_US.UTF-8', 04:37:07 INFO - 'LANGUAGE': 'en_US:en', 04:37:07 INFO - 'LOGNAME': 'cltbld', 04:37:07 INFO - 'MAIL': '/var/mail/cltbld', 04:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:07 INFO - 'MOZ_NO_REMOTE': '1', 04:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:07 INFO - 'NO_EM_RESTART': '1', 04:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:07 INFO - 'PWD': '/builds/slave/test', 04:37:07 INFO - 'SHELL': '/bin/bash', 04:37:07 INFO - 'SHLVL': '1', 04:37:07 INFO - 'TERM': 'linux', 04:37:07 INFO - 'TMOUT': '86400', 04:37:07 INFO - 'USER': 'cltbld', 04:37:07 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:07 INFO - '_': '/tools/buildbot/bin/python'} 04:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:08 INFO - Running setup.py (path:/tmp/pip-Hb7i9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:08 INFO - Running setup.py (path:/tmp/pip-r9XP7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:08 INFO - Running setup.py (path:/tmp/pip-hZkA2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:08 INFO - Running setup.py (path:/tmp/pip-kNZ6Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:08 INFO - Running setup.py (path:/tmp/pip-GxMpiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:08 INFO - Running setup.py (path:/tmp/pip-p9oE9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:08 INFO - Running setup.py (path:/tmp/pip-LXXjJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:08 INFO - Running setup.py (path:/tmp/pip-hB2YxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:08 INFO - Running setup.py (path:/tmp/pip-nG6F6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:08 INFO - Running setup.py (path:/tmp/pip-J1t5kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:08 INFO - Running setup.py (path:/tmp/pip-BjLJ1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:08 INFO - Running setup.py (path:/tmp/pip-dOi2n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:08 INFO - Running setup.py (path:/tmp/pip-HG6svY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:09 INFO - Running setup.py (path:/tmp/pip-mobSuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:09 INFO - Running setup.py (path:/tmp/pip-Bcrbvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:09 INFO - Running setup.py (path:/tmp/pip-bSYHAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:09 INFO - Running setup.py (path:/tmp/pip-U5YXpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:09 INFO - Running setup.py install for manifestparser 04:37:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:09 INFO - Running setup.py install for mozcrash 04:37:09 INFO - Running setup.py install for mozdebug 04:37:09 INFO - Running setup.py install for mozdevice 04:37:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:37:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:09 INFO - Running setup.py install for mozfile 04:37:09 INFO - Running setup.py install for mozhttpd 04:37:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:09 INFO - Running setup.py install for mozinfo 04:37:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Running setup.py install for mozInstall 04:37:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Running setup.py install for mozleak 04:37:10 INFO - Running setup.py install for mozlog 04:37:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Running setup.py install for moznetwork 04:37:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Running setup.py install for mozprocess 04:37:10 INFO - Running setup.py install for mozprofile 04:37:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Running setup.py install for mozrunner 04:37:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:10 INFO - Running setup.py install for mozscreenshot 04:37:10 INFO - Running setup.py install for moztest 04:37:11 INFO - Running setup.py install for mozversion 04:37:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:11 INFO - Cleaning up... 04:37:11 INFO - Return code: 0 04:37:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:11 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 0x199a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, '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': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:37:11 INFO - Using env: {'DISPLAY': ':0', 04:37:11 INFO - 'HOME': '/home/cltbld', 04:37:11 INFO - 'LANG': 'en_US.UTF-8', 04:37:11 INFO - 'LANGUAGE': 'en_US:en', 04:37:11 INFO - 'LOGNAME': 'cltbld', 04:37:11 INFO - 'MAIL': '/var/mail/cltbld', 04:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:11 INFO - 'MOZ_NO_REMOTE': '1', 04:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:11 INFO - 'NO_EM_RESTART': '1', 04:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:11 INFO - 'PWD': '/builds/slave/test', 04:37:11 INFO - 'SHELL': '/bin/bash', 04:37:11 INFO - 'SHLVL': '1', 04:37:11 INFO - 'TERM': 'linux', 04:37:11 INFO - 'TMOUT': '86400', 04:37:11 INFO - 'USER': 'cltbld', 04:37:11 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:11 INFO - '_': '/tools/buildbot/bin/python'} 04:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:11 INFO - Running setup.py (path:/tmp/pip-jvevcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:11 INFO - Running setup.py (path:/tmp/pip-ev1tFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:11 INFO - Running setup.py (path:/tmp/pip-lq2kCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:11 INFO - Running setup.py (path:/tmp/pip-GGoPF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:11 INFO - Running setup.py (path:/tmp/pip-HqL5ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:11 INFO - Running setup.py (path:/tmp/pip-4zRJNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:11 INFO - Running setup.py (path:/tmp/pip-zI8Yqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:11 INFO - Running setup.py (path:/tmp/pip-KYA1eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:11 INFO - Running setup.py (path:/tmp/pip-l25Zc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:12 INFO - Running setup.py (path:/tmp/pip-uSzpai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:12 INFO - Running setup.py (path:/tmp/pip-xVOi3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:12 INFO - Running setup.py (path:/tmp/pip-LH10hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:12 INFO - Running setup.py (path:/tmp/pip-ASzPnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:12 INFO - Running setup.py (path:/tmp/pip-dpXaIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:12 INFO - Running setup.py (path:/tmp/pip-nYTL4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:12 INFO - Running setup.py (path:/tmp/pip-LvvU7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:12 INFO - Running setup.py (path:/tmp/pip-YlbEOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:37:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:14 INFO - Downloading blessings-1.6.tar.gz 04:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:14 INFO - Installing collected packages: blessings 04:37:14 INFO - Running setup.py install for blessings 04:37:14 INFO - Successfully installed blessings 04:37:14 INFO - Cleaning up... 04:37:14 INFO - Return code: 0 04:37:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:14 INFO - Reading from file tmpfile_stdout 04:37:14 INFO - Current package versions: 04:37:14 INFO - argparse == 1.2.1 04:37:14 INFO - blessings == 1.6 04:37:14 INFO - blobuploader == 1.2.4 04:37:14 INFO - docopt == 0.6.1 04:37:14 INFO - functools32 == 3.2.3-2 04:37:14 INFO - jsonschema == 2.5.1 04:37:14 INFO - manifestparser == 1.1 04:37:14 INFO - mozInstall == 1.12 04:37:14 INFO - mozcrash == 0.17 04:37:14 INFO - mozdebug == 0.1 04:37:14 INFO - mozdevice == 0.48 04:37:14 INFO - mozfile == 1.2 04:37:14 INFO - mozhttpd == 0.7 04:37:14 INFO - mozinfo == 0.9 04:37:14 INFO - mozleak == 0.1 04:37:14 INFO - mozlog == 3.2 04:37:14 INFO - moznetwork == 0.27 04:37:14 INFO - mozprocess == 0.23 04:37:14 INFO - mozprofile == 0.28 04:37:14 INFO - mozrunner == 6.12 04:37:14 INFO - mozscreenshot == 0.1 04:37:14 INFO - mozsystemmonitor == 0.3 04:37:14 INFO - moztest == 0.7 04:37:14 INFO - mozversion == 1.4 04:37:14 INFO - psutil == 3.1.1 04:37:14 INFO - requests == 1.2.3 04:37:14 INFO - wsgiref == 0.1.2 04:37:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:14 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 0x199a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, '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': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:37:15 INFO - Using env: {'DISPLAY': ':0', 04:37:15 INFO - 'HOME': '/home/cltbld', 04:37:15 INFO - 'LANG': 'en_US.UTF-8', 04:37:15 INFO - 'LANGUAGE': 'en_US:en', 04:37:15 INFO - 'LOGNAME': 'cltbld', 04:37:15 INFO - 'MAIL': '/var/mail/cltbld', 04:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:15 INFO - 'MOZ_NO_REMOTE': '1', 04:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:15 INFO - 'NO_EM_RESTART': '1', 04:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:15 INFO - 'PWD': '/builds/slave/test', 04:37:15 INFO - 'SHELL': '/bin/bash', 04:37:15 INFO - 'SHLVL': '1', 04:37:15 INFO - 'TERM': 'linux', 04:37:15 INFO - 'TMOUT': '86400', 04:37:15 INFO - 'USER': 'cltbld', 04:37:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:15 INFO - '_': '/tools/buildbot/bin/python'} 04:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:37:15 INFO - Cleaning up... 04:37:15 INFO - Return code: 0 04:37:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:15 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 0x199a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, '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': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:37:15 INFO - Using env: {'DISPLAY': ':0', 04:37:15 INFO - 'HOME': '/home/cltbld', 04:37:15 INFO - 'LANG': 'en_US.UTF-8', 04:37:15 INFO - 'LANGUAGE': 'en_US:en', 04:37:15 INFO - 'LOGNAME': 'cltbld', 04:37:15 INFO - 'MAIL': '/var/mail/cltbld', 04:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:15 INFO - 'MOZ_NO_REMOTE': '1', 04:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:15 INFO - 'NO_EM_RESTART': '1', 04:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:15 INFO - 'PWD': '/builds/slave/test', 04:37:15 INFO - 'SHELL': '/bin/bash', 04:37:15 INFO - 'SHLVL': '1', 04:37:15 INFO - 'TERM': 'linux', 04:37:15 INFO - 'TMOUT': '86400', 04:37:15 INFO - 'USER': 'cltbld', 04:37:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:15 INFO - '_': '/tools/buildbot/bin/python'} 04:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:37:15 INFO - Cleaning up... 04:37:15 INFO - Return code: 0 04:37:15 INFO - Running post-action listener: _resource_record_post_action 04:37:15 INFO - Running post-action listener: _start_resource_monitoring 04:37:15 INFO - Starting resource monitoring. 04:37:15 INFO - ##### 04:37:15 INFO - ##### Finished create-virtualenv step (success) 04:37:15 INFO - ##### 04:37:15 INFO - ##### 04:37:15 INFO - ##### Running install step. 04:37:15 INFO - ##### 04:37:15 INFO - Running pre-action listener: _resource_record_pre_action 04:37:15 INFO - Running main action method: install 04:37:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:15 INFO - Reading from file tmpfile_stdout 04:37:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:15 INFO - Reading from file tmpfile_stdout 04:37:15 INFO - Output received: 04:37:15 INFO - Usage: mozinstall [options] installer 04:37:15 INFO - Options: 04:37:15 INFO - -h, --help show this help message and exit 04:37:15 INFO - -d DEST, --destination=DEST 04:37:15 INFO - Directory to install application into. [default: 04:37:15 INFO - "/builds/slave/test"] 04:37:15 INFO - --app=APP Application being installed. [default: firefox] 04:37:15 INFO - mkdir: /builds/slave/test/build/application 04:37:15 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'] 04:37:15 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 04:37:32 INFO - Reading from file tmpfile_stdout 04:37:32 INFO - Output received: 04:37:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:37:32 INFO - Running post-action listener: _resource_record_post_action 04:37:32 INFO - ##### 04:37:32 INFO - ##### Finished install step (success) 04:37:32 INFO - ##### 04:37:32 INFO - ##### 04:37:32 INFO - ##### Running run-tests step. 04:37:32 INFO - ##### 04:37:32 INFO - Running pre-action listener: _resource_record_pre_action 04:37:32 INFO - Running main action method: run_tests 04:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:32 INFO - Python 2.7.3 04:37:32 INFO - Return code: 0 04:37:32 INFO - grabbing minidump binary from tooltool 04:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:32 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 0x1c593b0>, '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 0x1c5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:37:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:37:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:37:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:32 INFO - Return code: 0 04:37:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:37:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:37:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:32 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/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:37:32 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/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:37:32 INFO - Using env: {'DISPLAY': ':0', 04:37:32 INFO - 'HOME': '/home/cltbld', 04:37:32 INFO - 'LANG': 'en_US.UTF-8', 04:37:32 INFO - 'LANGUAGE': 'en_US:en', 04:37:32 INFO - 'LOGNAME': 'cltbld', 04:37:32 INFO - 'MAIL': '/var/mail/cltbld', 04:37:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:32 INFO - 'MOZ_NO_REMOTE': '1', 04:37:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:32 INFO - 'NO_EM_RESTART': '1', 04:37:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:32 INFO - 'PWD': '/builds/slave/test', 04:37:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:32 INFO - 'SHELL': '/bin/bash', 04:37:32 INFO - 'SHLVL': '1', 04:37:32 INFO - 'TERM': 'linux', 04:37:32 INFO - 'TMOUT': '86400', 04:37:32 INFO - 'USER': 'cltbld', 04:37:32 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285', 04:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:32 INFO - '_': '/tools/buildbot/bin/python'} 04:37:32 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/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:37:32 INFO - mozversion application_buildid: 20160712041226 04:37:32 INFO - mozversion application_changeset: 829e9870eb1d9cd4e5acb894350d4bfc12e3345d 04:37:32 INFO - mozversion application_display_name: Nightly 04:37:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:32 INFO - mozversion application_name: Firefox 04:37:32 INFO - mozversion application_remotingname: firefox 04:37:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:37:32 INFO - mozversion application_vendor: Mozilla 04:37:32 INFO - mozversion application_version: 50.0a1 04:37:32 INFO - mozversion platform_buildid: 20160712041226 04:37:32 INFO - mozversion platform_changeset: 829e9870eb1d9cd4e5acb894350d4bfc12e3345d 04:37:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:37:32 INFO - mozversion platform_version: 50.0a1 04:37:32 INFO - using testdate: 1468323452 04:37:32 INFO - actual date: 1468323452 04:37:32 INFO - starting webserver on 'localhost:35354' 04:37:32 INFO - SUITE-START | Running 2 tests 04:37:32 INFO - TEST-START | dromaeo_css 04:37:32 INFO - operating with platform_type : linux_ 04:37:32 INFO - Initialising browser for dromaeo_css test... 04:37:32 INFO - TEST-INFO | started process 14522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiIo2pL/profile http://localhost:35354/getInfo.html) 04:37:50 INFO - PROCESS | 14522 | __metrics Screen width/height:1600/1200 04:37:50 INFO - PROCESS | 14522 | colorDepth:24 04:37:50 INFO - PROCESS | 14522 | Browser inner width/height: 1024/697 04:37:50 INFO - PROCESS | 14522 | __metrics 04:37:52 INFO - PROCESS | 14522 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:37:52 INFO - PROCESS | 14522 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:53 INFO - PROCESS | 14522 | console.error: PushService: 04:37:53 INFO - PROCESS | 14522 | stateChangeProcessEnqueue: Error transitioning state 04:37:53 INFO - PROCESS | 14522 | UnknownError 04:37:53 INFO - TEST-INFO | 14522: exit 0 04:37:53 INFO - Browser initialized. 04:37:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:53 INFO - TEST-INFO | started process 14605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiIo2pL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:05 INFO - PROCESS | 14605 | RSS: Main: 158195712 04:38:05 INFO - PROCESS | 14605 | 04:38:56 INFO - PROCESS | 14605 | 1468323536946 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:41:10 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:35354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35354/tests/dromaeo/cssquery-ext.html) 04:41:11 INFO - PROCESS | 14605 | RSS: Main: 271646720 04:41:11 INFO - PROCESS | 14605 | 04:44:14 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:35354/tests/dromaeo/cssquery-ext.html (next: http://localhost:35354/tests/dromaeo/cssquery-jquery.html) 04:44:14 INFO - PROCESS | 14605 | RSS: Main: 242966528 04:44:14 INFO - PROCESS | 14605 | 04:47:17 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:35354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35354/tests/dromaeo/cssquery-mootools.html) 04:47:17 INFO - PROCESS | 14605 | RSS: Main: 236253184 04:47:17 INFO - PROCESS | 14605 | 04:50:19 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:35354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35354/tests/dromaeo/cssquery-prototype.html) 04:50:20 INFO - PROCESS | 14605 | RSS: Main: 242671616 04:50:20 INFO - PROCESS | 14605 | 04:53:23 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:35354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35354/tests/dromaeo/cssquery-yui.html) 04:53:24 INFO - PROCESS | 14605 | RSS: Main: 214949888 04:53:24 INFO - PROCESS | 14605 | 04:56:27 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:35354/tests/dromaeo/cssquery-yui.html (next: http://localhost:35354/tests/dromaeo/cssquery-dojo.html) 04:56:27 INFO - PROCESS | 14605 | RSS: Main: 274485248 04:56:27 INFO - PROCESS | 14605 | 04:56:27 INFO - PROCESS | 14605 | __start_tp_report 04:56:27 INFO - PROCESS | 14605 | _x_x_mozilla_page_load 04:56:27 INFO - PROCESS | 14605 | _x_x_mozilla_page_load_details 04:56:27 INFO - PROCESS | 14605 | |i|pagename|runs| 04:56:27 INFO - PROCESS | 14605 | |0;dojo.html;2602.2193341997395;2618.9607155892677;2654.508915850568;2670.2656769388414;2673.278214881982;4558.27067669173;4642.930356044653;4734.739589322586;4753.35829662995;4796.16067188242;4618.237990731525;4630.884227894304;4643.442786865572;4675.532446755323;4675.994661147853;4095.672346212296;4298.935515967255;4328.112736888946;4361.149575832698;4466.575675310856;4380.89047773805;4413.3821265022925;4421.867343979686;4428.955710442887;4450.421445212134;4207.305794543897;4252.829886804524;4285.914281714379;4319.913601727979;4334.32817913224;4280.743155410654;4289.506706728735;4294.849680261207;4376.824927002916;4396.076823866992;4295.183915056129;4324.935125973113;4325.070109926381;4375.059362237134;4376.978115109404;4555.681102322838;4608.078384323148;4648.325992731069;4759.524047595212;4765.785539650724;4957.479464656231;4994.450610432849;5027.4469808321055;5042.470540593258;5044.319016932704;4998.075356059141;5047.596192304643;5051.873703157414;5071.822486212965;5075.086484432801;4625;4713.835015774465;4730.124926888468;4773.355596994431;4775.2598347256235;5260.868478287997;5270.7628156733035;5274.551663108678;5285.762140703678;5289.100852855024;5014;5029.673071250357;5056.494350564914;5075.822346217865;5077.1876499759865;4898.559129678346;5010.974945125324;5051.545360917535;5055.595552355802;5081.034603425337;4993.80024799004;5013.89972200554;5024.371953505812;5026.447090820006;5072.974635126875;4874.8050077997195;5001.8499445016705;5006.824761133343;5008.724520151427;5012.789257024117;4190.706650534495;4205.327147656421;4226.197022565702;4243.830246790156;4299;3673.522442082512;3677.356462619031;3689.262147570497;3722.925541489155;3729.384651532521;4360.672949528798;4367.5414081520985;4371.934420983688;4380.890477738082;4419.292913133883;4927.1131196384995;5010.974945125251;5037.748112594356;5067.569256613229;5083.949160508348;4350.521442641307;4361.825526978949;4373;4374.650027997753;4415.889602759957;4344.478662560513;4535.523770004168;4537.886552836206;4538.500764915857;4566.474855391606;4730.1958667027375;4743.573078422958;4767.76161191946;4774.594159496482;4780.545848144421;5032.295478633067;5065.468125846733;5067.41724701664;5069.645124841226;5113.463086375877;4577;4766.261229509431;4766.737829419415;4769.8313913091515;4819.3252944588485;4872.756362181806;4904.411470623548;4932.3094766731965;4936.605071594336;4953.2074868020945;4992.301077849032;4997.350344455198;5000.14997450427;5002.149634562061;5046.21783623539;4794.856154315376;4872.123017856678;4881.682690625098;4884.9511504884495;4929.852104436873;4908.386451693538;4934.7285899275885;4954.529319714621;4958.7024778513405;5011.949880501148;4836.782344794422;4852.587530059985;4896.877578060435;4905.190643543775;4905.23968784839;4831.323614694016;4931.3589233399425;4960.77676504551;4975.054739599609;4993.275974983534;4848.393950756155;4872.658913875995;4876.073546026244;4912.091263116335;4917.557419832089 04:56:27 INFO - PROCESS | 14605 | |1;ext.html;543.207345877727;581.6161333519877;587.0870795912357;592.4756590417479;596.8120042186711;26468.338291542696;26894.462110757773;29006.984755533587;38956;39673.206535869336;36738.81630591843;37163.81418092906;37209.25581488368;41335.17329653405;41347.58652413475;7858.09631892334;7981.720639777609;8001.199880011981;8007.559584222866;8009.479383840061;7572.697092116308;7851.528908265494;9842.163416109639;10105.54525046371;10106.242031847603;10321.12270457012;10378;10388.117010054155;10397.948010259975;10401.479926003707;10142.391456512596;10186.54160562769;10200.38797672142;10203.234757393151;10208.89791102087;9931.801363972752;10144.289899707024;10148.289619726622;10157;10161.745956351151;39625.80187099075;39944.400833987514;39965.60034399648;39990.40014399786;40029.19795614308;3175.6189257289043;3175.9206019849457;3233.0462513558555;3382.9492557611657;3391.5421418108485;29482.705172948212;29732.40535189284;30004.69995300063;30178.09465716032;30643.233919151975;3486.556034290418;3532.2935412917263;3549.3256281306726;3562;3614.6566076222716;199725;289997;292790;293077;427139;54384;55241.44758552443;55252.723736381864;55406.722966385714;55465.44534554683;58026.22829516068;58569.41430585725;58661.53346166295;58669;58740;13905.304734763222;14108.435662573587;14115.858841411455;14129.57611271643;14294;9202.76993075165;11337.433128343715;11386.08911287095;11421.143414243965;11424.885751142549;17631.294748210184;17941.910290448726;18085.819141808675;18623.81376186248;18707.345242916705;6846.965765171142;7008.7546935857;7019.016917810012;7038.824029399204;7039.894401583981;781.0783275734574;866.8266346730679;891.6656253904786;1020.640273753123;1027.7482016905906;27994;28420;28725.138245852657;29035.854820725763;29208.415831683247;915.5834095486671;929.6201723587637;968.7432830299977;971.7764914069803;1061.8725752909545;13913.513027044004;14734.557963261119;14739.778903316244;14764.40942362315;14824.851751482563;410439;411361;417085;417153;417766;47805;49059.26411103836;49080.26379604309;49093.26360104601;49232;1044.639599338227;1131.2533727739817;1138.08384250679;1228.1955319265894;1245.3337464456472;20667.793322066587;28239.576406354332;28342;28560.42879142447;29120.854395727885;40558.39162412507;41179.7941010293;41185.79407103065;41205;41253;254811;263447;264156;264174;264523;21612.838716128263;24082.397940050938;24244.755244755244;24579;24756.876215618806;41036.58963410328;41430.1713965725;41484.1703165941;41811.37282940819;42017;34941;35775.82112089423;36076.4588531167;36127.81936090303;36175.81912090423;34619.82690086634;35154.64845351514;35182.64817351794;35289.82355088208;35567.82216088903;34165.145871353416;34940.825295874376;35018;35124.824375878976;35295.94112176639;31438.214044649067;31869.36261274808;32083;32087.679123209404;32241.03276901697;23906.28281151568;25777.742222577534;25962.870185649706;25968.350791229615;26536.203913882615 04:56:27 INFO - PROCESS | 14605 | |2;jquery.html;356.7217570295169;356.84477252395203;363.76355369010156;379.78731910130347;392.6132759232158;15919.76120358194;16709;17351.47945561635;17408.129593520305;17457.476275711717;16390.754138687927;16803;17646.999999999967;17654.47036588901;17661.293548258087;4915.5084491550915;5013.598912087043;5047.596192304625;5053.494650534935;5055.79776808929;3749.6250374962424;3932.8820135395986;5279;5911.231539899807;6228.22147231596;6274.780382686607;6288.71700773464;6305.432511074003;6319.241690997087;6320.020396838498;6101.145839582462;6170.444659980601;6266.060090986343;6307.590006649576;6308.9684551577175;3379.746519011084;5113.59091272701;5416.21464887593;5416.7020813855615;5440.075187218183;20775.16899324025;21472.677909831364;21527;21534.353969380943;21574.892125539427;2096.119629755506;2101.401100686297;2124.1935885620283;2224.8665080095248;2366.810655147584;12916.935415322958;13408.396622152026;13613.591592252149;13620.863791362059;13817.585472435843;1701.7277235642362;1723.500184946364;1766.5318690547015;1767.2400867626916;1777.2713187593024;67941.66029169872;69709.65145174292;69967.3003269971;71042.28957710408;71089;9407.764805879771;9609.759756006155;9622.663206787729;9706.75733106664;10151.868107697319;13244.271565064015;13254.801177982337;13262.403191856389;13272.004599655065;13322.73354532904;6914.757983470555;7006.719731210796;7173.964130179315;7178.138623365126;7186.38915692172;6653.234877988996;6664.966930125838;6684.799456016327;6820.522563420513;6822.215445223863;5732.885342293214;5792.623479473821;6018.488428483541;6054.182685337511;6058.697065146725;1587.484067677986;1706.1810331040922;1736.9826301737073;1764.250193667686;1791.1492041280287;750.8761054426068;863.8617821148586;874.501534125555;900.1808354397467;921.5944984206927;16917.90033647809;17471;17913.37303194408;17948.102594870204;18214.36249731253;821.1706176761514;845.1210740829468;876.9429987050821;904.0101089307329;910.6402970826487;9726.358851555233;10298.485075746332;10310.896891031143;10324.12244959172;10455.424951627581;376889;378168;382622;384014;386194;71284;72572.91140632895;73052;73552;74372;843.6836186430089;908.1962463219966;924.3021518753433;938.887333519982;940;14837.554873353816;15457.227138643248;16206.756898646765;16656.16782153938;16745.162741863103;25277.747222528276;32492.512612311308;34040.14899627529;34708;35008.47487287642;42787;43574;44385.55614443943;44467.33299000453;44488.777556112014;6825.897611535732;7056.470764692771;7238.8914166288605;7261.419086473175;7731.381489480716;8058.073321568095;11554.884451155716;11759.706007349885;12345.506179753069;12404.38742963409;9791.804163916824;10282.485875706334;10525.210609204187;10600.363978161335;10731.517081731185;10098.19214462856;10374.792504150026;10439.739006524898;10440.63457778974;10462.68611941643;9922.900770992486;10294.742631434274;10462.110720588835;10687.679369618923;11091.833622495507;7191.7842464726145;7212.206657267801;7253.057102576631;7265.491415600857;7315.597642129734;9253.861192082259;10441.947790261303;10469.895301046892;10788.568457261621;11094.334339939307 04:56:27 INFO - PROCESS | 14605 | |3;mootools.html;1348.1910853487905;1396.6578188343858;1460.2917584971294;1635.05984059166;1677.7399503077027;6958.130233720785;7340.889886651705;7400.296971787671;7403.259674032594;7418.701727197739;6319.905201421971;6956.200036995747;7129.893051604217;7139.1789944156435;7311.561306321624;2197.044285735702;2222.622154233776;2225.9666105008437;2225.977740222593;2226.2875879718495;1851.9629607407844;2181.214762685432;2192.375173075674;2204.889755512226;2204.944876378095;2053.3634573282256;2123.5115923337644;2134.3170185540635;2142.8500004999655;2157.385145233609;2167.4581354661336;2171.913123475059;2193.8793366364844;2198.758136604972;2203.3830527452337;2139.967900481494;2140.49698320896;2144.6675765256255;2146.37755051035;2147.3450597567894;7277.490575659706;7317;7338.046054012998;7343.77968660941;7344.192138864774;4339.7830108494445;4452;4504.211762941472;4511.052678937427;4520.954790452086;2783.846888421136;2822.26621078519;2889.8844046238123;2900.6809250982374;2908.6945870683485;836.9121242269596;839.0812060793421;854.9871751923727;861.2722249698994;861.9310455163571;9764.609415623296;9800.26498012652;9810.117089461912;9810.852837207447;9817.214622830228;3966.1869316790567;4034.3746719257974;4194.0563373240775;4203.033302340479;4203.348480985391;8349.165083491602;8375.329973602098;8502.362322825813;8507.27688146502;8511.914880851236;4441.045175287329;4447.666425018072;4448.065906159743;4451.755153466525;4454.331850222427;4025.19496100781;4044.1911617676583;4052.2705912935367;4072.572379900068;4101.89745256365;3529.6999755020597;3570.5001299818045;3584.910377240538;3623.3115708015393;3638.7816730996224;1010.6967909627083;1131.5586921100778;1165.8600967883908;1191.773563023023;1215.501644325822;713.350850725837;768.3430666779823;804.5735760047185;820.0815087102484;848.5502683577714;4883.218685010382;4937.284093806378;5240.135377662643;5263.841435393336;5488.094464413327;787.6652422720321;813.7762115418308;826.3802148388709;844.907060223375;847.2798121596717;3518.7712798668003;3547.343741407848;3576;3597.712183025352;3654.7258955578436;8594.14058594148;8955.328350373748;9068.637254509746;9107.908920910839;9129.863052054225;7928.286454219033;8294.875576866352;9020.819583608421;9021.909780902239;9063.048379920145;6658;6927.3419025192525;6931.792046238621;6949.027136200936;6959.512834101564;5238.921416178684;5246.816361427332;5309.946900530946;5357;5414.052540805422;8154.714584989497;8185.263326300424;8207.876881846896;8277.213664701843;8286.171382861665;7817.5309481431295;8057.798555035936;8088.636011379384;8364.832703346021;8381.622826972678;6439.484841212598;6595.769148079794;6597;6607.07500949877;6608.867822643617;6901.827454313682;6960.651967401711;6983.930160698328;7002.579845209304;7010.123734533184;6375.362463753588;6399.072134540559;6486.610803351814;6536.803895883131;6624.503162262753;6301.464375528131;6360.96819515918;6396.328385519453;6398;6524.706388212447;5996.220491336098;6017.909731354121;6033;6072.180255665606;6085.513158947362;4391.692581519263;4511.819527218874;4588.357629931746;4619.491855895782;4623;4393.143337049245;4409.096135292193;4409.514953355192;4495.21333766583;4586.312053192048 04:56:27 INFO - PROCESS | 14605 | |4;prototype.html;293.6036350926249;297.4586253019505;298.91480927935544;299.73024278149677;300.1520704011168;4898.70607763534;4922.483139270379;4932.926006109907;4961.950380496194;4977.800887964481;4844.346013288205;4852.670718055336;4891.144049791281;4897.167481528139;4904.901901961958;3659.2315613721153;3779.903827889909;3804.980975095121;3857.864974725885;3873.4383514390397;3828.119532507525;3868.3810590305557;3869.1487872667967;3906.6484016438517;3908.902277443058;3823.7955044161;3826.196498735269;3827.8468861245515;3840.9231815363814;3854.9421758673643;3630.382834918057;3735.981320093396;3853.8611070855663;3872.5933776953298;3874.9806250968845;3415.9316813663586;3419.9145021374416;3429.3484237994703;3441.294534620422;3442.3631628148873;4759.095771803346;4768.284757286435;4775.689580177277;4802.5197480252045;4809.206480930642;4100.8675488745685;4358.193734159191;4403.3174857897075;4412.75729834859;4423.1153769246275;5094.439611642716;5103.770330335144;5142.434332223453;5165.173572228463;5180.300659411007;3655.4151335786414;3658.396364599838;3675.467057276707;3681.337359275329;3688.963110368889;5041.70602375918;5353.625246232727;5364.409914909357;5395.81114660985;5403.351597808249;3728.4780130781714;3728.496652951871;3742.139307959185;3746.5129533160516;3747.3816820224356;3787.659110680052;3788.5453745550158;3794.5446546414605;3805.334066538345;3806.619338066171;4360.716553424018;4369.3227549729845;4369.934450983238;4376.431063961728;4381.364702118175;5044.899102017939;5104.081265372269;5115.335006449212;5117.667351622133;5139.408967968657;1287.7682017236987;1299.3373379576294;1307.405130665545;1317.7562151001903;1321.458202137119;842.7556008757392;843.6709683223547;861.5907443964066;862.6376921692904;872.3326655108847;4414;4416.955830441719;4428.365122751958;4587.954120458753;4598.724076555417;5259.47405259471;5275.050490911596;5278.894422111536;5292.44429334922;5298.655587386807;4334.4798624165305;4494.70784399013;4505.594496495266;4512.555982085701;4524.547545245449;2800.901968431095;2810.580656768319;2815.3946901415884;2818.534941734591;2828.3070647691034;4901.142300097468;4968.329275547827;4975.776090075955;4985.52637499437;4988.12707776145;5098.388193416739;5357.651752636144;5373.516383525502;5377.5429088527135;5445.782168713207;4982.725950072709;4986.376702912208;4999.325091112726;5001.224810154432;5017.54842064216;5304.427352733844;5306.734663266744;5309.6725818545365;5321.813736519203;5344.144936810092;4955.6531042826655;5156.1750119980625;5178.508041736029;5225.790968361223;5233.633645644921;4999.400071991385;5013.749312534432;5019.64862459639;5028.270900719302;5041.470645582161;3782.4893639359434;3786.583475817713;3789.8673546426844;3795.829187686616;3816.7900765457057;5132.43543210254;5276.841694749163;5295.25866378715;5342.1452567589;5357.249985002025;5091.796328146981;5141.562967147835;5143.948560514496;5156.432792392909;5170.6380553360905;5096.031753966735;5125.74371281427;5148.742562871917;5156.329677141947;5179.404368497671;4865.56209941107;5022.3219865317715;5042.369703787027;5042.949570504248;5049.444561098349;4926.679765815211;5022.773975171053;5139.229115632685;5159.535641792257;5162.425460234665;5024.84925452237;5052.646314757932;5066.36670416198;5075.619328550448;5077.720725360141 04:56:27 INFO - PROCESS | 14605 | |5;yui.html;654.8297442664907;690.5545922879746;717.9030830837835;724.0551080839504;755.1089714137315;12207.450664720087;13124.606261812149;13921.30393480327;14304.427822887099;14323.641908952255;14699.338529766159;14709.926450367733;14809.555713328591;14889.627759306022;14895.404183832661;634.4955760170675;771.5062360089547;789.8696715042012;797.7367468735304;812.1513018895268;797.9122296547404;804.8953636027309;806.3549160671469;807.6688557691348;807.9192080791903;844.7170197983683;845.5265051571109;845.8223773007645;846.327169899931;846.8899043124385;648.7761722205831;800.903891533014;824.3199360527589;825.9091499935003;840.2857571064608;602.7016626769733;602.8583282928508;605.6729366142278;605.6941244671413;607.3835057416726;13832.30838458083;13852.099613525088;13872.722545549133;13875.444982200699;13876.861231387658;12085.516579336816;12660.366981650972;12701.745965080647;12795.168314059649;12964.611061668165;11480.425978701114;11487.540498380054;11661.183717139804;11737.471813768401;12273.140880138393;4065.9593404065877;4092.386142078682;4107.404426358161;4158.854440094612;4165.541790403053;59980.70009649968;60673.696631517;60824.695876520775;60865;60874.695626521585;9997.550110245056;10106.444145572064;10128.645497407555;10267;10449.529771160316;17834;17910.91044544795;17940.19269132892;17967.73048404275;17969.820301796815;6375.458086062644;6395.616263024233;6523.24982627004;6570.474362051024;6589.044588534635;3523.841427135785;3545.7163426925786;3568.3933731265747;3583.516225309602;3618.366785812525;2749.9037533686223;2839.730225628562;2847.3308772438872;2848.51575232211;2849.743523082891;483.48750324655276;491.4618492750433;494.1796617614742;495.72982724415283;507.26446652354235;456.6506622433841;469.06277075677235;474.077918448621;518.5980864829787;525.5086494128003;7096.396806271421;7129.108861392326;7432.702691892372;7546.1321947976685;7706;540.9667535008194;548.6488647265753;552.8009916430082;586.4077281945181;592.295168749187;3452.5339079224486;3598.712103031751;3663.2307215484516;3683.1528748388023;3752.3245815753426;58986.705066474395;91018.54490727636;92512;92790;93361.5331923336;80154;80445.55567200122;81178.59410703027;81827;83104;64619.35380646228;73490.63254683692;74012.62993684997;74424.62787686136;74500.25499745042;7253.8186545336785;7272.346744536133;7281.599512026889;7395.334419902019;8242.587870606565;33627.83186084054;34713.13217169591;41051.384229237185;42917.356239657056;44493.77753111214;41060.79469602633;51593;55366.72316638552;61592.38407615866;62795;10823.350598964087;11129.332240065622;11202.551897924317;11239.65124185103;11432.94283528577;12272.877271227173;12451.377431128589;12503.499860005499;12506.499740010298;13015.804762928374;11507.654770356903;11839.112066594867;11996.76006479848;12068.698282543006;12123;10743.731406714895;10895.782084358427;11620.593279235187;11842.881571184178;12448.128630995743;10857.185711071543;10901.454927253764;10908.563657453931;11192.776144477228;11580.073594112619;10121.443320617142;10334.689959301233;10416.687499375032;10738.087262582769;10801.297915635772;8721.476711397336;8919.910800892168;9216.447013179231;9272.708188592953;9802.558884850056 04:56:27 INFO - PROCESS | 14605 | __end_tp_report 04:56:27 INFO - PROCESS | 14605 | __start_cc_report 04:56:27 INFO - PROCESS | 14605 | _x_x_mozilla_cycle_collect,1119 04:56:27 INFO - PROCESS | 14605 | __end_cc_report 04:56:27 INFO - PROCESS | 14605 | __startTimestamp1468324587358__endTimestamp 04:56:27 INFO - PROCESS | 14605 | 04:56:27 INFO - PROCESS | 14605 | ------- Summary: start ------- 04:56:27 INFO - PROCESS | 14605 | Number of tests: 6 04:56:27 INFO - PROCESS | 14605 | 04:56:27 INFO - PROCESS | 14605 | [#0] dojo.html Cycles:165 Average:4658.04 Median:4780.55 stddev:492.83 (10.3%) stddev-sans-first:467.21 04:56:27 INFO - PROCESS | 14605 | Values: 2602.2 2619.0 2654.5 2670.3 2673.3 4558.3 4642.9 4734.7 4753.4 4796.2 4618.2 4630.9 4643.4 4675.5 4676.0 4095.7 4298.9 4328.1 4361.1 4466.6 4380.9 4413.4 4421.9 4429.0 4450.4 4207.3 4252.8 4285.9 4319.9 4334.3 4280.7 4289.5 4294.8 4376.8 4396.1 4295.2 4324.9 4325.1 4375.1 4377.0 4555.7 4608.1 4648.3 4759.5 4765.8 4957.5 4994.5 5027.4 5042.5 5044.3 4998.1 5047.6 5051.9 5071.8 5075.1 4625.0 4713.8 4730.1 4773.4 4775.3 5260.9 5270.8 5274.6 5285.8 5289.1 5014.0 5029.7 5056.5 5075.8 5077.2 4898.6 5011.0 5051.5 5055.6 5081.0 4993.8 5013.9 5024.4 5026.4 5073.0 4874.8 5001.8 5006.8 5008.7 5012.8 4190.7 4205.3 4226.2 4243.8 4299.0 3673.5 3677.4 3689.3 3722.9 3729.4 4360.7 4367.5 4371.9 4380.9 4419.3 4927.1 5011.0 5037.7 5067.6 5083.9 4350.5 4361.8 4373.0 4374.7 4415.9 4344.5 4535.5 4537.9 4538.5 4566.5 4730.2 4743.6 4767.8 4774.6 4780.5 5032.3 5065.5 5067.4 5069.6 5113.5 4577.0 4766.3 4766.7 4769.8 4819.3 4872.8 4904.4 4932.3 4936.6 4953.2 4992.3 4997.4 5000.1 5002.1 5046.2 4794.9 4872.1 4881.7 4885.0 4929.9 4908.4 4934.7 4954.5 4958.7 5011.9 4836.8 4852.6 4896.9 4905.2 4905.2 4831.3 4931.4 4960.8 4975.1 4993.3 4848.4 4872.7 4876.1 4912.1 4917.6 04:56:27 INFO - PROCESS | 14605 | 04:56:27 INFO - PROCESS | 14605 | [#1] ext.html Cycles:180 Average:48044.33 Median:34392.49 stddev:88376.90 (257.0%) stddev-sans-first:88552.86 04:56:27 INFO - PROCESS | 14605 | Values: 543.2 581.6 587.1 592.5 596.8 26468.3 26894.5 29007.0 38956.0 39673.2 36738.8 37163.8 37209.3 41335.2 41347.6 7858.1 7981.7 8001.2 8007.6 8009.5 7572.7 7851.5 9842.2 10105.5 10106.2 10321.1 10378.0 10388.1 10397.9 10401.5 10142.4 10186.5 10200.4 10203.2 10208.9 9931.8 10144.3 10148.3 10157.0 10161.7 39625.8 39944.4 39965.6 39990.4 40029.2 3175.6 3175.9 3233.0 3382.9 3391.5 29482.7 29732.4 30004.7 30178.1 30643.2 3486.6 3532.3 3549.3 3562.0 3614.7 199725.0 289997.0 292790.0 293077.0 427139.0 54384.0 55241.4 55252.7 55406.7 55465.4 58026.2 58569.4 58661.5 58669.0 58740.0 13905.3 14108.4 14115.9 14129.6 14294.0 9202.8 11337.4 11386.1 11421.1 11424.9 17631.3 17941.9 18085.8 18623.8 18707.3 6847.0 7008.8 7019.0 7038.8 7039.9 781.1 866.8 891.7 1020.6 1027.7 27994.0 28420.0 28725.1 29035.9 29208.4 915.6 929.6 968.7 971.8 1061.9 13913.5 14734.6 14739.8 14764.4 14824.9 410439.0 411361.0 417085.0 417153.0 417766.0 47805.0 49059.3 49080.3 49093.3 49232.0 1044.6 1131.3 1138.1 1228.2 1245.3 20667.8 28239.6 28342.0 28560.4 29120.9 40558.4 41179.8 41185.8 41205.0 41253.0 254811.0 263447.0 264156.0 264174.0 264523.0 21612.8 24082.4 24244.8 24579.0 24756.9 41036.6 41430.2 41484.2 41811.4 42017.0 34941.0 35775.8 36076.5 36127.8 36175.8 34619.8 35154.6 35182.6 35289.8 35567.8 34165.1 34940.8 35018.0 35124.8 35295.9 31438.2 31869.4 32083.0 32087.7 32241.0 23906.3 25777.7 25962.9 25968.4 26536.2 04:56:27 INFO - PROCESS | 14605 | 04:56:27 INFO - PROCESS | 14605 | [#2] jquery.html Cycles:180 Average:23887.33 Median:385104.00 stddev:62850.05 (16.3%) stddev-sans-first:63001.53 04:56:27 INFO - PROCESS | 14605 | Values: 356.7 356.8 363.8 379.8 392.6 15919.8 16709.0 17351.5 17408.1 17457.5 16390.8 16803.0 17647.0 17654.5 17661.3 4915.5 5013.6 5047.6 5053.5 5055.8 3749.6 3932.9 5279.0 5911.2 6228.2 6274.8 6288.7 6305.4 6319.2 6320.0 6101.1 6170.4 6266.1 6307.6 6309.0 3379.7 5113.6 5416.2 5416.7 5440.1 20775.2 21472.7 21527.0 21534.4 21574.9 2096.1 2101.4 2124.2 2224.9 2366.8 12916.9 13408.4 13613.6 13620.9 13817.6 1701.7 1723.5 1766.5 1767.2 1777.3 67941.7 69709.7 69967.3 71042.3 71089.0 9407.8 9609.8 9622.7 9706.8 10151.9 13244.3 13254.8 13262.4 13272.0 13322.7 6914.8 7006.7 7174.0 7178.1 7186.4 6653.2 6665.0 6684.8 6820.5 6822.2 5732.9 5792.6 6018.5 6054.2 6058.7 1587.5 1706.2 1737.0 1764.3 1791.1 750.9 863.9 874.5 900.2 921.6 16917.9 17471.0 17913.4 17948.1 18214.4 821.2 845.1 876.9 904.0 910.6 9726.4 10298.5 10310.9 10324.1 10455.4 376889.0 378168.0 382622.0 384014.0 386194.0 71284.0 72572.9 73052.0 73552.0 74372.0 843.7 908.2 924.3 938.9 940.0 14837.6 15457.2 16206.8 16656.2 16745.2 25277.7 32492.5 34040.1 34708.0 35008.5 42787.0 43574.0 44385.6 44467.3 44488.8 6825.9 7056.5 7238.9 7261.4 7731.4 8058.1 11554.9 11759.7 12345.5 12404.4 9791.8 10282.5 10525.2 10600.4 10731.5 10098.2 10374.8 10439.7 10440.6 10462.7 9922.9 10294.7 10462.1 10687.7 11091.8 7191.8 7212.2 7253.1 7265.5 7315.6 9253.9 10441.9 10469.9 10788.6 11094.3 04:56:27 INFO - PROCESS | 14605 | 04:56:27 INFO - PROCESS | 14605 | [#3] mootools.html Cycles:180 Average:4881.00 Median:6007.07 stddev:2618.84 (43.6%) stddev-sans-first:2612.73 04:56:27 INFO - PROCESS | 14605 | Values: 1348.2 1396.7 1460.3 1635.1 1677.7 6958.1 7340.9 7400.3 7403.3 7418.7 6319.9 6956.2 7129.9 7139.2 7311.6 2197.0 2222.6 2226.0 2226.0 2226.3 1852.0 2181.2 2192.4 2204.9 2204.9 2053.4 2123.5 2134.3 2142.9 2157.4 2167.5 2171.9 2193.9 2198.8 2203.4 2140.0 2140.5 2144.7 2146.4 2147.3 7277.5 7317.0 7338.0 7343.8 7344.2 4339.8 4452.0 4504.2 4511.1 4521.0 2783.8 2822.3 2889.9 2900.7 2908.7 836.9 839.1 855.0 861.3 861.9 9764.6 9800.3 9810.1 9810.9 9817.2 3966.2 4034.4 4194.1 4203.0 4203.3 8349.2 8375.3 8502.4 8507.3 8511.9 4441.0 4447.7 4448.1 4451.8 4454.3 4025.2 4044.2 4052.3 4072.6 4101.9 3529.7 3570.5 3584.9 3623.3 3638.8 1010.7 1131.6 1165.9 1191.8 1215.5 713.4 768.3 804.6 820.1 848.6 4883.2 4937.3 5240.1 5263.8 5488.1 787.7 813.8 826.4 844.9 847.3 3518.8 3547.3 3576.0 3597.7 3654.7 8594.1 8955.3 9068.6 9107.9 9129.9 7928.3 8294.9 9020.8 9021.9 9063.0 6658.0 6927.3 6931.8 6949.0 6959.5 5238.9 5246.8 5309.9 5357.0 5414.1 8154.7 8185.3 8207.9 8277.2 8286.2 7817.5 8057.8 8088.6 8364.8 8381.6 6439.5 6595.8 6597.0 6607.1 6608.9 6901.8 6960.7 6983.9 7002.6 7010.1 6375.4 6399.1 6486.6 6536.8 6624.5 6301.5 6361.0 6396.3 6398.0 6524.7 5996.2 6017.9 6033.0 6072.2 6085.5 4391.7 4511.8 4588.4 4619.5 4623.0 4393.1 4409.1 4409.5 4495.2 4586.3 04:56:27 INFO - PROCESS | 14605 | 04:56:27 INFO - PROCESS | 14605 | [#4] prototype.html Cycles:180 Average:4266.78 Median:4899.92 stddev:1236.17 (25.2%) stddev-sans-first:1203.13 04:56:27 INFO - PROCESS | 14605 | Values: 293.6 297.5 298.9 299.7 300.2 4898.7 4922.5 4932.9 4962.0 4977.8 4844.3 4852.7 4891.1 4897.2 4904.9 3659.2 3779.9 3805.0 3857.9 3873.4 3828.1 3868.4 3869.1 3906.6 3908.9 3823.8 3826.2 3827.8 3840.9 3854.9 3630.4 3736.0 3853.9 3872.6 3875.0 3415.9 3419.9 3429.3 3441.3 3442.4 4759.1 4768.3 4775.7 4802.5 4809.2 4100.9 4358.2 4403.3 4412.8 4423.1 5094.4 5103.8 5142.4 5165.2 5180.3 3655.4 3658.4 3675.5 3681.3 3689.0 5041.7 5353.6 5364.4 5395.8 5403.4 3728.5 3728.5 3742.1 3746.5 3747.4 3787.7 3788.5 3794.5 3805.3 3806.6 4360.7 4369.3 4369.9 4376.4 4381.4 5044.9 5104.1 5115.3 5117.7 5139.4 1287.8 1299.3 1307.4 1317.8 1321.5 842.8 843.7 861.6 862.6 872.3 4414.0 4417.0 4428.4 4588.0 4598.7 5259.5 5275.1 5278.9 5292.4 5298.7 4334.5 4494.7 4505.6 4512.6 4524.5 2800.9 2810.6 2815.4 2818.5 2828.3 4901.1 4968.3 4975.8 4985.5 4988.1 5098.4 5357.7 5373.5 5377.5 5445.8 4982.7 4986.4 4999.3 5001.2 5017.5 5304.4 5306.7 5309.7 5321.8 5344.1 4955.7 5156.2 5178.5 5225.8 5233.6 4999.4 5013.7 5019.6 5028.3 5041.5 3782.5 3786.6 3789.9 3795.8 3816.8 5132.4 5276.8 5295.3 5342.1 5357.2 5091.8 5141.6 5143.9 5156.4 5170.6 5096.0 5125.7 5148.7 5156.3 5179.4 4865.6 5022.3 5042.4 5042.9 5049.4 4926.7 5022.8 5139.2 5159.5 5162.4 5024.8 5052.6 5066.4 5075.6 5077.7 04:56:27 INFO - PROCESS | 14605 | 04:56:27 INFO - PROCESS | 14605 | [#5] yui.html Cycles:180 Average:16887.49 Median:462.86 stddev:23509.81 (5079.3%) stddev-sans-first:23544.16 04:56:27 INFO - PROCESS | 14605 | Values: 654.8 690.6 717.9 724.1 755.1 12207.5 13124.6 13921.3 14304.4 14323.6 14699.3 14709.9 14809.6 14889.6 14895.4 634.5 771.5 789.9 797.7 812.2 797.9 804.9 806.4 807.7 807.9 844.7 845.5 845.8 846.3 846.9 648.8 800.9 824.3 825.9 840.3 602.7 602.9 605.7 605.7 607.4 13832.3 13852.1 13872.7 13875.4 13876.9 12085.5 12660.4 12701.7 12795.2 12964.6 11480.4 11487.5 11661.2 11737.5 12273.1 4066.0 4092.4 4107.4 4158.9 4165.5 59980.7 60673.7 60824.7 60865.0 60874.7 9997.6 10106.4 10128.6 10267.0 10449.5 17834.0 17910.9 17940.2 17967.7 17969.8 6375.5 6395.6 6523.2 6570.5 6589.0 3523.8 3545.7 3568.4 3583.5 3618.4 2749.9 2839.7 2847.3 2848.5 2849.7 483.5 491.5 494.2 495.7 507.3 456.7 469.1 474.1 518.6 525.5 7096.4 7129.1 7432.7 7546.1 7706.0 541.0 548.6 552.8 586.4 592.3 3452.5 3598.7 3663.2 3683.2 3752.3 58986.7 91018.5 92512.0 92790.0 93361.5 80154.0 80445.6 81178.6 81827.0 83104.0 64619.4 73490.6 74012.6 74424.6 74500.3 7253.8 7272.3 7281.6 7395.3 8242.6 33627.8 34713.1 41051.4 42917.4 44493.8 41060.8 51593.0 55366.7 61592.4 62795.0 10823.4 11129.3 11202.6 11239.7 11432.9 12272.9 12451.4 12503.5 12506.5 13015.8 11507.7 11839.1 11996.8 12068.7 12123.0 10743.7 10895.8 11620.6 11842.9 12448.1 10857.2 10901.5 10908.6 11192.8 11580.1 10121.4 10334.7 10416.7 10738.1 10801.3 8721.5 8919.9 9216.4 9272.7 9802.6 04:56:27 INFO - PROCESS | 14605 | -------- Summary: end -------- 04:56:27 INFO - PROCESS | 14605 | 04:56:28 INFO - TEST-INFO | 14605: exit 0 04:56:28 INFO - TEST-OK | dromaeo_css | took 1135891ms 04:56:28 INFO - TEST-START | kraken 04:56:28 INFO - operating with platform_type : linux_ 04:56:28 INFO - Initialising browser for kraken test... 04:56:28 INFO - TEST-INFO | started process 14794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKcRNAG/profile http://localhost:35354/getInfo.html) 04:56:34 INFO - PROCESS | 14794 | __metrics Screen width/height:1600/1200 04:56:34 INFO - PROCESS | 14794 | colorDepth:24 04:56:34 INFO - PROCESS | 14794 | Browser inner width/height: 1024/697 04:56:34 INFO - PROCESS | 14794 | __metrics 04:56:36 INFO - PROCESS | 14794 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:56:36 INFO - PROCESS | 14794 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:37 INFO - TEST-INFO | 14794: exit 0 04:56:37 INFO - Browser initialized. 04:56:37 INFO - Running cycle 1/1 for kraken test... 04:56:37 INFO - TEST-INFO | started process 14876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKcRNAG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:49 INFO - PROCESS | 14876 | RSS: Main: 159092736 04:56:49 INFO - PROCESS | 14876 | 04:56:52 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35354/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:53 INFO - PROCESS | 14876 | RSS: Main: 216612864 04:56:53 INFO - PROCESS | 14876 | 04:56:55 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35354/tests/kraken/driver.html?testName=audio-dft) 04:56:56 INFO - PROCESS | 14876 | RSS: Main: 205025280 04:56:56 INFO - PROCESS | 14876 | 04:56:59 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35354/tests/kraken/driver.html?testName=audio-fft) 04:57:00 INFO - PROCESS | 14876 | RSS: Main: 270778368 04:57:00 INFO - PROCESS | 14876 | 04:57:02 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35354/tests/kraken/driver.html?testName=audio-oscillator) 04:57:03 INFO - PROCESS | 14876 | RSS: Main: 182128640 04:57:03 INFO - PROCESS | 14876 | 04:57:05 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:05 INFO - PROCESS | 14876 | RSS: Main: 186372096 04:57:05 INFO - PROCESS | 14876 | 04:57:09 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35354/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:09 INFO - PROCESS | 14876 | RSS: Main: 222048256 04:57:09 INFO - PROCESS | 14876 | 04:57:13 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35354/tests/kraken/driver.html?testName=imaging-desaturate) 04:57:13 INFO - PROCESS | 14876 | RSS: Main: 217604096 04:57:13 INFO - PROCESS | 14876 | 04:57:16 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35354/tests/kraken/driver.html?testName=json-parse-financial) 04:57:17 INFO - PROCESS | 14876 | RSS: Main: 220311552 04:57:17 INFO - PROCESS | 14876 | 04:57:19 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:19 INFO - PROCESS | 14876 | RSS: Main: 206725120 04:57:19 INFO - PROCESS | 14876 | 04:57:21 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35354/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:57:22 INFO - PROCESS | 14876 | RSS: Main: 211611648 04:57:22 INFO - PROCESS | 14876 | 04:57:24 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:57:25 INFO - PROCESS | 14876 | RSS: Main: 212414464 04:57:25 INFO - PROCESS | 14876 | 04:57:28 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:57:29 INFO - PROCESS | 14876 | RSS: Main: 226693120 04:57:29 INFO - PROCESS | 14876 | 04:57:31 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:32 INFO - PROCESS | 14876 | RSS: Main: 226672640 04:57:32 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | Cycle 1(1): loaded http://localhost:35354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35354/tests/kraken/driver.html?testName=ai-astar) 04:57:34 INFO - PROCESS | 14876 | RSS: Main: 268185600 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | __start_tp_report 04:57:34 INFO - PROCESS | 14876 | _x_x_mozilla_page_load 04:57:34 INFO - PROCESS | 14876 | _x_x_mozilla_page_load_details 04:57:34 INFO - PROCESS | 14876 | |i|pagename|runs| 04:57:34 INFO - PROCESS | 14876 | |0;ai-astar;107;115;115;116;114;115;114;114;115;113 04:57:34 INFO - PROCESS | 14876 | |1;audio-beat-detection;150;123;128;174;123;127;146;121;159;121 04:57:34 INFO - PROCESS | 14876 | |2;audio-dft;162;162;161;163;162;161;160;162;160;160 04:57:34 INFO - PROCESS | 14876 | |3;audio-fft;76;75;76;127;76;77;76;77;103;79 04:57:34 INFO - PROCESS | 14876 | |4;audio-oscillator;86;85;110;85;85;85;120;84;86;128 04:57:34 INFO - PROCESS | 14876 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 04:57:34 INFO - PROCESS | 14876 | |6;imaging-darkroom;147;147;147;147;147;147;147;146;147;145 04:57:34 INFO - PROCESS | 14876 | |7;imaging-desaturate;95;95;94;95;95;94;95;95;96;95 04:57:34 INFO - PROCESS | 14876 | |8;json-parse-financial;63;64;63;63;64;63;63;64;64;63 04:57:34 INFO - PROCESS | 14876 | |9;json-stringify-tinderbox;65;66;64;65;64;65;65;67;65;79 04:57:34 INFO - PROCESS | 14876 | |10;stanford-crypto-aes;84;80;79;89;79;79;83;86;85;79 04:57:34 INFO - PROCESS | 14876 | |11;stanford-crypto-ccm;146;137;136;131;130;132;140;130;215;131 04:57:34 INFO - PROCESS | 14876 | |12;stanford-crypto-pbkdf2;170;167;170;167;167;168;169;168;166;171 04:57:34 INFO - PROCESS | 14876 | |13;stanford-crypto-sha256-iterative;67;69;70;71;69;68;68;70;66;67 04:57:34 INFO - PROCESS | 14876 | __end_tp_report 04:57:34 INFO - PROCESS | 14876 | __start_cc_report 04:57:34 INFO - PROCESS | 14876 | _x_x_mozilla_cycle_collect,1892 04:57:34 INFO - PROCESS | 14876 | __end_cc_report 04:57:34 INFO - PROCESS | 14876 | __startTimestamp1468324654554__endTimestamp 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | ------- Summary: start ------- 04:57:34 INFO - PROCESS | 14876 | Number of tests: 14 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:2.53 (2.2%) stddev-sans-first:0.88 04:57:34 INFO - PROCESS | 14876 | Values: 107.0 115.0 115.0 116.0 114.0 115.0 114.0 114.0 115.0 113.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:137.00 stddev:18.82 (13.7%) stddev-sans-first:19.38 04:57:34 INFO - PROCESS | 14876 | Values: 150.0 123.0 128.0 174.0 123.0 127.0 146.0 121.0 159.0 121.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 04:57:34 INFO - PROCESS | 14876 | Values: 162.0 162.0 161.0 163.0 162.0 161.0 160.0 162.0 160.0 160.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:17.22 (22.7%) stddev-sans-first:18.01 04:57:34 INFO - PROCESS | 14876 | Values: 76.0 75.0 76.0 127.0 76.0 77.0 76.0 77.0 103.0 79.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:17.06 (20.1%) stddev-sans-first:17.76 04:57:34 INFO - PROCESS | 14876 | Values: 86.0 85.0 110.0 85.0 85.0 85.0 120.0 84.0 86.0 128.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:57:34 INFO - PROCESS | 14876 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:57:34 INFO - PROCESS | 14876 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 145.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:57:34 INFO - PROCESS | 14876 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:57:34 INFO - PROCESS | 14876 | Values: 63.0 64.0 63.0 63.0 64.0 63.0 63.0 64.0 64.0 63.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:65.00 stddev:4.48 (6.9%) stddev-sans-first:4.72 04:57:34 INFO - PROCESS | 14876 | Values: 65.0 66.0 64.0 65.0 64.0 65.0 65.0 67.0 65.0 79.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.50 stddev:3.62 (4.3%) stddev-sans-first:3.79 04:57:34 INFO - PROCESS | 14876 | Values: 84.0 80.0 79.0 89.0 79.0 79.0 83.0 86.0 85.0 79.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:136.50 stddev:25.89 (19.0%) stddev-sans-first:27.44 04:57:34 INFO - PROCESS | 14876 | Values: 146.0 137.0 136.0 131.0 130.0 132.0 140.0 130.0 215.0 131.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.50 stddev:1.64 (1.0%) stddev-sans-first:1.62 04:57:34 INFO - PROCESS | 14876 | Values: 170.0 167.0 170.0 167.0 167.0 168.0 169.0 168.0 166.0 171.0 04:57:34 INFO - PROCESS | 14876 | 04:57:34 INFO - PROCESS | 14876 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.58 (2.3%) stddev-sans-first:1.58 04:57:34 INFO - PROCESS | 14876 | Values: 67.0 69.0 70.0 71.0 69.0 68.0 68.0 70.0 66.0 67.0 04:57:34 INFO - PROCESS | 14876 | -------- Summary: end -------- 04:57:34 INFO - PROCESS | 14876 | 04:57:35 INFO - TEST-INFO | 14876: exit 0 04:57:35 INFO - TEST-OK | kraken | took 67472ms 04:57:35 INFO - SUITE-END | took 1203s 04:57:36 INFO - Completed test suite (00:20:03) 04:57:36 INFO - javascript benchmark 04:57:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.2193341997395, 2618.9607155892677, 2654.508915850568, 2670.2656769388414, 2673.278214881982, 4558.27067669173, 4642.930356044653, 4734.739589322586, 4753.35829662995, 4796.16067188242, 4618.237990731525, 4630.884227894304, 4643.442786865572, 4675.532446755323, 4675.994661147853, 4095.672346212296, 4298.935515967255, 4328.112736888946, 4361.149575832698, 4466.575675310856, 4380.89047773805, 4413.3821265022925, 4421.867343979686, 4428.955710442887, 4450.421445212134, 4207.305794543897, 4252.829886804524, 4285.914281714379, 4319.913601727979, 4334.32817913224, 4280.743155410654, 4289.506706728735, 4294.849680261207, 4376.824927002916, 4396.076823866992, 4295.183915056129, 4324.935125973113, 4325.070109926381, 4375.059362237134, 4376.978115109404, 4555.681102322838, 4608.078384323148, 4648.325992731069, 4759.524047595212, 4765.785539650724, 4957.479464656231, 4994.450610432849, 5027.4469808321055, 5042.470540593258, 5044.319016932704, 4998.075356059141, 5047.596192304643, 5051.873703157414, 5071.822486212965, 5075.086484432801, 4625.0, 4713.835015774465, 4730.124926888468, 4773.355596994431, 4775.2598347256235, 5260.868478287997, 5270.7628156733035, 5274.551663108678, 5285.762140703678, 5289.100852855024, 5014.0, 5029.673071250357, 5056.494350564914, 5075.822346217865, 5077.1876499759865, 4898.559129678346, 5010.974945125324, 5051.545360917535, 5055.595552355802, 5081.034603425337, 4993.80024799004, 5013.89972200554, 5024.371953505812, 5026.447090820006, 5072.974635126875, 4874.8050077997195, 5001.8499445016705, 5006.824761133343, 5008.724520151427, 5012.789257024117, 4190.706650534495, 4205.327147656421, 4226.197022565702, 4243.830246790156, 4299.0, 3673.522442082512, 3677.356462619031, 3689.262147570497, 3722.925541489155, 3729.384651532521, 4360.672949528798, 4367.5414081520985, 4371.934420983688, 4380.890477738082, 4419.292913133883, 4927.1131196384995, 5010.974945125251, 5037.748112594356, 5067.569256613229, 5083.949160508348, 4350.521442641307, 4361.825526978949, 4373.0, 4374.650027997753, 4415.889602759957, 4344.478662560513, 4535.523770004168, 4537.886552836206, 4538.500764915857, 4566.474855391606, 4730.1958667027375, 4743.573078422958, 4767.76161191946, 4774.594159496482, 4780.545848144421, 5032.295478633067, 5065.468125846733, 5067.41724701664, 5069.645124841226, 5113.463086375877, 4577.0, 4766.261229509431, 4766.737829419415, 4769.8313913091515, 4819.3252944588485, 4872.756362181806, 4904.411470623548, 4932.3094766731965, 4936.605071594336, 4953.2074868020945, 4992.301077849032, 4997.350344455198, 5000.14997450427, 5002.149634562061, 5046.21783623539, 4794.856154315376, 4872.123017856678, 4881.682690625098, 4884.9511504884495, 4929.852104436873, 4908.386451693538, 4934.7285899275885, 4954.529319714621, 4958.7024778513405, 5011.949880501148, 4836.782344794422, 4852.587530059985, 4896.877578060435, 4905.190643543775, 4905.23968784839, 4831.323614694016, 4931.3589233399425, 4960.77676504551, 4975.054739599609, 4993.275974983534, 4848.393950756155, 4872.658913875995, 4876.073546026244, 4912.091263116335, 4917.557419832089], "value": 4626.499381336998, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.207345877727, 581.6161333519877, 587.0870795912357, 592.4756590417479, 596.8120042186711, 26468.338291542696, 26894.462110757773, 29006.984755533587, 38956.0, 39673.206535869336, 36738.81630591843, 37163.81418092906, 37209.25581488368, 41335.17329653405, 41347.58652413475, 7858.09631892334, 7981.720639777609, 8001.199880011981, 8007.559584222866, 8009.479383840061, 7572.697092116308, 7851.528908265494, 9842.163416109639, 10105.54525046371, 10106.242031847603, 10321.12270457012, 10378.0, 10388.117010054155, 10397.948010259975, 10401.479926003707, 10142.391456512596, 10186.54160562769, 10200.38797672142, 10203.234757393151, 10208.89791102087, 9931.801363972752, 10144.289899707024, 10148.289619726622, 10157.0, 10161.745956351151, 39625.80187099075, 39944.400833987514, 39965.60034399648, 39990.40014399786, 40029.19795614308, 3175.6189257289043, 3175.9206019849457, 3233.0462513558555, 3382.9492557611657, 3391.5421418108485, 29482.705172948212, 29732.40535189284, 30004.69995300063, 30178.09465716032, 30643.233919151975, 3486.556034290418, 3532.2935412917263, 3549.3256281306726, 3562.0, 3614.6566076222716, 199725.0, 289997.0, 292790.0, 293077.0, 427139.0, 54384.0, 55241.44758552443, 55252.723736381864, 55406.722966385714, 55465.44534554683, 58026.22829516068, 58569.41430585725, 58661.53346166295, 58669.0, 58740.0, 13905.304734763222, 14108.435662573587, 14115.858841411455, 14129.57611271643, 14294.0, 9202.76993075165, 11337.433128343715, 11386.08911287095, 11421.143414243965, 11424.885751142549, 17631.294748210184, 17941.910290448726, 18085.819141808675, 18623.81376186248, 18707.345242916705, 6846.965765171142, 7008.7546935857, 7019.016917810012, 7038.824029399204, 7039.894401583981, 781.0783275734574, 866.8266346730679, 891.6656253904786, 1020.640273753123, 1027.7482016905906, 27994.0, 28420.0, 28725.138245852657, 29035.854820725763, 29208.415831683247, 915.5834095486671, 929.6201723587637, 968.7432830299977, 971.7764914069803, 1061.8725752909545, 13913.513027044004, 14734.557963261119, 14739.778903316244, 14764.40942362315, 14824.851751482563, 410439.0, 411361.0, 417085.0, 417153.0, 417766.0, 47805.0, 49059.26411103836, 49080.26379604309, 49093.26360104601, 49232.0, 1044.639599338227, 1131.2533727739817, 1138.08384250679, 1228.1955319265894, 1245.3337464456472, 20667.793322066587, 28239.576406354332, 28342.0, 28560.42879142447, 29120.854395727885, 40558.39162412507, 41179.7941010293, 41185.79407103065, 41205.0, 41253.0, 254811.0, 263447.0, 264156.0, 264174.0, 264523.0, 21612.838716128263, 24082.397940050938, 24244.755244755244, 24579.0, 24756.876215618806, 41036.58963410328, 41430.1713965725, 41484.1703165941, 41811.37282940819, 42017.0, 34941.0, 35775.82112089423, 36076.4588531167, 36127.81936090303, 36175.81912090423, 34619.82690086634, 35154.64845351514, 35182.64817351794, 35289.82355088208, 35567.82216088903, 34165.145871353416, 34940.825295874376, 35018.0, 35124.824375878976, 35295.94112176639, 31438.214044649067, 31869.36261274808, 32083.0, 32087.679123209404, 32241.03276901697, 23906.28281151568, 25777.742222577534, 25962.870185649706, 25968.350791229615, 26536.203913882615], "value": 17933.548460822574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7217570295169, 356.84477252395203, 363.76355369010156, 379.78731910130347, 392.6132759232158, 15919.76120358194, 16709.0, 17351.47945561635, 17408.129593520305, 17457.476275711717, 16390.754138687927, 16803.0, 17646.999999999967, 17654.47036588901, 17661.293548258087, 4915.5084491550915, 5013.598912087043, 5047.596192304625, 5053.494650534935, 5055.79776808929, 3749.6250374962424, 3932.8820135395986, 5279.0, 5911.231539899807, 6228.22147231596, 6274.780382686607, 6288.71700773464, 6305.432511074003, 6319.241690997087, 6320.020396838498, 6101.145839582462, 6170.444659980601, 6266.060090986343, 6307.590006649576, 6308.9684551577175, 3379.746519011084, 5113.59091272701, 5416.21464887593, 5416.7020813855615, 5440.075187218183, 20775.16899324025, 21472.677909831364, 21527.0, 21534.353969380943, 21574.892125539427, 2096.119629755506, 2101.401100686297, 2124.1935885620283, 2224.8665080095248, 2366.810655147584, 12916.935415322958, 13408.396622152026, 13613.591592252149, 13620.863791362059, 13817.585472435843, 1701.7277235642362, 1723.500184946364, 1766.5318690547015, 1767.2400867626916, 1777.2713187593024, 67941.66029169872, 69709.65145174292, 69967.3003269971, 71042.28957710408, 71089.0, 9407.764805879771, 9609.759756006155, 9622.663206787729, 9706.75733106664, 10151.868107697319, 13244.271565064015, 13254.801177982337, 13262.403191856389, 13272.004599655065, 13322.73354532904, 6914.757983470555, 7006.719731210796, 7173.964130179315, 7178.138623365126, 7186.38915692172, 6653.234877988996, 6664.966930125838, 6684.799456016327, 6820.522563420513, 6822.215445223863, 5732.885342293214, 5792.623479473821, 6018.488428483541, 6054.182685337511, 6058.697065146725, 1587.484067677986, 1706.1810331040922, 1736.9826301737073, 1764.250193667686, 1791.1492041280287, 750.8761054426068, 863.8617821148586, 874.501534125555, 900.1808354397467, 921.5944984206927, 16917.90033647809, 17471.0, 17913.37303194408, 17948.102594870204, 18214.36249731253, 821.1706176761514, 845.1210740829468, 876.9429987050821, 904.0101089307329, 910.6402970826487, 9726.358851555233, 10298.485075746332, 10310.896891031143, 10324.12244959172, 10455.424951627581, 376889.0, 378168.0, 382622.0, 384014.0, 386194.0, 71284.0, 72572.91140632895, 73052.0, 73552.0, 74372.0, 843.6836186430089, 908.1962463219966, 924.3021518753433, 938.887333519982, 940.0, 14837.554873353816, 15457.227138643248, 16206.756898646765, 16656.16782153938, 16745.162741863103, 25277.747222528276, 32492.512612311308, 34040.14899627529, 34708.0, 35008.47487287642, 42787.0, 43574.0, 44385.55614443943, 44467.33299000453, 44488.777556112014, 6825.897611535732, 7056.470764692771, 7238.8914166288605, 7261.419086473175, 7731.381489480716, 8058.073321568095, 11554.884451155716, 11759.706007349885, 12345.506179753069, 12404.38742963409, 9791.804163916824, 10282.485875706334, 10525.210609204187, 10600.363978161335, 10731.517081731185, 10098.19214462856, 10374.792504150026, 10439.739006524898, 10440.63457778974, 10462.68611941643, 9922.900770992486, 10294.742631434274, 10462.110720588835, 10687.679369618923, 11091.833622495507, 7191.7842464726145, 7212.206657267801, 7253.057102576631, 7265.491415600857, 7315.597642129734, 9253.861192082259, 10441.947790261303, 10469.895301046892, 10788.568457261621, 11094.334339939307], "value": 8329.070618583844, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.1910853487905, 1396.6578188343858, 1460.2917584971294, 1635.05984059166, 1677.7399503077027, 6958.130233720785, 7340.889886651705, 7400.296971787671, 7403.259674032594, 7418.701727197739, 6319.905201421971, 6956.200036995747, 7129.893051604217, 7139.1789944156435, 7311.561306321624, 2197.044285735702, 2222.622154233776, 2225.9666105008437, 2225.977740222593, 2226.2875879718495, 1851.9629607407844, 2181.214762685432, 2192.375173075674, 2204.889755512226, 2204.944876378095, 2053.3634573282256, 2123.5115923337644, 2134.3170185540635, 2142.8500004999655, 2157.385145233609, 2167.4581354661336, 2171.913123475059, 2193.8793366364844, 2198.758136604972, 2203.3830527452337, 2139.967900481494, 2140.49698320896, 2144.6675765256255, 2146.37755051035, 2147.3450597567894, 7277.490575659706, 7317.0, 7338.046054012998, 7343.77968660941, 7344.192138864774, 4339.7830108494445, 4452.0, 4504.211762941472, 4511.052678937427, 4520.954790452086, 2783.846888421136, 2822.26621078519, 2889.8844046238123, 2900.6809250982374, 2908.6945870683485, 836.9121242269596, 839.0812060793421, 854.9871751923727, 861.2722249698994, 861.9310455163571, 9764.609415623296, 9800.26498012652, 9810.117089461912, 9810.852837207447, 9817.214622830228, 3966.1869316790567, 4034.3746719257974, 4194.0563373240775, 4203.033302340479, 4203.348480985391, 8349.165083491602, 8375.329973602098, 8502.362322825813, 8507.27688146502, 8511.914880851236, 4441.045175287329, 4447.666425018072, 4448.065906159743, 4451.755153466525, 4454.331850222427, 4025.19496100781, 4044.1911617676583, 4052.2705912935367, 4072.572379900068, 4101.89745256365, 3529.6999755020597, 3570.5001299818045, 3584.910377240538, 3623.3115708015393, 3638.7816730996224, 1010.6967909627083, 1131.5586921100778, 1165.8600967883908, 1191.773563023023, 1215.501644325822, 713.350850725837, 768.3430666779823, 804.5735760047185, 820.0815087102484, 848.5502683577714, 4883.218685010382, 4937.284093806378, 5240.135377662643, 5263.841435393336, 5488.094464413327, 787.6652422720321, 813.7762115418308, 826.3802148388709, 844.907060223375, 847.2798121596717, 3518.7712798668003, 3547.343741407848, 3576.0, 3597.712183025352, 3654.7258955578436, 8594.14058594148, 8955.328350373748, 9068.637254509746, 9107.908920910839, 9129.863052054225, 7928.286454219033, 8294.875576866352, 9020.819583608421, 9021.909780902239, 9063.048379920145, 6658.0, 6927.3419025192525, 6931.792046238621, 6949.027136200936, 6959.512834101564, 5238.921416178684, 5246.816361427332, 5309.946900530946, 5357.0, 5414.052540805422, 8154.714584989497, 8185.263326300424, 8207.876881846896, 8277.213664701843, 8286.171382861665, 7817.5309481431295, 8057.798555035936, 8088.636011379384, 8364.832703346021, 8381.622826972678, 6439.484841212598, 6595.769148079794, 6597.0, 6607.07500949877, 6608.867822643617, 6901.827454313682, 6960.651967401711, 6983.930160698328, 7002.579845209304, 7010.123734533184, 6375.362463753588, 6399.072134540559, 6486.610803351814, 6536.803895883131, 6624.503162262753, 6301.464375528131, 6360.96819515918, 6396.328385519453, 6398.0, 6524.706388212447, 5996.220491336098, 6017.909731354121, 6033.0, 6072.180255665606, 6085.513158947362, 4391.692581519263, 4511.819527218874, 4588.357629931746, 4619.491855895782, 4623.0, 4393.143337049245, 4409.096135292193, 4409.514953355192, 4495.21333766583, 4586.312053192048], "value": 3978.052697594882, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.6036350926249, 297.4586253019505, 298.91480927935544, 299.73024278149677, 300.1520704011168, 4898.70607763534, 4922.483139270379, 4932.926006109907, 4961.950380496194, 4977.800887964481, 4844.346013288205, 4852.670718055336, 4891.144049791281, 4897.167481528139, 4904.901901961958, 3659.2315613721153, 3779.903827889909, 3804.980975095121, 3857.864974725885, 3873.4383514390397, 3828.119532507525, 3868.3810590305557, 3869.1487872667967, 3906.6484016438517, 3908.902277443058, 3823.7955044161, 3826.196498735269, 3827.8468861245515, 3840.9231815363814, 3854.9421758673643, 3630.382834918057, 3735.981320093396, 3853.8611070855663, 3872.5933776953298, 3874.9806250968845, 3415.9316813663586, 3419.9145021374416, 3429.3484237994703, 3441.294534620422, 3442.3631628148873, 4759.095771803346, 4768.284757286435, 4775.689580177277, 4802.5197480252045, 4809.206480930642, 4100.8675488745685, 4358.193734159191, 4403.3174857897075, 4412.75729834859, 4423.1153769246275, 5094.439611642716, 5103.770330335144, 5142.434332223453, 5165.173572228463, 5180.300659411007, 3655.4151335786414, 3658.396364599838, 3675.467057276707, 3681.337359275329, 3688.963110368889, 5041.70602375918, 5353.625246232727, 5364.409914909357, 5395.81114660985, 5403.351597808249, 3728.4780130781714, 3728.496652951871, 3742.139307959185, 3746.5129533160516, 3747.3816820224356, 3787.659110680052, 3788.5453745550158, 3794.5446546414605, 3805.334066538345, 3806.619338066171, 4360.716553424018, 4369.3227549729845, 4369.934450983238, 4376.431063961728, 4381.364702118175, 5044.899102017939, 5104.081265372269, 5115.335006449212, 5117.667351622133, 5139.408967968657, 1287.7682017236987, 1299.3373379576294, 1307.405130665545, 1317.7562151001903, 1321.458202137119, 842.7556008757392, 843.6709683223547, 861.5907443964066, 862.6376921692904, 872.3326655108847, 4414.0, 4416.955830441719, 4428.365122751958, 4587.954120458753, 4598.724076555417, 5259.47405259471, 5275.050490911596, 5278.894422111536, 5292.44429334922, 5298.655587386807, 4334.4798624165305, 4494.70784399013, 4505.594496495266, 4512.555982085701, 4524.547545245449, 2800.901968431095, 2810.580656768319, 2815.3946901415884, 2818.534941734591, 2828.3070647691034, 4901.142300097468, 4968.329275547827, 4975.776090075955, 4985.52637499437, 4988.12707776145, 5098.388193416739, 5357.651752636144, 5373.516383525502, 5377.5429088527135, 5445.782168713207, 4982.725950072709, 4986.376702912208, 4999.325091112726, 5001.224810154432, 5017.54842064216, 5304.427352733844, 5306.734663266744, 5309.6725818545365, 5321.813736519203, 5344.144936810092, 4955.6531042826655, 5156.1750119980625, 5178.508041736029, 5225.790968361223, 5233.633645644921, 4999.400071991385, 5013.749312534432, 5019.64862459639, 5028.270900719302, 5041.470645582161, 3782.4893639359434, 3786.583475817713, 3789.8673546426844, 3795.829187686616, 3816.7900765457057, 5132.43543210254, 5276.841694749163, 5295.25866378715, 5342.1452567589, 5357.249985002025, 5091.796328146981, 5141.562967147835, 5143.948560514496, 5156.432792392909, 5170.6380553360905, 5096.031753966735, 5125.74371281427, 5148.742562871917, 5156.329677141947, 5179.404368497671, 4865.56209941107, 5022.3219865317715, 5042.369703787027, 5042.949570504248, 5049.444561098349, 4926.679765815211, 5022.773975171053, 5139.229115632685, 5159.535641792257, 5162.425460234665, 5024.84925452237, 5052.646314757932, 5066.36670416198, 5075.619328550448, 5077.720725360141], "value": 3870.326085287493, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.8297442664907, 690.5545922879746, 717.9030830837835, 724.0551080839504, 755.1089714137315, 12207.450664720087, 13124.606261812149, 13921.30393480327, 14304.427822887099, 14323.641908952255, 14699.338529766159, 14709.926450367733, 14809.555713328591, 14889.627759306022, 14895.404183832661, 634.4955760170675, 771.5062360089547, 789.8696715042012, 797.7367468735304, 812.1513018895268, 797.9122296547404, 804.8953636027309, 806.3549160671469, 807.6688557691348, 807.9192080791903, 844.7170197983683, 845.5265051571109, 845.8223773007645, 846.327169899931, 846.8899043124385, 648.7761722205831, 800.903891533014, 824.3199360527589, 825.9091499935003, 840.2857571064608, 602.7016626769733, 602.8583282928508, 605.6729366142278, 605.6941244671413, 607.3835057416726, 13832.30838458083, 13852.099613525088, 13872.722545549133, 13875.444982200699, 13876.861231387658, 12085.516579336816, 12660.366981650972, 12701.745965080647, 12795.168314059649, 12964.611061668165, 11480.425978701114, 11487.540498380054, 11661.183717139804, 11737.471813768401, 12273.140880138393, 4065.9593404065877, 4092.386142078682, 4107.404426358161, 4158.854440094612, 4165.541790403053, 59980.70009649968, 60673.696631517, 60824.695876520775, 60865.0, 60874.695626521585, 9997.550110245056, 10106.444145572064, 10128.645497407555, 10267.0, 10449.529771160316, 17834.0, 17910.91044544795, 17940.19269132892, 17967.73048404275, 17969.820301796815, 6375.458086062644, 6395.616263024233, 6523.24982627004, 6570.474362051024, 6589.044588534635, 3523.841427135785, 3545.7163426925786, 3568.3933731265747, 3583.516225309602, 3618.366785812525, 2749.9037533686223, 2839.730225628562, 2847.3308772438872, 2848.51575232211, 2849.743523082891, 483.48750324655276, 491.4618492750433, 494.1796617614742, 495.72982724415283, 507.26446652354235, 456.6506622433841, 469.06277075677235, 474.077918448621, 518.5980864829787, 525.5086494128003, 7096.396806271421, 7129.108861392326, 7432.702691892372, 7546.1321947976685, 7706.0, 540.9667535008194, 548.6488647265753, 552.8009916430082, 586.4077281945181, 592.295168749187, 3452.5339079224486, 3598.712103031751, 3663.2307215484516, 3683.1528748388023, 3752.3245815753426, 58986.705066474395, 91018.54490727636, 92512.0, 92790.0, 93361.5331923336, 80154.0, 80445.55567200122, 81178.59410703027, 81827.0, 83104.0, 64619.35380646228, 73490.63254683692, 74012.62993684997, 74424.62787686136, 74500.25499745042, 7253.8186545336785, 7272.346744536133, 7281.599512026889, 7395.334419902019, 8242.587870606565, 33627.83186084054, 34713.13217169591, 41051.384229237185, 42917.356239657056, 44493.77753111214, 41060.79469602633, 51593.0, 55366.72316638552, 61592.38407615866, 62795.0, 10823.350598964087, 11129.332240065622, 11202.551897924317, 11239.65124185103, 11432.94283528577, 12272.877271227173, 12451.377431128589, 12503.499860005499, 12506.499740010298, 13015.804762928374, 11507.654770356903, 11839.112066594867, 11996.76006479848, 12068.698282543006, 12123.0, 10743.731406714895, 10895.782084358427, 11620.593279235187, 11842.881571184178, 12448.128630995743, 10857.185711071543, 10901.454927253764, 10908.563657453931, 11192.776144477228, 11580.073594112619, 10121.443320617142, 10334.689959301233, 10416.687499375032, 10738.087262582769, 10801.297915635772, 8721.476711397336, 8919.910800892168, 9216.447013179231, 9272.708188592953, 9802.558884850056], "value": 6440.6228691840815, "unit": "score"}], "name": "dromaeo_css", "value": 6397.134613883033, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 116.0, 114.0, 115.0, 114.0, 114.0, 115.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 128.0, 174.0, 123.0, 127.0, 146.0, 121.0, 159.0, 121.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 162.0, 161.0, 160.0, 162.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 127.0, 76.0, 77.0, 76.0, 77.0, 103.0, 79.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 110.0, 85.0, 85.0, 85.0, 120.0, 84.0, 86.0, 128.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 145.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 64.0, 65.0, 65.0, 67.0, 65.0, 79.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 79.0, 89.0, 79.0, 79.0, 83.0, 86.0, 85.0, 79.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 137.0, 136.0, 131.0, 130.0, 132.0, 140.0, 130.0, 215.0, 131.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 170.0, 167.0, 167.0, 168.0, 169.0, 168.0, 166.0, 171.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 70.0, 71.0, 69.0, 68.0, 68.0, 70.0, 66.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1542.2999999999997, "alertThreshold": 2.0}]} 04:57:36 INFO - Return code: 0 04:57:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:36 INFO - # TBPL SUCCESS # 04:57:36 INFO - Running post-action listener: _resource_record_post_action 04:57:36 INFO - ##### 04:57:36 INFO - ##### Finished run-tests step (success) 04:57:36 INFO - ##### 04:57:36 INFO - Running post-run listener: _resource_record_post_run 04:57:36 INFO - Total resource usage - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539389952; Read time: 4356; Write time: 4088312 04:57:36 INFO - TinderboxPrint: CPU usage
13.4% 04:57:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4,356 04:57:36 INFO - TinderboxPrint: I/O write bytes / time
539,389,952 / 4,088,312 04:57:36 INFO - TinderboxPrint: CPU idle
8,430.4 (86.6%) 04:57:36 INFO - TinderboxPrint: CPU user
1,200.2 (12.3%) 04:57:36 INFO - TinderboxPrint: Swap in / out
0 / 0 04:57:36 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 149262336; Read time: 0; Write time: 842484 04:57:36 INFO - run-tests - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 374042624; Read time: 4356; Write time: 3115592 04:57:36 INFO - Running post-run listener: _upload_blobber_files 04:57:36 INFO - Blob upload gear active. 04:57:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:57:37 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:38 INFO - (blobuploader) - INFO - Done attempting. 04:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:41 INFO - (blobuploader) - INFO - Done attempting. 04:57:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:43 INFO - (blobuploader) - INFO - Done attempting. 04:57:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:43 INFO - Return code: 0 04:57:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a83d68a1dc3eb09e685cc6ff7321c7a28d6d34aee8c7c6dde5ac19de3702b1f932de04a75b86518f552ea49dfe860c58edfc807ec8895b598ff82080d5c6795", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2801797959455e2dd026c9fd5222a0351393e88f35a6d20bbf4a74d27e62dd0efc76ca501bf6026e049210a99809d3e724667809eed6e9bdc238a5e07dd1c4e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/13355a700354303b1c5d35c0384bbe07986d8cfd3beea9eaf21344448fda6a08a41d7b47578b4852afaab0c9e87d55b463b7912893effe8ce7fa6888cbe5513b"} 04:57:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:43 INFO - Contents: 04:57:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a83d68a1dc3eb09e685cc6ff7321c7a28d6d34aee8c7c6dde5ac19de3702b1f932de04a75b86518f552ea49dfe860c58edfc807ec8895b598ff82080d5c6795", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2801797959455e2dd026c9fd5222a0351393e88f35a6d20bbf4a74d27e62dd0efc76ca501bf6026e049210a99809d3e724667809eed6e9bdc238a5e07dd1c4e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/13355a700354303b1c5d35c0384bbe07986d8cfd3beea9eaf21344448fda6a08a41d7b47578b4852afaab0c9e87d55b463b7912893effe8ce7fa6888cbe5513b"} 04:57:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:43 INFO - Copying logs to upload dir... 04:57:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.273516 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-12 04:57:42.344367) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:42.347698) ========= 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=33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285 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/7a83d68a1dc3eb09e685cc6ff7321c7a28d6d34aee8c7c6dde5ac19de3702b1f932de04a75b86518f552ea49dfe860c58edfc807ec8895b598ff82080d5c6795", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2801797959455e2dd026c9fd5222a0351393e88f35a6d20bbf4a74d27e62dd0efc76ca501bf6026e049210a99809d3e724667809eed6e9bdc238a5e07dd1c4e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/13355a700354303b1c5d35c0384bbe07986d8cfd3beea9eaf21344448fda6a08a41d7b47578b4852afaab0c9e87d55b463b7912893effe8ce7fa6888cbe5513b"} build_url:https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/P2Vt4TovRPq_L1VkrVO0yA/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/7a83d68a1dc3eb09e685cc6ff7321c7a28d6d34aee8c7c6dde5ac19de3702b1f932de04a75b86518f552ea49dfe860c58edfc807ec8895b598ff82080d5c6795", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2801797959455e2dd026c9fd5222a0351393e88f35a6d20bbf4a74d27e62dd0efc76ca501bf6026e049210a99809d3e724667809eed6e9bdc238a5e07dd1c4e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/13355a700354303b1c5d35c0384bbe07986d8cfd3beea9eaf21344448fda6a08a41d7b47578b4852afaab0c9e87d55b463b7912893effe8ce7fa6888cbe5513b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:42.372746) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:42.373054) ========= 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=33d5923976266a1c518c4bf7000001ab-1468323400.582783-2082175285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:42.460305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 04:57:42.460649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 04:57:42.461018) ========= ========= Total master_lag: 0.16 =========