builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1467763906.76 results: success (0) buildid: 20160705143027 builduid: e288e501b18c498bbaa8139406902498 revision: a74f88a7a05abe2b80eba43cab211199b30e7463 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:46.762877) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:46.763325) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:46.763615) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:46.782728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:46.783020) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 17:11:47-- 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% 87.9M=0s 2016-07-05 17:11:47 (87.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.424851 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:47.222671) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:47.222999) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015671 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:47.272987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:47.273347) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a74f88a7a05abe2b80eba43cab211199b30e7463 --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 a74f88a7a05abe2b80eba43cab211199b30e7463 --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=e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 17:11:48,043 truncating revision to first 12 chars 2016-07-05 17:11:48,043 Setting DEBUG logging. 2016-07-05 17:11:48,044 attempt 1/10 2016-07-05 17:11:48,044 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a74f88a7a05a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 17:11:48,355 unpacking tar archive at: fx-team-a74f88a7a05a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657340 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:47.945196) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:47.945575) ========= script_repo_revision: a74f88a7a05abe2b80eba43cab211199b30e7463 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:47.946007) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:47.946322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 17:11:47.956710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-05 17:11:47.957158) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:11:48 INFO - MultiFileLogger online at 20160705 17:11:48 in /builds/slave/test 17:11:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:11:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:11:48 INFO - {'append_to_log': False, 17:11:48 INFO - 'base_work_dir': '/builds/slave/test', 17:11:48 INFO - 'blob_upload_branch': 'Fx-Team', 17:11:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:11:48 INFO - 'branch': 'Fx-Team', 17:11:48 INFO - 'buildbot_json_path': 'buildprops.json', 17:11:48 INFO - 'config_files': ('talos/linux_config.py',), 17:11:48 INFO - 'default_actions': ('clobber', 17:11:48 INFO - 'read-buildbot-config', 17:11:48 INFO - 'download-and-extract', 17:11:48 INFO - 'populate-webroot', 17:11:48 INFO - 'create-virtualenv', 17:11:48 INFO - 'install', 17:11:48 INFO - 'run-tests'), 17:11:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:11:48 INFO - 'download_minidump_stackwalk': True, 17:11:48 INFO - 'download_symbols': 'ondemand', 17:11:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:11:48 INFO - 'tooltool.py': '/tools/tooltool.py', 17:11:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:11:48 INFO - '/tools/misc-python/virtualenv.py')}, 17:11:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:11:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:11:48 INFO - 'installer_path': 'installer.exe', 17:11:48 INFO - 'log_level': 'info', 17:11:48 INFO - 'log_name': 'talos', 17:11:48 INFO - 'log_to_console': True, 17:11:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:11:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:11:48 INFO - 'opt_config_files': (), 17:11:48 INFO - 'pip_index': False, 17:11:48 INFO - 'sps_profile': False, 17:11:48 INFO - 'sps_profile_interval': 0, 17:11:48 INFO - 'suite': 'dromaeojs', 17:11:48 INFO - 'system_bits': '32', 17:11:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:11:48 INFO - 'title': 'talos-linux64-ix-067', 17:11:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:11:48 INFO - 'use_talos_json': True, 17:11:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:11:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:11:48 INFO - 'work_dir': 'build'} 17:11:48 INFO - ##### 17:11:48 INFO - ##### Running clobber step. 17:11:48 INFO - ##### 17:11:48 INFO - Running pre-action listener: _resource_record_pre_action 17:11:48 INFO - Running main action method: clobber 17:11:48 INFO - rmtree: /builds/slave/test/build 17:11:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:11:49 INFO - Running post-action listener: _resource_record_post_action 17:11:49 INFO - ##### 17:11:49 INFO - ##### Finished clobber step (success) 17:11:49 INFO - ##### 17:11:49 INFO - ##### 17:11:49 INFO - ##### Running read-buildbot-config step. 17:11:49 INFO - ##### 17:11:49 INFO - Running pre-action listener: _resource_record_pre_action 17:11:49 INFO - Running main action method: read_buildbot_config 17:11:49 INFO - Using buildbot properties: 17:11:49 INFO - { 17:11:49 INFO - "project": "", 17:11:49 INFO - "product": "firefox", 17:11:49 INFO - "script_repo_revision": "production", 17:11:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:11:49 INFO - "repository": "", 17:11:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:11:49 INFO - "buildid": "20160705143027", 17:11:49 INFO - "pgo_build": "True", 17:11:49 INFO - "basedir": "/builds/slave/test", 17:11:49 INFO - "buildnumber": 1304, 17:11:49 INFO - "slavename": "talos-linux64-ix-067", 17:11:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:11:49 INFO - "platform": "ubuntu64_hw", 17:11:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:11:49 INFO - "branch": "fx-team", 17:11:49 INFO - "repo_path": "integration/fx-team", 17:11:49 INFO - "revision": "a74f88a7a05abe2b80eba43cab211199b30e7463", 17:11:49 INFO - "stage_platform": "linux64-pgo", 17:11:49 INFO - "builduid": "e288e501b18c498bbaa8139406902498", 17:11:49 INFO - "slavebuilddir": "test" 17:11:49 INFO - } 17:11:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:11:49 INFO - Running post-action listener: _resource_record_post_action 17:11:49 INFO - ##### 17:11:49 INFO - ##### Finished read-buildbot-config step (success) 17:11:49 INFO - ##### 17:11:49 INFO - ##### 17:11:49 INFO - ##### Running download-and-extract step. 17:11:49 INFO - ##### 17:11:49 INFO - Running pre-action listener: _resource_record_pre_action 17:11:49 INFO - Running main action method: download_and_extract 17:11:49 INFO - mkdir: /builds/slave/test/build/tests 17:11: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')]} 17:11:49 INFO - https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:11:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:11:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:11:50 INFO - Downloaded 1361 bytes. 17:11:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:50 INFO - Using the following test package requirements: 17:11:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:11:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:11:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:50 INFO - u'jsshell-linux-x86_64.zip'], 17:11:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:11:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:11:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:11:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:11:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:11:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:11:50 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')]} 17:11:50 INFO - https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:11:51 INFO - Downloaded 24299680 bytes. 17:11:51 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'] 17:11:51 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 17:11:52 INFO - Return code: 0 17:11:52 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 17:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:52 INFO - https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:11:59 INFO - Downloaded 24299680 bytes. 17:11:59 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'] 17:11:59 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 17:12:01 INFO - Return code: 0 17:12: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')]} 17:12:01 INFO - https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:12:02 INFO - Downloaded 14403333 bytes. 17:12:02 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'] 17:12:02 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 17:12:02 INFO - Return code: 0 17:12:02 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')]} 17:12:02 INFO - https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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 17:12:04 INFO - Downloaded 60352783 bytes. 17:12:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:04 INFO - mkdir: /builds/slave/test/properties 17:12:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:04 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:04 INFO - Contents: 17:12:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:04 INFO - Running post-action listener: _resource_record_post_action 17:12:04 INFO - Running post-action listener: set_extra_try_arguments 17:12:04 INFO - ##### 17:12:04 INFO - ##### Finished download-and-extract step (success) 17:12:04 INFO - ##### 17:12:04 INFO - ##### 17:12:04 INFO - ##### Running populate-webroot step. 17:12:04 INFO - ##### 17:12:04 INFO - Running pre-action listener: _resource_record_pre_action 17:12:04 INFO - Running main action method: populate_webroot 17:12:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:04 INFO - '--tppagecycles', 17:12:04 INFO - '7'], 17:12:04 INFO - 'tests': ['tsvgm']}}, 17:12:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:12:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:12:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:04 INFO - 'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:04 INFO - 'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['damp', 'tps']}, 17:12:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:04 INFO - 'tests': ['damp', 'tps']}, 17:12:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['dromaeo_dom']}, 17:12:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['basic_compositor_video']}, 17:12:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:12:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['a11yr', 17:12:04 INFO - 'ts_paint', 17:12:04 INFO - 'tpaint', 17:12:04 INFO - 'sessionrestore', 17:12:04 INFO - 'sessionrestore_no_auto_restore', 17:12:04 INFO - 'tabpaint']}, 17:12:04 INFO - 'other-e10s': {'tests': ['a11yr', 17:12:04 INFO - 'ts_paint', 17:12:04 INFO - 'tpaint', 17:12:04 INFO - 'sessionrestore', 17:12:04 INFO - 'sessionrestore_no_auto_restore', 17:12:04 INFO - 'tabpaint']}, 17:12:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:12:04 INFO - 'ts_paint', 17:12:04 INFO - 'tpaint', 17:12:04 INFO - 'sessionrestore', 17:12:04 INFO - 'sessionrestore_no_auto_restore', 17:12:04 INFO - 'tabpaint']}, 17:12:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:12:04 INFO - 'ts_paint', 17:12:04 INFO - 'tpaint', 17:12:04 INFO - 'sessionrestore', 17:12:04 INFO - 'sessionrestore_no_auto_restore', 17:12:04 INFO - 'tabpaint']}, 17:12:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['a11yr', 17:12:04 INFO - 'ts_paint', 17:12:04 INFO - 'tpaint', 17:12:04 INFO - 'sessionrestore', 17:12:04 INFO - 'sessionrestore_no_auto_restore', 17:12:04 INFO - 'tabpaint']}, 17:12:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['a11yr', 17:12:04 INFO - 'ts_paint', 17:12:04 INFO - 'tpaint', 17:12:04 INFO - 'sessionrestore', 17:12:04 INFO - 'sessionrestore_no_auto_restore', 17:12:04 INFO - 'tabpaint']}, 17:12:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['tsvgx', 17:12:04 INFO - 'tsvgr_opacity', 17:12:04 INFO - 'tart', 17:12:04 INFO - 'tscrollx', 17:12:04 INFO - 'cart']}, 17:12:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:12:04 INFO - 'tsvgr_opacity', 17:12:04 INFO - 'tart', 17:12:04 INFO - 'tscrollx', 17:12:04 INFO - 'cart']}, 17:12:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:04 INFO - 'talos_options': ['--disable-e10s'], 17:12:04 INFO - 'tests': ['tp5o']}, 17:12:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:04 INFO - 'tests': ['tp5o']}, 17:12:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:04 INFO - 'talos_options': ['--disable-e10s', 17:12:04 INFO - '--xperf_path', 17:12:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:04 INFO - 'tests': ['tp5n']}, 17:12:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:04 INFO - 'talos_options': ['--xperf_path', 17:12:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:04 INFO - 'tests': ['tp5n']}}, 17:12:04 INFO - 'talos.zip': {'path': '', 17:12:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:04 INFO - Running post-action listener: _resource_record_post_action 17:12:04 INFO - ##### 17:12:04 INFO - ##### Finished populate-webroot step (success) 17:12:04 INFO - ##### 17:12:04 INFO - ##### 17:12:04 INFO - ##### Running create-virtualenv step. 17:12:04 INFO - ##### 17:12:04 INFO - Running pre-action listener: _resource_record_pre_action 17:12:04 INFO - Running main action method: create_virtualenv 17:12:04 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:04 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 17:12:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:04 INFO - Using real prefix '/usr' 17:12:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:05 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:07 INFO - Installing pip.................done. 17:12:07 INFO - Return code: 0 17:12:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:07 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 0x1429030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', '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 17:12:07 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 17:12:07 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 17:12:07 INFO - Using env: {'DISPLAY': ':0', 17:12:07 INFO - 'HOME': '/home/cltbld', 17:12:07 INFO - 'LANG': 'en_US.UTF-8', 17:12:07 INFO - 'LANGUAGE': 'en_US:en', 17:12:07 INFO - 'LOGNAME': 'cltbld', 17:12:07 INFO - 'MAIL': '/var/mail/cltbld', 17:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:07 INFO - 'MOZ_NO_REMOTE': '1', 17:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:07 INFO - 'NO_EM_RESTART': '1', 17:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:07 INFO - 'PWD': '/builds/slave/test', 17:12:07 INFO - 'SHELL': '/bin/bash', 17:12:07 INFO - 'SHLVL': '1', 17:12:07 INFO - 'TERM': 'linux', 17:12:07 INFO - 'TMOUT': '86400', 17:12:07 INFO - 'USER': 'cltbld', 17:12:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:07 INFO - '_': '/tools/buildbot/bin/python'} 17:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:07 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 17:12:07 INFO - Cleaning up... 17:12:07 INFO - Return code: 0 17:12:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:07 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 0x1429030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', '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 17:12:07 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 17:12:07 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 17:12:07 INFO - Using env: {'DISPLAY': ':0', 17:12:07 INFO - 'HOME': '/home/cltbld', 17:12:07 INFO - 'LANG': 'en_US.UTF-8', 17:12:07 INFO - 'LANGUAGE': 'en_US:en', 17:12:07 INFO - 'LOGNAME': 'cltbld', 17:12:07 INFO - 'MAIL': '/var/mail/cltbld', 17:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:07 INFO - 'MOZ_NO_REMOTE': '1', 17:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:07 INFO - 'NO_EM_RESTART': '1', 17:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:07 INFO - 'PWD': '/builds/slave/test', 17:12:07 INFO - 'SHELL': '/bin/bash', 17:12:07 INFO - 'SHLVL': '1', 17:12:07 INFO - 'TERM': 'linux', 17:12:07 INFO - 'TMOUT': '86400', 17:12:07 INFO - 'USER': 'cltbld', 17:12:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:07 INFO - '_': '/tools/buildbot/bin/python'} 17:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:07 INFO - Downloading/unpacking psutil>=3.1.1 17:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:09 INFO - Installing collected packages: psutil 17:12:09 INFO - Running setup.py install for psutil 17:12:09 INFO - building 'psutil._psutil_linux' extension 17:12:09 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 17:12:10 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 17:12:10 INFO - building 'psutil._psutil_posix' extension 17:12:10 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 17:12:10 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 17:12:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:10 INFO - Successfully installed psutil 17:12:10 INFO - Cleaning up... 17:12:10 INFO - Return code: 0 17:12:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:12:10 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')]} 17:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:10 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')]} 17:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:10 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 0x1429030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', '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 17:12:10 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 17:12:10 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 17:12:10 INFO - Using env: {'DISPLAY': ':0', 17:12:10 INFO - 'HOME': '/home/cltbld', 17:12:10 INFO - 'LANG': 'en_US.UTF-8', 17:12:10 INFO - 'LANGUAGE': 'en_US:en', 17:12:10 INFO - 'LOGNAME': 'cltbld', 17:12:10 INFO - 'MAIL': '/var/mail/cltbld', 17:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:10 INFO - 'MOZ_NO_REMOTE': '1', 17:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:10 INFO - 'NO_EM_RESTART': '1', 17:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:10 INFO - 'PWD': '/builds/slave/test', 17:12:10 INFO - 'SHELL': '/bin/bash', 17:12:10 INFO - 'SHLVL': '1', 17:12:10 INFO - 'TERM': 'linux', 17:12:10 INFO - 'TMOUT': '86400', 17:12:10 INFO - 'USER': 'cltbld', 17:12:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:10 INFO - '_': '/tools/buildbot/bin/python'} 17:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:12:10 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 17:12:10 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 17:12:10 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 17:12:10 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 17:12:10 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 17:12:10 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 17:12:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:12:12 INFO - Installing collected packages: mozsystemmonitor 17:12:12 INFO - Running setup.py install for mozsystemmonitor 17:12:12 INFO - Successfully installed mozsystemmonitor 17:12:12 INFO - Cleaning up... 17:12:12 INFO - Return code: 0 17:12:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:12 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 0x1429030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', '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 17:12:12 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 17:12:12 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 17:12:12 INFO - Using env: {'DISPLAY': ':0', 17:12:12 INFO - 'HOME': '/home/cltbld', 17:12:12 INFO - 'LANG': 'en_US.UTF-8', 17:12:12 INFO - 'LANGUAGE': 'en_US:en', 17:12:12 INFO - 'LOGNAME': 'cltbld', 17:12:12 INFO - 'MAIL': '/var/mail/cltbld', 17:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:12 INFO - 'MOZ_NO_REMOTE': '1', 17:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:12 INFO - 'NO_EM_RESTART': '1', 17:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:12 INFO - 'PWD': '/builds/slave/test', 17:12:12 INFO - 'SHELL': '/bin/bash', 17:12:12 INFO - 'SHLVL': '1', 17:12:12 INFO - 'TERM': 'linux', 17:12:12 INFO - 'TMOUT': '86400', 17:12:12 INFO - 'USER': 'cltbld', 17:12:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:12 INFO - '_': '/tools/buildbot/bin/python'} 17:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:12 INFO - Downloading/unpacking jsonschema==2.5.1 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:12:14 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 17:12:14 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 17:12:14 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 17:12:14 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 17:12:14 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 17:12:14 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 17:12:14 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:15 INFO - warning: no files found matching '*.txt' 17:12:15 INFO - no previously-included directories found matching 'build' 17:12:15 INFO - no previously-included directories found matching 'dist' 17:12:15 INFO - no previously-included directories found matching '.git*' 17:12:15 INFO - Installing collected packages: jsonschema, functools32 17:12:15 INFO - Running setup.py install for functools32 17:12:15 INFO - warning: no files found matching '*.txt' 17:12:15 INFO - no previously-included directories found matching 'build' 17:12:15 INFO - no previously-included directories found matching 'dist' 17:12:15 INFO - no previously-included directories found matching '.git*' 17:12:15 INFO - Successfully installed jsonschema functools32 17:12:15 INFO - Cleaning up... 17:12:15 INFO - Return code: 0 17:12:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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', '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 0x1429030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', '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 17:12: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:12: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 blobuploader==1.2.4 17:12:15 INFO - Using env: {'DISPLAY': ':0', 17:12:15 INFO - 'HOME': '/home/cltbld', 17:12:15 INFO - 'LANG': 'en_US.UTF-8', 17:12:15 INFO - 'LANGUAGE': 'en_US:en', 17:12:15 INFO - 'LOGNAME': 'cltbld', 17:12:15 INFO - 'MAIL': '/var/mail/cltbld', 17:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:15 INFO - 'MOZ_NO_REMOTE': '1', 17:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:15 INFO - 'NO_EM_RESTART': '1', 17:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:15 INFO - 'PWD': '/builds/slave/test', 17:12:15 INFO - 'SHELL': '/bin/bash', 17:12:15 INFO - 'SHLVL': '1', 17:12:15 INFO - 'TERM': 'linux', 17:12:15 INFO - 'TMOUT': '86400', 17:12:15 INFO - 'USER': 'cltbld', 17:12:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:15 INFO - '_': '/tools/buildbot/bin/python'} 17:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:15 INFO - Downloading/unpacking blobuploader==1.2.4 17:12:15 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 17:12:15 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 17:12:15 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 17:12:15 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 17:12:15 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 17:12:15 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 17:12:17 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:12:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:18 INFO - Downloading docopt-0.6.1.tar.gz 17:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:18 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:18 INFO - Running setup.py install for blobuploader 17:12:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:12:18 INFO - Running setup.py install for requests 17:12:18 INFO - Running setup.py install for docopt 17:12:18 INFO - Successfully installed blobuploader requests docopt 17:12:18 INFO - Cleaning up... 17:12:18 INFO - Return code: 0 17:12:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:18 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 0x1429030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', '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 17:12:18 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 17:12:18 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 17:12:18 INFO - Using env: {'DISPLAY': ':0', 17:12:18 INFO - 'HOME': '/home/cltbld', 17:12:18 INFO - 'LANG': 'en_US.UTF-8', 17:12:18 INFO - 'LANGUAGE': 'en_US:en', 17:12:18 INFO - 'LOGNAME': 'cltbld', 17:12:18 INFO - 'MAIL': '/var/mail/cltbld', 17:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:18 INFO - 'MOZ_NO_REMOTE': '1', 17:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:18 INFO - 'NO_EM_RESTART': '1', 17:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:18 INFO - 'PWD': '/builds/slave/test', 17:12:18 INFO - 'SHELL': '/bin/bash', 17:12:18 INFO - 'SHLVL': '1', 17:12:18 INFO - 'TERM': 'linux', 17:12:18 INFO - 'TMOUT': '86400', 17:12:18 INFO - 'USER': 'cltbld', 17:12:18 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:18 INFO - '_': '/tools/buildbot/bin/python'} 17:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:18 INFO - Running setup.py (path:/tmp/pip-CRhB0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:19 INFO - Running setup.py (path:/tmp/pip-lKf4lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:19 INFO - Running setup.py (path:/tmp/pip-lMGYCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:19 INFO - Running setup.py (path:/tmp/pip-g3NndN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:19 INFO - Running setup.py (path:/tmp/pip-FOqLCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:19 INFO - Running setup.py (path:/tmp/pip-aazdCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:19 INFO - Running setup.py (path:/tmp/pip-FbGD6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:19 INFO - Running setup.py (path:/tmp/pip-9RmtDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:19 INFO - Running setup.py (path:/tmp/pip-XNdn_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:19 INFO - Running setup.py (path:/tmp/pip-VB7Jfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:19 INFO - Running setup.py (path:/tmp/pip-PgsAmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:19 INFO - Running setup.py (path:/tmp/pip-FFiFZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:19 INFO - Running setup.py (path:/tmp/pip-asSmM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:19 INFO - Running setup.py (path:/tmp/pip-u9AMsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:19 INFO - Running setup.py (path:/tmp/pip-WoIcvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:20 INFO - Running setup.py (path:/tmp/pip-TOyRD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:20 INFO - Running setup.py (path:/tmp/pip-mUS9Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:20 INFO - Running setup.py install for manifestparser 17:12:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:12:20 INFO - Running setup.py install for mozcrash 17:12:20 INFO - Running setup.py install for mozdebug 17:12:20 INFO - Running setup.py install for mozdevice 17:12:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:12:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:12:20 INFO - Running setup.py install for mozfile 17:12:20 INFO - Running setup.py install for mozhttpd 17:12:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:12:20 INFO - Running setup.py install for mozinfo 17:12:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:12:20 INFO - Running setup.py install for mozInstall 17:12:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:12:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:12:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:12:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:12:20 INFO - Running setup.py install for mozleak 17:12:21 INFO - Running setup.py install for mozlog 17:12:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Running setup.py install for moznetwork 17:12:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Running setup.py install for mozprocess 17:12:21 INFO - Running setup.py install for mozprofile 17:12:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Running setup.py install for mozrunner 17:12:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Running setup.py install for mozscreenshot 17:12:21 INFO - Running setup.py install for moztest 17:12:21 INFO - Running setup.py install for mozversion 17:12:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:12:21 INFO - Cleaning up... 17:12:21 INFO - Return code: 0 17:12:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:21 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 0x1429030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', '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 17:12:21 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 17:12:21 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 17:12:21 INFO - Using env: {'DISPLAY': ':0', 17:12:21 INFO - 'HOME': '/home/cltbld', 17:12:21 INFO - 'LANG': 'en_US.UTF-8', 17:12:21 INFO - 'LANGUAGE': 'en_US:en', 17:12:21 INFO - 'LOGNAME': 'cltbld', 17:12:21 INFO - 'MAIL': '/var/mail/cltbld', 17:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:21 INFO - 'MOZ_NO_REMOTE': '1', 17:12:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:21 INFO - 'NO_EM_RESTART': '1', 17:12:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:21 INFO - 'PWD': '/builds/slave/test', 17:12:21 INFO - 'SHELL': '/bin/bash', 17:12:21 INFO - 'SHLVL': '1', 17:12:21 INFO - 'TERM': 'linux', 17:12:21 INFO - 'TMOUT': '86400', 17:12:21 INFO - 'USER': 'cltbld', 17:12:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:21 INFO - '_': '/tools/buildbot/bin/python'} 17:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:22 INFO - Running setup.py (path:/tmp/pip-Nzsd_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:22 INFO - Running setup.py (path:/tmp/pip-sWVYZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:22 INFO - Running setup.py (path:/tmp/pip-DWn96t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:22 INFO - Running setup.py (path:/tmp/pip-lzvU_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:22 INFO - Running setup.py (path:/tmp/pip-S7UVQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:22 INFO - Running setup.py (path:/tmp/pip-KhheY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:22 INFO - Running setup.py (path:/tmp/pip-1ROl9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:22 INFO - Running setup.py (path:/tmp/pip-NpmxwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:22 INFO - Running setup.py (path:/tmp/pip-JGXW35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:22 INFO - Running setup.py (path:/tmp/pip-3WnRKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:22 INFO - Running setup.py (path:/tmp/pip-e_jEpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:22 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)) 17:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:22 INFO - Running setup.py (path:/tmp/pip-WQkj0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:23 INFO - Running setup.py (path:/tmp/pip-b_XcMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:23 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)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:23 INFO - Running setup.py (path:/tmp/pip-ql9xBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:23 INFO - Running setup.py (path:/tmp/pip-gGzPuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:23 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)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:23 INFO - Running setup.py (path:/tmp/pip-YLZy2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:23 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)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:23 INFO - Running setup.py (path:/tmp/pip-mgxQ_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:23 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)) 17:12:23 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)) 17:12:23 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)) 17:12:23 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)) 17:12:23 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)) 17:12:23 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)) 17:12:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:25 INFO - Downloading blessings-1.6.tar.gz 17:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:25 INFO - Installing collected packages: blessings 17:12:25 INFO - Running setup.py install for blessings 17:12:25 INFO - Successfully installed blessings 17:12:25 INFO - Cleaning up... 17:12:25 INFO - Return code: 0 17:12:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:12:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:25 INFO - Reading from file tmpfile_stdout 17:12:25 INFO - Current package versions: 17:12:25 INFO - argparse == 1.2.1 17:12:25 INFO - blessings == 1.6 17:12:25 INFO - blobuploader == 1.2.4 17:12:25 INFO - docopt == 0.6.1 17:12:25 INFO - functools32 == 3.2.3-2 17:12:25 INFO - jsonschema == 2.5.1 17:12:25 INFO - manifestparser == 1.1 17:12:25 INFO - mozInstall == 1.12 17:12:25 INFO - mozcrash == 0.17 17:12:25 INFO - mozdebug == 0.1 17:12:25 INFO - mozdevice == 0.48 17:12:25 INFO - mozfile == 1.2 17:12:25 INFO - mozhttpd == 0.7 17:12:25 INFO - mozinfo == 0.9 17:12:25 INFO - mozleak == 0.1 17:12:25 INFO - mozlog == 3.2 17:12:25 INFO - moznetwork == 0.27 17:12:25 INFO - mozprocess == 0.22 17:12:25 INFO - mozprofile == 0.28 17:12:25 INFO - mozrunner == 6.11 17:12:25 INFO - mozscreenshot == 0.1 17:12:25 INFO - mozsystemmonitor == 0.3 17:12:25 INFO - moztest == 0.7 17:12:25 INFO - mozversion == 1.4 17:12:25 INFO - psutil == 3.1.1 17:12:25 INFO - requests == 1.2.3 17:12:25 INFO - wsgiref == 0.1.2 17:12:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:25 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 0x1429030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', '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 17:12:25 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 17:12:25 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 17:12:25 INFO - Using env: {'DISPLAY': ':0', 17:12:25 INFO - 'HOME': '/home/cltbld', 17:12:25 INFO - 'LANG': 'en_US.UTF-8', 17:12:25 INFO - 'LANGUAGE': 'en_US:en', 17:12:25 INFO - 'LOGNAME': 'cltbld', 17:12:25 INFO - 'MAIL': '/var/mail/cltbld', 17:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:25 INFO - 'MOZ_NO_REMOTE': '1', 17:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:25 INFO - 'NO_EM_RESTART': '1', 17:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:25 INFO - 'PWD': '/builds/slave/test', 17:12:25 INFO - 'SHELL': '/bin/bash', 17:12:25 INFO - 'SHLVL': '1', 17:12:25 INFO - 'TERM': 'linux', 17:12:25 INFO - 'TMOUT': '86400', 17:12:25 INFO - 'USER': 'cltbld', 17:12:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:25 INFO - '_': '/tools/buildbot/bin/python'} 17:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:25 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)) 17:12:25 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)) 17:12:25 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)) 17:12:25 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)) 17:12:25 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)) 17:12:25 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)) 17:12:25 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)) 17:12:25 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)) 17:12:25 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)) 17:12:25 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)) 17:12:25 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)) 17:12:25 INFO - Cleaning up... 17:12:26 INFO - Return code: 0 17:12:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:12:26 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')]} 17:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:26 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')]} 17:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:26 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 0x1429030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ea180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', '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 17:12:26 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 17:12:26 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 17:12:26 INFO - Using env: {'DISPLAY': ':0', 17:12:26 INFO - 'HOME': '/home/cltbld', 17:12:26 INFO - 'LANG': 'en_US.UTF-8', 17:12:26 INFO - 'LANGUAGE': 'en_US:en', 17:12:26 INFO - 'LOGNAME': 'cltbld', 17:12:26 INFO - 'MAIL': '/var/mail/cltbld', 17:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:26 INFO - 'MOZ_NO_REMOTE': '1', 17:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:26 INFO - 'NO_EM_RESTART': '1', 17:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:26 INFO - 'PWD': '/builds/slave/test', 17:12:26 INFO - 'SHELL': '/bin/bash', 17:12:26 INFO - 'SHLVL': '1', 17:12:26 INFO - 'TERM': 'linux', 17:12:26 INFO - 'TMOUT': '86400', 17:12:26 INFO - 'USER': 'cltbld', 17:12:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:26 INFO - '_': '/tools/buildbot/bin/python'} 17:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:12:26 INFO - Cleaning up... 17:12:26 INFO - Return code: 0 17:12:26 INFO - Running post-action listener: _resource_record_post_action 17:12:26 INFO - Running post-action listener: _start_resource_monitoring 17:12:26 INFO - Starting resource monitoring. 17:12:26 INFO - ##### 17:12:26 INFO - ##### Finished create-virtualenv step (success) 17:12:26 INFO - ##### 17:12:26 INFO - ##### 17:12:26 INFO - ##### Running install step. 17:12:26 INFO - ##### 17:12:26 INFO - Running pre-action listener: _resource_record_pre_action 17:12:26 INFO - Running main action method: install 17:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:26 INFO - Reading from file tmpfile_stdout 17:12:26 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:26 INFO - Reading from file tmpfile_stdout 17:12:26 INFO - Output received: 17:12:26 INFO - Usage: mozinstall [options] installer 17:12:26 INFO - Options: 17:12:26 INFO - -h, --help show this help message and exit 17:12:26 INFO - -d DEST, --destination=DEST 17:12:26 INFO - Directory to install application into. [default: 17:12:26 INFO - "/builds/slave/test"] 17:12:26 INFO - --app=APP Application being installed. [default: firefox] 17:12:26 INFO - mkdir: /builds/slave/test/build/application 17:12:26 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'] 17:12:26 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 17:12:43 INFO - Reading from file tmpfile_stdout 17:12:43 INFO - Output received: 17:12:43 INFO - /builds/slave/test/build/application/firefox/firefox 17:12:43 INFO - Running post-action listener: _resource_record_post_action 17:12:43 INFO - ##### 17:12:43 INFO - ##### Finished install step (success) 17:12:43 INFO - ##### 17:12:43 INFO - ##### 17:12:43 INFO - ##### Running run-tests step. 17:12:43 INFO - ##### 17:12:43 INFO - Running pre-action listener: _resource_record_pre_action 17:12:43 INFO - Running main action method: run_tests 17:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:12:43 INFO - Python 2.7.3 17:12:43 INFO - Return code: 0 17:12:43 INFO - grabbing minidump binary from tooltool 17:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:43 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 0x16e83b0>, '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 0x16e92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:12:43 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 17:12:43 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 17:12:43 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 17:12:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:43 INFO - Return code: 0 17:12:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:12:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:12:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:12:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:12:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 17:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 17:12:43 INFO - Using env: {'DISPLAY': ':0', 17:12:43 INFO - 'HOME': '/home/cltbld', 17:12:43 INFO - 'LANG': 'en_US.UTF-8', 17:12:43 INFO - 'LANGUAGE': 'en_US:en', 17:12:43 INFO - 'LOGNAME': 'cltbld', 17:12:43 INFO - 'MAIL': '/var/mail/cltbld', 17:12:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:43 INFO - 'MOZ_NO_REMOTE': '1', 17:12:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:43 INFO - 'NO_EM_RESTART': '1', 17:12:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:43 INFO - 'PWD': '/builds/slave/test', 17:12:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:43 INFO - 'SHELL': '/bin/bash', 17:12:43 INFO - 'SHLVL': '1', 17:12:43 INFO - 'TERM': 'linux', 17:12:43 INFO - 'TMOUT': '86400', 17:12:43 INFO - 'USER': 'cltbld', 17:12:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514', 17:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:43 INFO - '_': '/tools/buildbot/bin/python'} 17:12:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 17:12:43 INFO - mozversion application_buildid: 20160705143027 17:12:43 INFO - mozversion application_changeset: a74f88a7a05abe2b80eba43cab211199b30e7463 17:12:43 INFO - mozversion application_display_name: Nightly 17:12:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:43 INFO - mozversion application_name: Firefox 17:12:43 INFO - mozversion application_remotingname: firefox 17:12:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:12:43 INFO - mozversion application_vendor: Mozilla 17:12:43 INFO - mozversion application_version: 50.0a1 17:12:43 INFO - mozversion platform_buildid: 20160705143027 17:12:43 INFO - mozversion platform_changeset: a74f88a7a05abe2b80eba43cab211199b30e7463 17:12:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:12:43 INFO - mozversion platform_version: 50.0a1 17:12:43 INFO - using testdate: 1467763963 17:12:43 INFO - actual date: 1467763963 17:12:43 INFO - starting webserver on 'localhost:51414' 17:12:43 INFO - SUITE-START | Running 2 tests 17:12:43 INFO - TEST-START | dromaeo_css 17:12:43 INFO - operating with platform_type : linux_ 17:12:43 INFO - Initialising browser for dromaeo_css test... 17:12:43 INFO - TEST-INFO | started process 22386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk5FEno/profile http://localhost:51414/getInfo.html) 17:12:47 INFO - PROCESS | 22386 | __metrics Screen width/height:1600/1200 17:12:47 INFO - PROCESS | 22386 | colorDepth:24 17:12:47 INFO - PROCESS | 22386 | Browser inner width/height: 1024/697 17:12:47 INFO - PROCESS | 22386 | __metrics 17:12:48 INFO - PROCESS | 22386 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:49 INFO - TEST-INFO | 22386: exit 0 17:12:49 INFO - Browser initialized. 17:12:49 INFO - Running cycle 1/1 for dromaeo_css test... 17:12:49 INFO - TEST-INFO | started process 22468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk5FEno/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:01 INFO - PROCESS | 22468 | RSS: Main: 157831168 17:13:01 INFO - PROCESS | 22468 | 17:13:52 INFO - PROCESS | 22468 | 1467764032674 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] 17:16:00 INFO - PROCESS | 22468 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51414/tests/dromaeo/cssquery-ext.html) 17:16:01 INFO - PROCESS | 22468 | RSS: Main: 245768192 17:16:01 INFO - PROCESS | 22468 | 17:19:03 INFO - PROCESS | 22468 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-ext.html (next: http://localhost:51414/tests/dromaeo/cssquery-jquery.html) 17:19:04 INFO - PROCESS | 22468 | RSS: Main: 248729600 17:19:04 INFO - PROCESS | 22468 | 17:22:05 INFO - PROCESS | 22468 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51414/tests/dromaeo/cssquery-mootools.html) 17:22:06 INFO - PROCESS | 22468 | RSS: Main: 246652928 17:22:06 INFO - PROCESS | 22468 | 17:25:08 INFO - PROCESS | 22468 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51414/tests/dromaeo/cssquery-prototype.html) 17:25:09 INFO - PROCESS | 22468 | RSS: Main: 235819008 17:25:09 INFO - PROCESS | 22468 | 17:28:12 INFO - PROCESS | 22468 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51414/tests/dromaeo/cssquery-yui.html) 17:28:12 INFO - PROCESS | 22468 | RSS: Main: 230469632 17:28:12 INFO - PROCESS | 22468 | 17:31:15 INFO - PROCESS | 22468 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-yui.html (next: http://localhost:51414/tests/dromaeo/cssquery-dojo.html) 17:31:15 INFO - PROCESS | 22468 | RSS: Main: 307728384 17:31:15 INFO - PROCESS | 22468 | 17:31:15 INFO - PROCESS | 22468 | __start_tp_report 17:31:15 INFO - PROCESS | 22468 | _x_x_mozilla_page_load 17:31:15 INFO - PROCESS | 22468 | _x_x_mozilla_page_load_details 17:31:15 INFO - PROCESS | 22468 | |i|pagename|runs| 17:31:15 INFO - PROCESS | 22468 | |0;dojo.html;3116.7506599472044;3119.7504199664;3149.9370012599757;3162.2094476380903;3181.2842110525135;5224.111900976834;5296.3379577552805;5400.324959380077;5457.645253058553;5489.615726899118;5291.708956007418;5343.946560534394;5344.812931547397;5358.196270559418;5371.248025276464;4807.903841923159;4808.903821923559;4864.927026094611;4874.195757699975;5082.263071854579;4995.225740010304;5006.799728010875;5029.1199040168;5049.3940727112795;5056.241563765446;4787.329773831666;4874.878128046809;4920.532549407801;4928.827491037832;4975.651704380694;4817.229243321051;4830.154722923475;4834.395700537433;4836.056968891067;4932.21084626458;4829.710217386968;4844.830430934936;4869.4156701195725;4878.780454879539;4914.729689867056;5184.274201611777;5318.574514038867;5378.542823859937;5383.031054410205;5386.245925570423;5796.855078623026;5797.391273916221;5838.299404071496;5855.443732845415;5856.590038697293;5853.47318741311;5869.06095024794;5891.351951285355;5905.202797622309;5908.379620139866;5211.739413029333;5315.601329900234;5343.465653434664;5346.331708536433;5365;5897.203877476486;5902.173695682608;5910.763569457174;5912.054071348563;5913.053911374245;5426.348838139448;5648.350439699405;5694.316681998187;5696.772129114789;5703.058995265817;5721.542276617861;5738.225339579187;5788.88422231553;5791.131330300404;5792.275965504312;5722.828315150552;5723.055695810228;5730.455606717355;5732.656040637575;5732.77068917247;5553.4724201200825;5717.685527295956;5738.454846789548;5744.913826292609;5752.568557358215;4336.934945975813;4351.3472979053395;4365.585269399402;4407.360932664746;4410.5368936261875;3875.4961854958674;3894.0264933766557;3895.6883449323986;3909.765414075108;3930.390789427643;5195.3246078009615;5290.841274761763;5368.0605893968395;5509;5548.140038294071;5653.547716182696;5669.914951275734;5680.744366503517;5689.800856970069;5732.656040637575;5369.946300537023;5378.381486129145;5423.593230507728;5424.077906755861;5427.348718153847;4691.882702932454;4760.809567617256;4794.232922732346;4816.084943860656;4843.2250839865455;5963.194968679173;5969.761209551656;5973.731182096903;5976.312724036705;6012.819615411545;5769.538436924952;5770.2498675171955;5774.797882074107;5778.335491418541;5779.884402312015;5799.623024503562;5821.738021788945;5864.824055278348;5890.14592884038;5909.586328957103;5601.5238704710555;5612.775488980558;5630.915536267041;5635.577331700221;5642.407547207648;5630.634008789416;5660.349059858169;5670.659760414388;5686.976344258073;5687.687177205294;5340.332458442695;5466.835994919999;5511.862203444785;5567.498925096761;5594.692291923983;5545.3622833374675;5580.135079062752;5582.218489411404;5582.804601838916;5591.944080559142;5305.602079844104;5473.28847249855;5509.090999984957;5525.668459892419;5575.247341608993;5451.4276001019325;5541.861453463695;5558.972205138948;5575.358833734173;5625.578081643811;5427.918581221364;5429.67421954684;5434.782608695766;5439.156930675752;5461.863453413537 17:31:15 INFO - PROCESS | 22468 | |1;ext.html;597.4951166264508;602.7317843559615;641.7721708793375;648.8669822686347;655.2006552006557;30144.698553014463;32868.83565582175;32943.50584741231;42438.151236975245;44521.33218001733;45140.774296128475;45470.77264613681;45477.09045819082;45530.54469455304;45549;8879.644814207424;8975.775605609846;9031.683891063782;9042.186203241707;9046.231070359026;8764.8685269721;8924.286057115416;8925;8932.955335223314;8938.687145949893;8915.153060459279;8963.565829467287;8967;8976.910230897705;8987.281017518582;8932.196102350787;8966.730998070068;8980.416272942302;8982.999999999967;8985.281177505783;8843.336749743796;8906.109389061106;8906.198442140238;8906.821863562758;8908.06465321145;41824.37263441051;42063.36904946428;42127;42134.78932605348;42162.78918605418;3440.208751987032;3442.6557344265625;3529.294141171776;3536.1513236823234;3701.907452313687;32382.352352953043;33037;33128.33743325144;33248.83375583131;33934.660653393395;4437.0682156747125;4479.126570318789;4495.078508905699;4504.61710754583;4510.075434535912;349692;352144;352897;353009;353583;52619;59632.40367596355;60058.399416006156;60105;60158.398416016156;61937.690311548155;63828;63868.36131638624;68170.65914670395;68188.3181168192;17014.744778828328;17085.57286067858;17184.398546050827;17188.42173673934;17209.311627534757;11271;11536.480858361394;13241.073124881359;13413.798793018113;13422;14308.928455357865;18791.15439805212;19288.80711192898;19310.517237069187;19784.109715062856;7116.608586527687;7224.74713385029;7246.094238220223;7294.197638259787;7409.814754631069;961.9326647134774;1039.5383373366672;1039.8752149741929;1067.9679609611724;1091.0704757725532;31823.204419889225;33527.32945341079;34124.82937585296;36220.637793622256;36592.26815463729;1135.6593022093339;1145.307089211032;1154.417019405195;1164.0920082335792;1176.4176732517458;16688.165591720364;17011.788467499395;17159.828401716073;17213.1393430328;17225.1387430628;545375;549706;550701;550868;551830;56916;57404.42595574074;57466.7126664364;57484.13773793396;57491.42508574944;1190.547591915084;1219.5914368686413;1246.7070238493948;1279.4754150798128;1381.6891199480237;29787.70212297849;32201;35359.11602209965;35727.28545429129;35986.64013359938;55939.16091258553;56394.43605563892;56925.71537142288;56962.430375695716;56986;521556;525593;525918;526257;527499;33448.83275583606;42589.36115958325;43056;43733;47435;48481;48893;49796;50196.49803501918;50568.241476377145;37175.44236836504;41513.58486415218;41675.7916210417;42210.15579688328;42574.361384579875;42200.57799421967;42796.14407711891;43099.56900430955;43195.78402108095;43995.56004440042;41387.379189312785;41963.37054944239;42656.14687706166;42795.57204427916;42842.35736464018;35143;37259;37308.06729831776;37560.43659345058;37796.811015945845;28068.456234907277;28265.858670707337;28382.290442739097;28400.43199136047;28826.855865720536 17:31:15 INFO - PROCESS | 22468 | |2;jquery.html;378.892015775504;383.6029709250924;383.79275191396647;397.28687006822753;400.3774131225944;17565.648687026252;19576.70634940477;19811.00944952752;19839.801601983974;19853.40439786805;18511.629767404644;18740.250389984383;19007.619847603073;19066.142023608936;19518;5630.296212973379;5646.153077038436;5778.306603207621;5824.242848429698;5827.562932780037;5551.444855514436;5674.631148975324;5675.432456754333;5691.544676425897;5715.2855893013375;5427.402985671592;5536.916946245809;5658.8019419320335;5675.772969081232;5718.799842005531;5619.887602247953;5626.268585083933;5630.268065151545;5639.943600564024;5667.659940403569;4949.901001979976;5033.471485494044;5046.293518907356;5050.621203409759;5056.292119103328;22804.54390912189;23022.194223202274;23171.420714482105;23458.882705586362;23460.530789384116;2326.7207935047904;2397.880105994711;2444.963325550118;2503.7496250374998;2964.5108557088056;13650.112742671694;13748.243846588433;13961;14198.787018194735;14669.046511976794;1982.1773963805147;1997.9600407991759;1999.8400127989726;2000.1599328282011;2027.8479114066504;75354.24645753582;77592.61203694002;78976.21023789688;79010;79132.60433697852;8837.381383303236;9242.537873106317;9429.811403771886;9623.615055397846;9980.451075190935;12931.54739584129;12952.611421657366;13028.47886084565;13038.608841734573;13040.478380864848;7586.165521792598;7728.18854020331;7772.106207786064;7886.211378862183;7953.602319883983;7847.372210223169;7893.486923349964;7985.401094917905;8015.078265999368;8100.392470564613;3575.284943011408;3658.414653655402;3659.359612067931;3972.443857859902;4024.879253622396;1951.5316324082403;1958.529952811315;1960.4510736993664;1974.2399176316935;2012.4465771912548;926.6756635177769;972.8589354543551;992.8659630949874;1022.4734261855151;1025.374521541859;18472.168752406174;18656.626867462575;19068.80931190698;19171.437659033047;19642.70535941962;941.2564074381162;949.2453499467939;973.8149751547325;1029.9854643176466;1033.3902997231519;10551.050405463391;10736.838947415796;10866.891331086747;10928.890711092787;10970.561177552809;357443;361526;361735;459892;467102;92601.53699231596;98287;101794.49102754438;102062.6485459248;103102;1017.59296281488;1018.556927736437;1037.0666400239693;1063.83509558049;1066.5253961986996;17146;17448.787156128037;17736.467905962843;17756.733648995534;17942.37201697934;42189.367159493246;42559.36160957526;43063.784681076395;43753.56246437495;44098.77950610355;54244.45755542552;54358.184627229835;56603.43396565982;61302.38697612967;64585.677071614344;8200.26197642215;8203.138670439517;8260.752177434686;8302.833943320979;8531.573421329032;8780.824383512421;13386.464541418623;13827.86172138306;13968.37142328618;14007.789883151965;11822.290662560274;11839.467223975114;12024.699382515508;12131.393430328271;12163.635090947286;11634.476448559666;11858.52565897389;12033.134864096079;12077;12386;11676.124290678063;11916.34460104668;12021.579244726392;12190.695232619255;12475.875241247835;8002.119766825528;8165.632546535301;8219.794505137419;8573.65705371803;8650.610722517376;11816.822747658964;11860.406979651156;11964.760704785682;12213.14507984468;12290.262584244974 17:31:15 INFO - PROCESS | 22468 | |3;mootools.html;1304.1718508746942;1466.508719578941;1470.3530446603493;1658.3449537432707;1783.9732404013942;8509.489430634167;8941.821163576724;9000.729978100668;9212;9230.261579073675;8919;9110.544472776368;9146.45121292723;9147.359684822066;9164.358494905358;2040.5204776877497;2275.5448910218024;2321.7562155973546;2332.3935776698054;2380.9166679166233;2353.505763789606;2361.633946738258;2362.1024010875844;2362.61016932206;2372.9288121356385;2269.307861102363;2283.703118594589;2292.7592602776717;2295.7819007194375;2298.0807676929194;1959.7256384106165;2191.550732099916;2245.640697488394;2249.0216755711317;2251.043306594699;2261.6381378979286;2280.2019293247395;2281.908723651052;2285.211601997325;2286.142696488817;9008.774780630536;9037.096290370977;9043.593038313225;9077.591508382138;9080.182783549511;5181.1969144782615;5264.341957255343;5264.947350526484;5269.314989051399;5278.551323137538;3416.6070901846356;3443.777459002043;3460.446328587414;3479.599846017715;3573.1960308930543;1070.8982646648556;1075.5590208014755;1086.630545614487;1092.4210168610648;1099.433791597328;11711.238769480042;11726.120540959462;11738.70653233676;11746.706332341675;11780.352080635561;4433.756143412079;4520.118576877478;4648.093621743727;4663.347131401607;4673.906521869543;9969.30214884951;9971.40171589707;9972.30193886421;9978.351407158512;10004.749881252881;5198.610104242197;5227.215917612312;5227.503387178288;5232.136697444879;5253.4221235664045;4398.362237475548;4762.3808904842845;4901.534354236342;4921.212605983025;4987.975060124676;4099.282625540519;4099.754014759124;4156.866653378537;4182.414461975326;4205.3902184183125;1176.3062586676585;1217.4764851114105;1267.4233223883111;1282.3588205897051;1286.9806952895715;787.8930103205006;954.9952250238705;960.6061514778908;966.8839739231197;972.5720682899502;5888.735006924699;6015.789447369409;6038.275406951107;6062.42406971337;6082.665453400017;905.9139381758722;993.4337427666161;995.437577768573;996.1930836022844;1011.2163073618005;4061.817218225187;4174.102567947906;4183.91632167355;4194.832206711759;4262.808173632194;11171;11534.94232528832;11726.589569365031;11852.703682407837;11891.524339026342;11624.593139240085;11716.88283117175;11731.824022639667;11733.941330293294;11752.353620550952;8605.95697021511;8642.870356944652;8653.913460865437;8661;8671.479711217347;5972.790952316648;6003.429674180946;6102.267727872683;6121.755129794758;6277.811665650038;10517.842232366675;10553.788924221319;10747.892521075002;10769.353838769699;10773.353598784099;10787.406692631666;10957.780844382909;11049.558017679203;11167.329960202414;11202;7103.9289607103265;7353.264673532604;7354.705811767683;7718.652660630398;7805.33654639362;8244.917550824415;8477.703280385156;8491.065982742017;8787.956060219658;8789.604467798836;7784.766457006299;7883.763487095396;7905;8071.959640201761;8078.878816817635;7669.271419215165;7700.122508739882;7730.922690773245;7871.763847084597;7942.086660033939;7399.223081576572;7516.285952834472;7600.771976840703;7600.885986710093;7607.087149542091;5210.6613070150315;5230.11088115029;5323.574114070942;5360.865978350573;5417.83746487606;5244.292020577173;5360.571154307724;5441.428649991853;5476;5484.61607687458 17:31:15 INFO - PROCESS | 22468 | |4;prototype.html;323.501807216886;326.80881684214734;329.4695540180308;331.38362645479407;334.1379241556784;5258.526732594066;5259.86850328742;5267.815626453075;5272.973635131829;5279.5512381447525;5185.377754669445;5204.947950520494;5209.244659524366;5242.737863106849;5249.370075590925;3630.2739452109554;3921.90195245119;4030.677545796344;4043.433919251307;4047.4738284023038;4031.8992025199314;4097.385392191165;4119.217348703737;4126.64923481503;4127.855525056623;4053.3312003519386;4071.4503542021894;4080.510338759353;4081.1837632473475;4107.219628270634;3912.39357899526;4008.779517126557;4099.61053699901;4100.528439229482;4112.799652186066;3406.7615266931325;3559.94660080099;3562.1806984393475;3597.676209141164;3604.4588565061567;5059.8988020239385;5074;5083.822066227664;5095.490450954912;5099.515546023122;4413.29387298034;4644.4658864230705;4644.790984405709;4651.557932085649;4656.627469802408;5462.672239665632;5468.031508656881;5482.698451585161;5490.886008886568;5491.505764481216;3927;3928.626780455852;3936.7757217172493;3937;3944.861929832442;5179.948200517984;5431.592630552725;5674.829755107312;5719.14212868069;5719.742611582489;3964.5837187095517;3978.085040440657;3985.362342025262;3989.860354887623;3991.7006224533275;4006.779627120478;4010.19796040793;4021.6782657387926;4045;4047.3928910663635;4644.140833945731;4651.906961860744;4662.860114196579;4665.6034237090225;4667.8366257181515;5276.709780962007;5546.722663866791;5555.666660000413;5555.916661250004;5556.583256255797;1395.6510872281929;1402.6773842016394;1407.3526177958254;1413.7525932961692;1417.454280102168;883.8188171424842;901.2339511415245;908.7500937242311;919.4575200631659;928.5774972387547;4724.456687480983;4728.574428301401;4740.45484769249;4762.618990480753;4763.475687779877;5016.871203979148;5032.84901452957;5035.136999310279;5058.9494105058475;5082.847514574569;4654.487291630166;4734.502877197913;4831.492693267227;4836.975815120902;4926.3349447824085;2972.271793410585;2989.9850500747357;2991.461536923331;3007.8195308281574;3009.5335223040465;5715.685637289989;5802.564807639444;5805.767769289266;5856.4143585641095;5858.56060795442;5453.23654688344;5565.582581306418;5742.167385729046;5758.165066065397;5815.156802263648;5644.8024319148635;5718.656880587178;5810.360860305363;5817.301923769175;5819.82540523785;5559.388467268516;5592.972035139798;5616.326040875121;5663.631863928831;5672.404397538199;5454.181872719124;5573.3869274380595;5595.972020139873;5596.4123767003875;5608.691521966331;5764.827055188351;5775.343342062698;5786;5813.94186058134;5837.270341207349;3975.741576797499;3991.3015222336558;3991.880243592697;4002.939955900722;4021.6983726221238;5431.375391829832;5681.659100453986;5689.516391106802;5699.601027928005;5709.25779648643;5500.28496295479;5530.11518157109;5535.557155427637;5564.888702226014;5608.579356548356;5309.46905309466;5496.258005169251;5543.750531226186;5548.417416171405;5578.684845788952;5418.566514678738;5524.723763811874;5525.751341189736;5566.109422492382;5575.8290758941075;5459.2629994950175;5518;5553.8333849984565;5610.214569960127;5650.830475085754;5207.557357624644;5475.260839786737;5481.958427898687;5489.204065410573;5528.474794894479 17:31:15 INFO - PROCESS | 22468 | |5;yui.html;748.5209465941798;777.8677624803782;802.8835818806269;828.4987582512581;840.5167028958349;15985.84014159858;16470.505884823473;17081.40215092472;17127.486175414728;17136.48590542284;13454.596362109129;13537.120087194326;13617.45530178794;13619.523316683919;13626.454941802316;655.6393983309173;778.2295527427863;802.1016461563057;807.4105902691039;809.6437567470324;804.8108694456798;805.2752522729531;806.9919300806976;807.0839597057353;807.1000834069999;678.1150598468996;836.2306677856357;839.5508403004394;839.5969934431446;840.2479780596362;699.199416667915;702.1644243350422;702.6767686864049;806.7700705298962;838.5094719589048;614.1003429975063;614.529884638252;614.6435067660746;614.6987975891825;614.8555089553952;15295.923520382437;15298.235088245654;15333.156676382794;15357.616059598487;15358.078515289119;14397.856021439757;14508.492202772957;14602.926985365111;14648.926755366261;14801.925990370088;13166.605001849959;13186.406611702401;13252.536161234408;13479.528216512474;13494.662633434145;4403.251447253974;4488.8877778055485;4541.205289074399;4592.931106033412;4642.396488456479;78722;79126.20873791246;79175;79379.20620793776;81012;11135.72160695989;11208.887911120948;11235.494402751896;11329.71675708114;11476;19754.209831606575;19771.703424448646;19772.802271977383;19909;19952.800471995095;8760;8987.820243595092;9048.638054477879;9060.093990600888;9194.12655797698;4919.434265059564;4932.506749325039;4965.503449655078;5047.091523525727;5092.567131793839;3535.452004939187;3685.594584595692;3723.0506220913494;3723.6834869035893;3723.77657340555;634.7175506899478;652.5464801962685;653.8692261547709;657.9572327798678;662.7084083003463;642.4603333200134;642.8489305013318;674.130371820356;732.487258918759;761.3490465651788;9726.70819875405;9755.658551950648;9762.121409073217;9841.311108222355;10244.692659220234;607.4320510322774;610.9114178444189;613.5980932489226;675.5743881354813;709.3863807806314;4387.407699960465;4554.635629149726;4558.452985641744;4560.475545312332;4644.558766917137;111899;116330.41834790772;116626.41686791682;120751;122894;74103;99064.50467747616;100006.4999674997;100159.49920250352;100340;87748.12251877527;90581.11222770631;90613.54693226492;90944.09055909488;91429.54285228532;9139.451632902048;9253.861192082259;9400.905990940004;9514.904850951401;9515.381500202464;50293;50489.74755126201;51355.74322128366;51731.22403164031;52333.47666523286;75795.31535134997;76053;76262.23737762551;77952;79400;11151.888481115086;11255.887441125811;11313.094952403624;11406.600768973378;12294;14105;14364;14430.134191948517;14538.200398978157;14583;13661.658458538615;13732.65668358299;13870.514531991332;13910.37403316833;14381.568552943429;12904.290264035568;13407.262600557064;13508.189508629514;14318.856811431753;14322.928385358007;12140.453679584616;12382.257064576153;12748.87251127514;12922.289274090015;13134.474621015052;10110.595576176871;10323.793524129625;10509.106725928381;10566.366018038942;11118.61084862026;10286.280336800397;10298.08955075959;10324.43215623148;10435.843462347919;10530.104941079788 17:31:15 INFO - PROCESS | 22468 | __end_tp_report 17:31:15 INFO - PROCESS | 22468 | __start_cc_report 17:31:15 INFO - PROCESS | 22468 | _x_x_mozilla_cycle_collect,785 17:31:15 INFO - PROCESS | 22468 | __end_cc_report 17:31:15 INFO - PROCESS | 22468 | __startTimestamp1467765075481__endTimestamp 17:31:15 INFO - PROCESS | 22468 | 17:31:15 INFO - PROCESS | 22468 | ------- Summary: start ------- 17:31:15 INFO - PROCESS | 22468 | Number of tests: 6 17:31:15 INFO - PROCESS | 22468 | 17:31:15 INFO - PROCESS | 22468 | [#0] dojo.html Cycles:165 Average:5317.00 Median:5473.29 stddev:602.74 (11.0%) stddev-sans-first:579.35 17:31:15 INFO - PROCESS | 22468 | Values: 3116.8 3119.8 3149.9 3162.2 3181.3 5224.1 5296.3 5400.3 5457.6 5489.6 5291.7 5343.9 5344.8 5358.2 5371.2 4807.9 4808.9 4864.9 4874.2 5082.3 4995.2 5006.8 5029.1 5049.4 5056.2 4787.3 4874.9 4920.5 4928.8 4975.7 4817.2 4830.2 4834.4 4836.1 4932.2 4829.7 4844.8 4869.4 4878.8 4914.7 5184.3 5318.6 5378.5 5383.0 5386.2 5796.9 5797.4 5838.3 5855.4 5856.6 5853.5 5869.1 5891.4 5905.2 5908.4 5211.7 5315.6 5343.5 5346.3 5365.0 5897.2 5902.2 5910.8 5912.1 5913.1 5426.3 5648.4 5694.3 5696.8 5703.1 5721.5 5738.2 5788.9 5791.1 5792.3 5722.8 5723.1 5730.5 5732.7 5732.8 5553.5 5717.7 5738.5 5744.9 5752.6 4336.9 4351.3 4365.6 4407.4 4410.5 3875.5 3894.0 3895.7 3909.8 3930.4 5195.3 5290.8 5368.1 5509.0 5548.1 5653.5 5669.9 5680.7 5689.8 5732.7 5369.9 5378.4 5423.6 5424.1 5427.3 4691.9 4760.8 4794.2 4816.1 4843.2 5963.2 5969.8 5973.7 5976.3 6012.8 5769.5 5770.2 5774.8 5778.3 5779.9 5799.6 5821.7 5864.8 5890.1 5909.6 5601.5 5612.8 5630.9 5635.6 5642.4 5630.6 5660.3 5670.7 5687.0 5687.7 5340.3 5466.8 5511.9 5567.5 5594.7 5545.4 5580.1 5582.2 5582.8 5591.9 5305.6 5473.3 5509.1 5525.7 5575.2 5451.4 5541.9 5559.0 5575.4 5625.6 5427.9 5429.7 5434.8 5439.2 5461.9 17:31:15 INFO - PROCESS | 22468 | 17:31:15 INFO - PROCESS | 22468 | [#1] ext.html Cycles:180 Average:63975.99 Median:42819.25 stddev:128495.10 (300.1%) stddev-sans-first:128767.45 17:31:15 INFO - PROCESS | 22468 | Values: 597.5 602.7 641.8 648.9 655.2 30144.7 32868.8 32943.5 42438.2 44521.3 45140.8 45470.8 45477.1 45530.5 45549.0 8879.6 8975.8 9031.7 9042.2 9046.2 8764.9 8924.3 8925.0 8933.0 8938.7 8915.2 8963.6 8967.0 8976.9 8987.3 8932.2 8966.7 8980.4 8983.0 8985.3 8843.3 8906.1 8906.2 8906.8 8908.1 41824.4 42063.4 42127.0 42134.8 42162.8 3440.2 3442.7 3529.3 3536.2 3701.9 32382.4 33037.0 33128.3 33248.8 33934.7 4437.1 4479.1 4495.1 4504.6 4510.1 349692.0 352144.0 352897.0 353009.0 353583.0 52619.0 59632.4 60058.4 60105.0 60158.4 61937.7 63828.0 63868.4 68170.7 68188.3 17014.7 17085.6 17184.4 17188.4 17209.3 11271.0 11536.5 13241.1 13413.8 13422.0 14308.9 18791.2 19288.8 19310.5 19784.1 7116.6 7224.7 7246.1 7294.2 7409.8 961.9 1039.5 1039.9 1068.0 1091.1 31823.2 33527.3 34124.8 36220.6 36592.3 1135.7 1145.3 1154.4 1164.1 1176.4 16688.2 17011.8 17159.8 17213.1 17225.1 545375.0 549706.0 550701.0 550868.0 551830.0 56916.0 57404.4 57466.7 57484.1 57491.4 1190.5 1219.6 1246.7 1279.5 1381.7 29787.7 32201.0 35359.1 35727.3 35986.6 55939.2 56394.4 56925.7 56962.4 56986.0 521556.0 525593.0 525918.0 526257.0 527499.0 33448.8 42589.4 43056.0 43733.0 47435.0 48481.0 48893.0 49796.0 50196.5 50568.2 37175.4 41513.6 41675.8 42210.2 42574.4 42200.6 42796.1 43099.6 43195.8 43995.6 41387.4 41963.4 42656.1 42795.6 42842.4 35143.0 37259.0 37308.1 37560.4 37796.8 28068.5 28265.9 28382.3 28400.4 28826.9 17:31:15 INFO - PROCESS | 22468 | 17:31:15 INFO - PROCESS | 22468 | [#2] jquery.html Cycles:180 Average:26678.98 Median:180203.76 stddev:67511.65 (37.5%) stddev-sans-first:67672.16 17:31:15 INFO - PROCESS | 22468 | Values: 378.9 383.6 383.8 397.3 400.4 17565.6 19576.7 19811.0 19839.8 19853.4 18511.6 18740.3 19007.6 19066.1 19518.0 5630.3 5646.2 5778.3 5824.2 5827.6 5551.4 5674.6 5675.4 5691.5 5715.3 5427.4 5536.9 5658.8 5675.8 5718.8 5619.9 5626.3 5630.3 5639.9 5667.7 4949.9 5033.5 5046.3 5050.6 5056.3 22804.5 23022.2 23171.4 23458.9 23460.5 2326.7 2397.9 2445.0 2503.7 2964.5 13650.1 13748.2 13961.0 14198.8 14669.0 1982.2 1998.0 1999.8 2000.2 2027.8 75354.2 77592.6 78976.2 79010.0 79132.6 8837.4 9242.5 9429.8 9623.6 9980.5 12931.5 12952.6 13028.5 13038.6 13040.5 7586.2 7728.2 7772.1 7886.2 7953.6 7847.4 7893.5 7985.4 8015.1 8100.4 3575.3 3658.4 3659.4 3972.4 4024.9 1951.5 1958.5 1960.5 1974.2 2012.4 926.7 972.9 992.9 1022.5 1025.4 18472.2 18656.6 19068.8 19171.4 19642.7 941.3 949.2 973.8 1030.0 1033.4 10551.1 10736.8 10866.9 10928.9 10970.6 357443.0 361526.0 361735.0 459892.0 467102.0 92601.5 98287.0 101794.5 102062.6 103102.0 1017.6 1018.6 1037.1 1063.8 1066.5 17146.0 17448.8 17736.5 17756.7 17942.4 42189.4 42559.4 43063.8 43753.6 44098.8 54244.5 54358.2 56603.4 61302.4 64585.7 8200.3 8203.1 8260.8 8302.8 8531.6 8780.8 13386.5 13827.9 13968.4 14007.8 11822.3 11839.5 12024.7 12131.4 12163.6 11634.5 11858.5 12033.1 12077.0 12386.0 11676.1 11916.3 12021.6 12190.7 12475.9 8002.1 8165.6 8219.8 8573.7 8650.6 11816.8 11860.4 11964.8 12213.1 12290.3 17:31:15 INFO - PROCESS | 22468 | 17:31:15 INFO - PROCESS | 22468 | [#3] mootools.html Cycles:180 Average:5930.08 Median:4954.59 stddev:3421.10 (69.0%) stddev-sans-first:3413.03 17:31:15 INFO - PROCESS | 22468 | Values: 1304.2 1466.5 1470.4 1658.3 1784.0 8509.5 8941.8 9000.7 9212.0 9230.3 8919.0 9110.5 9146.5 9147.4 9164.4 2040.5 2275.5 2321.8 2332.4 2380.9 2353.5 2361.6 2362.1 2362.6 2372.9 2269.3 2283.7 2292.8 2295.8 2298.1 1959.7 2191.6 2245.6 2249.0 2251.0 2261.6 2280.2 2281.9 2285.2 2286.1 9008.8 9037.1 9043.6 9077.6 9080.2 5181.2 5264.3 5264.9 5269.3 5278.6 3416.6 3443.8 3460.4 3479.6 3573.2 1070.9 1075.6 1086.6 1092.4 1099.4 11711.2 11726.1 11738.7 11746.7 11780.4 4433.8 4520.1 4648.1 4663.3 4673.9 9969.3 9971.4 9972.3 9978.4 10004.7 5198.6 5227.2 5227.5 5232.1 5253.4 4398.4 4762.4 4901.5 4921.2 4988.0 4099.3 4099.8 4156.9 4182.4 4205.4 1176.3 1217.5 1267.4 1282.4 1287.0 787.9 955.0 960.6 966.9 972.6 5888.7 6015.8 6038.3 6062.4 6082.7 905.9 993.4 995.4 996.2 1011.2 4061.8 4174.1 4183.9 4194.8 4262.8 11171.0 11534.9 11726.6 11852.7 11891.5 11624.6 11716.9 11731.8 11733.9 11752.4 8606.0 8642.9 8653.9 8661.0 8671.5 5972.8 6003.4 6102.3 6121.8 6277.8 10517.8 10553.8 10747.9 10769.4 10773.4 10787.4 10957.8 11049.6 11167.3 11202.0 7103.9 7353.3 7354.7 7718.7 7805.3 8244.9 8477.7 8491.1 8788.0 8789.6 7784.8 7883.8 7905.0 8072.0 8078.9 7669.3 7700.1 7730.9 7871.8 7942.1 7399.2 7516.3 7600.8 7600.9 7607.1 5210.7 5230.1 5323.6 5360.9 5417.8 5244.3 5360.6 5441.4 5476.0 5484.6 17:31:15 INFO - PROCESS | 22468 | 17:31:15 INFO - PROCESS | 22468 | [#4] prototype.html Cycles:180 Average:4573.48 Median:5182.66 stddev:1348.55 (26.0%) stddev-sans-first:1314.07 17:31:15 INFO - PROCESS | 22468 | Values: 323.5 326.8 329.5 331.4 334.1 5258.5 5259.9 5267.8 5273.0 5279.6 5185.4 5204.9 5209.2 5242.7 5249.4 3630.3 3921.9 4030.7 4043.4 4047.5 4031.9 4097.4 4119.2 4126.6 4127.9 4053.3 4071.5 4080.5 4081.2 4107.2 3912.4 4008.8 4099.6 4100.5 4112.8 3406.8 3559.9 3562.2 3597.7 3604.5 5059.9 5074.0 5083.8 5095.5 5099.5 4413.3 4644.5 4644.8 4651.6 4656.6 5462.7 5468.0 5482.7 5490.9 5491.5 3927.0 3928.6 3936.8 3937.0 3944.9 5179.9 5431.6 5674.8 5719.1 5719.7 3964.6 3978.1 3985.4 3989.9 3991.7 4006.8 4010.2 4021.7 4045.0 4047.4 4644.1 4651.9 4662.9 4665.6 4667.8 5276.7 5546.7 5555.7 5555.9 5556.6 1395.7 1402.7 1407.4 1413.8 1417.5 883.8 901.2 908.8 919.5 928.6 4724.5 4728.6 4740.5 4762.6 4763.5 5016.9 5032.8 5035.1 5058.9 5082.8 4654.5 4734.5 4831.5 4837.0 4926.3 2972.3 2990.0 2991.5 3007.8 3009.5 5715.7 5802.6 5805.8 5856.4 5858.6 5453.2 5565.6 5742.2 5758.2 5815.2 5644.8 5718.7 5810.4 5817.3 5819.8 5559.4 5593.0 5616.3 5663.6 5672.4 5454.2 5573.4 5596.0 5596.4 5608.7 5764.8 5775.3 5786.0 5813.9 5837.3 3975.7 3991.3 3991.9 4002.9 4021.7 5431.4 5681.7 5689.5 5699.6 5709.3 5500.3 5530.1 5535.6 5564.9 5608.6 5309.5 5496.3 5543.8 5548.4 5578.7 5418.6 5524.7 5525.8 5566.1 5575.8 5459.3 5518.0 5553.8 5610.2 5650.8 5207.6 5475.3 5482.0 5489.2 5528.5 17:31:15 INFO - PROCESS | 22468 | 17:31:15 INFO - PROCESS | 22468 | [#5] yui.html Cycles:180 Average:20965.82 Median:4576.70 stddev:30464.43 (665.6%) stddev-sans-first:30512.07 17:31:15 INFO - PROCESS | 22468 | Values: 748.5 777.9 802.9 828.5 840.5 15985.8 16470.5 17081.4 17127.5 17136.5 13454.6 13537.1 13617.5 13619.5 13626.5 655.6 778.2 802.1 807.4 809.6 804.8 805.3 807.0 807.1 807.1 678.1 836.2 839.6 839.6 840.2 699.2 702.2 702.7 806.8 838.5 614.1 614.5 614.6 614.7 614.9 15295.9 15298.2 15333.2 15357.6 15358.1 14397.9 14508.5 14602.9 14648.9 14801.9 13166.6 13186.4 13252.5 13479.5 13494.7 4403.3 4488.9 4541.2 4592.9 4642.4 78722.0 79126.2 79175.0 79379.2 81012.0 11135.7 11208.9 11235.5 11329.7 11476.0 19754.2 19771.7 19772.8 19909.0 19952.8 8760.0 8987.8 9048.6 9060.1 9194.1 4919.4 4932.5 4965.5 5047.1 5092.6 3535.5 3685.6 3723.1 3723.7 3723.8 634.7 652.5 653.9 658.0 662.7 642.5 642.8 674.1 732.5 761.3 9726.7 9755.7 9762.1 9841.3 10244.7 607.4 610.9 613.6 675.6 709.4 4387.4 4554.6 4558.5 4560.5 4644.6 111899.0 116330.4 116626.4 120751.0 122894.0 74103.0 99064.5 100006.5 100159.5 100340.0 87748.1 90581.1 90613.5 90944.1 91429.5 9139.5 9253.9 9400.9 9514.9 9515.4 50293.0 50489.7 51355.7 51731.2 52333.5 75795.3 76053.0 76262.2 77952.0 79400.0 11151.9 11255.9 11313.1 11406.6 12294.0 14105.0 14364.0 14430.1 14538.2 14583.0 13661.7 13732.7 13870.5 13910.4 14381.6 12904.3 13407.3 13508.2 14318.9 14322.9 12140.5 12382.3 12748.9 12922.3 13134.5 10110.6 10323.8 10509.1 10566.4 11118.6 10286.3 10298.1 10324.4 10435.8 10530.1 17:31:15 INFO - PROCESS | 22468 | -------- Summary: end -------- 17:31:15 INFO - PROCESS | 22468 | 17:31:16 INFO - TEST-INFO | 22468: exit 0 17:31:16 INFO - TEST-OK | dromaeo_css | took 1112242ms 17:31:16 INFO - TEST-START | kraken 17:31:16 INFO - operating with platform_type : linux_ 17:31:16 INFO - Initialising browser for kraken test... 17:31:16 INFO - TEST-INFO | started process 22664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0XZyKR/profile http://localhost:51414/getInfo.html) 17:31:19 INFO - PROCESS | 22664 | __metrics Screen width/height:1600/1200 17:31:19 INFO - PROCESS | 22664 | colorDepth:24 17:31:19 INFO - PROCESS | 22664 | Browser inner width/height: 1024/697 17:31:19 INFO - PROCESS | 22664 | __metrics 17:31:20 INFO - PROCESS | 22664 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:31:21 INFO - TEST-INFO | 22664: exit 0 17:31:21 INFO - Browser initialized. 17:31:21 INFO - Running cycle 1/1 for kraken test... 17:31:21 INFO - TEST-INFO | started process 22746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0XZyKR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:33 INFO - PROCESS | 22746 | RSS: Main: 158044160 17:31:33 INFO - PROCESS | 22746 | 17:31:35 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51414/tests/kraken/driver.html?testName=audio-beat-detection) 17:31:36 INFO - PROCESS | 22746 | RSS: Main: 215953408 17:31:36 INFO - PROCESS | 22746 | 17:31:39 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51414/tests/kraken/driver.html?testName=audio-dft) 17:31:39 INFO - PROCESS | 22746 | RSS: Main: 204312576 17:31:39 INFO - PROCESS | 22746 | 17:31:42 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51414/tests/kraken/driver.html?testName=audio-fft) 17:31:43 INFO - PROCESS | 22746 | RSS: Main: 269078528 17:31:43 INFO - PROCESS | 22746 | 17:31:45 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51414/tests/kraken/driver.html?testName=audio-oscillator) 17:31:46 INFO - PROCESS | 22746 | RSS: Main: 179970048 17:31:46 INFO - PROCESS | 22746 | 17:31:48 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51414/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:31:49 INFO - PROCESS | 22746 | RSS: Main: 185274368 17:31:49 INFO - PROCESS | 22746 | 17:31:52 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51414/tests/kraken/driver.html?testName=imaging-darkroom) 17:31:52 INFO - PROCESS | 22746 | RSS: Main: 219398144 17:31:52 INFO - PROCESS | 22746 | 17:31:56 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51414/tests/kraken/driver.html?testName=imaging-desaturate) 17:31:56 INFO - PROCESS | 22746 | RSS: Main: 221417472 17:31:56 INFO - PROCESS | 22746 | 17:31:59 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51414/tests/kraken/driver.html?testName=json-parse-financial) 17:32:00 INFO - PROCESS | 22746 | RSS: Main: 222089216 17:32:00 INFO - PROCESS | 22746 | 17:32:01 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51414/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:02 INFO - PROCESS | 22746 | RSS: Main: 209481728 17:32:02 INFO - PROCESS | 22746 | 17:32:03 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:04 INFO - PROCESS | 22746 | RSS: Main: 212422656 17:32:04 INFO - PROCESS | 22746 | 17:32:06 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:07 INFO - PROCESS | 22746 | RSS: Main: 210030592 17:32:07 INFO - PROCESS | 22746 | 17:32:09 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:10 INFO - PROCESS | 22746 | RSS: Main: 224296960 17:32:10 INFO - PROCESS | 22746 | 17:32:13 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:13 INFO - PROCESS | 22746 | RSS: Main: 225406976 17:32:13 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51414/tests/kraken/driver.html?testName=ai-astar) 17:32:15 INFO - PROCESS | 22746 | RSS: Main: 268288000 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | __start_tp_report 17:32:15 INFO - PROCESS | 22746 | _x_x_mozilla_page_load 17:32:15 INFO - PROCESS | 22746 | _x_x_mozilla_page_load_details 17:32:15 INFO - PROCESS | 22746 | |i|pagename|runs| 17:32:15 INFO - PROCESS | 22746 | |0;ai-astar;102;111;110;111;111;112;109;110;110;109 17:32:15 INFO - PROCESS | 22746 | |1;audio-beat-detection;141;116;118;174;119;116;150;118;149;117 17:32:15 INFO - PROCESS | 22746 | |2;audio-dft;160;160;161;160;159;161;160;161;162;161 17:32:15 INFO - PROCESS | 22746 | |3;audio-fft;75;74;74;115;76;76;74;73;108;74 17:32:15 INFO - PROCESS | 22746 | |4;audio-oscillator;84;84;125;83;84;85;137;84;84;135 17:32:15 INFO - PROCESS | 22746 | |5;imaging-gaussian-blur;118;117;117;117;117;117;118;117;117;116 17:32:15 INFO - PROCESS | 22746 | |6;imaging-darkroom;146;147;147;146;145;146;146;146;146;145 17:32:15 INFO - PROCESS | 22746 | |7;imaging-desaturate;94;95;95;95;95;96;96;95;95;96 17:32:15 INFO - PROCESS | 22746 | |8;json-parse-financial;52;51;53;53;55;53;54;53;53;53 17:32:15 INFO - PROCESS | 22746 | |9;json-stringify-tinderbox;60;60;61;60;61;60;61;60;60;60 17:32:15 INFO - PROCESS | 22746 | |10;stanford-crypto-aes;84;78;80;75;75;76;75;74;75;75 17:32:15 INFO - PROCESS | 22746 | |11;stanford-crypto-ccm;128;118;118;120;129;139;136;129;156;131 17:32:15 INFO - PROCESS | 22746 | |12;stanford-crypto-pbkdf2;160;163;160;160;159;159;155;154;155;160 17:32:15 INFO - PROCESS | 22746 | |13;stanford-crypto-sha256-iterative;62;63;61;61;66;65;63;62;62;66 17:32:15 INFO - PROCESS | 22746 | __end_tp_report 17:32:15 INFO - PROCESS | 22746 | __start_cc_report 17:32:15 INFO - PROCESS | 22746 | _x_x_mozilla_cycle_collect,1645 17:32:15 INFO - PROCESS | 22746 | __end_cc_report 17:32:15 INFO - PROCESS | 22746 | __startTimestamp1467765135529__endTimestamp 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | ------- Summary: start ------- 17:32:15 INFO - PROCESS | 22746 | Number of tests: 14 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 17:32:15 INFO - PROCESS | 22746 | Values: 102.0 111.0 110.0 111.0 111.0 112.0 109.0 110.0 110.0 109.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:130.00 stddev:20.43 (15.7%) stddev-sans-first:21.39 17:32:15 INFO - PROCESS | 22746 | Values: 141.0 116.0 118.0 174.0 119.0 116.0 150.0 118.0 149.0 117.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 17:32:15 INFO - PROCESS | 22746 | Values: 160.0 160.0 161.0 160.0 159.0 161.0 160.0 161.0 162.0 161.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.00 stddev:15.72 (21.2%) stddev-sans-first:16.47 17:32:15 INFO - PROCESS | 22746 | Values: 75.0 74.0 74.0 115.0 76.0 76.0 74.0 73.0 108.0 74.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:84.00 stddev:23.55 (28.0%) stddev-sans-first:24.38 17:32:15 INFO - PROCESS | 22746 | Values: 84.0 84.0 125.0 83.0 84.0 85.0 137.0 84.0 84.0 135.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 17:32:15 INFO - PROCESS | 22746 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:32:15 INFO - PROCESS | 22746 | Values: 146.0 147.0 147.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 17:32:15 INFO - PROCESS | 22746 | Values: 94.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.05 (2.0%) stddev-sans-first:1.05 17:32:15 INFO - PROCESS | 22746 | Values: 52.0 51.0 53.0 53.0 55.0 53.0 54.0 53.0 53.0 53.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 17:32:15 INFO - PROCESS | 22746 | Values: 60.0 60.0 61.0 60.0 61.0 60.0 61.0 60.0 60.0 60.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:75.50 stddev:3.13 (4.1%) stddev-sans-first:1.90 17:32:15 INFO - PROCESS | 22746 | Values: 84.0 78.0 80.0 75.0 75.0 76.0 75.0 74.0 75.0 75.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:130.00 stddev:11.48 (8.8%) stddev-sans-first:12.14 17:32:15 INFO - PROCESS | 22746 | Values: 128.0 118.0 118.0 120.0 129.0 139.0 136.0 129.0 156.0 131.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:160.00 stddev:2.88 (1.8%) stddev-sans-first:3.00 17:32:15 INFO - PROCESS | 22746 | Values: 160.0 163.0 160.0 160.0 159.0 159.0 155.0 154.0 155.0 160.0 17:32:15 INFO - PROCESS | 22746 | 17:32:15 INFO - PROCESS | 22746 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.91 (3.0%) stddev-sans-first:1.99 17:32:15 INFO - PROCESS | 22746 | Values: 62.0 63.0 61.0 61.0 66.0 65.0 63.0 62.0 62.0 66.0 17:32:15 INFO - PROCESS | 22746 | -------- Summary: end -------- 17:32:15 INFO - PROCESS | 22746 | 17:32:16 INFO - TEST-INFO | 22746: exit 0 17:32:16 INFO - TEST-OK | kraken | took 60263ms 17:32:16 INFO - SUITE-END | took 1172s 17:32:16 INFO - Completed test suite (00:19:32) 17:32:16 INFO - javascript benchmark 17:32:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.7506599472044, 3119.7504199664, 3149.9370012599757, 3162.2094476380903, 3181.2842110525135, 5224.111900976834, 5296.3379577552805, 5400.324959380077, 5457.645253058553, 5489.615726899118, 5291.708956007418, 5343.946560534394, 5344.812931547397, 5358.196270559418, 5371.248025276464, 4807.903841923159, 4808.903821923559, 4864.927026094611, 4874.195757699975, 5082.263071854579, 4995.225740010304, 5006.799728010875, 5029.1199040168, 5049.3940727112795, 5056.241563765446, 4787.329773831666, 4874.878128046809, 4920.532549407801, 4928.827491037832, 4975.651704380694, 4817.229243321051, 4830.154722923475, 4834.395700537433, 4836.056968891067, 4932.21084626458, 4829.710217386968, 4844.830430934936, 4869.4156701195725, 4878.780454879539, 4914.729689867056, 5184.274201611777, 5318.574514038867, 5378.542823859937, 5383.031054410205, 5386.245925570423, 5796.855078623026, 5797.391273916221, 5838.299404071496, 5855.443732845415, 5856.590038697293, 5853.47318741311, 5869.06095024794, 5891.351951285355, 5905.202797622309, 5908.379620139866, 5211.739413029333, 5315.601329900234, 5343.465653434664, 5346.331708536433, 5365.0, 5897.203877476486, 5902.173695682608, 5910.763569457174, 5912.054071348563, 5913.053911374245, 5426.348838139448, 5648.350439699405, 5694.316681998187, 5696.772129114789, 5703.058995265817, 5721.542276617861, 5738.225339579187, 5788.88422231553, 5791.131330300404, 5792.275965504312, 5722.828315150552, 5723.055695810228, 5730.455606717355, 5732.656040637575, 5732.77068917247, 5553.4724201200825, 5717.685527295956, 5738.454846789548, 5744.913826292609, 5752.568557358215, 4336.934945975813, 4351.3472979053395, 4365.585269399402, 4407.360932664746, 4410.5368936261875, 3875.4961854958674, 3894.0264933766557, 3895.6883449323986, 3909.765414075108, 3930.390789427643, 5195.3246078009615, 5290.841274761763, 5368.0605893968395, 5509.0, 5548.140038294071, 5653.547716182696, 5669.914951275734, 5680.744366503517, 5689.800856970069, 5732.656040637575, 5369.946300537023, 5378.381486129145, 5423.593230507728, 5424.077906755861, 5427.348718153847, 4691.882702932454, 4760.809567617256, 4794.232922732346, 4816.084943860656, 4843.2250839865455, 5963.194968679173, 5969.761209551656, 5973.731182096903, 5976.312724036705, 6012.819615411545, 5769.538436924952, 5770.2498675171955, 5774.797882074107, 5778.335491418541, 5779.884402312015, 5799.623024503562, 5821.738021788945, 5864.824055278348, 5890.14592884038, 5909.586328957103, 5601.5238704710555, 5612.775488980558, 5630.915536267041, 5635.577331700221, 5642.407547207648, 5630.634008789416, 5660.349059858169, 5670.659760414388, 5686.976344258073, 5687.687177205294, 5340.332458442695, 5466.835994919999, 5511.862203444785, 5567.498925096761, 5594.692291923983, 5545.3622833374675, 5580.135079062752, 5582.218489411404, 5582.804601838916, 5591.944080559142, 5305.602079844104, 5473.28847249855, 5509.090999984957, 5525.668459892419, 5575.247341608993, 5451.4276001019325, 5541.861453463695, 5558.972205138948, 5575.358833734173, 5625.578081643811, 5427.918581221364, 5429.67421954684, 5434.782608695766, 5439.156930675752, 5461.863453413537], "value": 5276.839355243028, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4951166264508, 602.7317843559615, 641.7721708793375, 648.8669822686347, 655.2006552006557, 30144.698553014463, 32868.83565582175, 32943.50584741231, 42438.151236975245, 44521.33218001733, 45140.774296128475, 45470.77264613681, 45477.09045819082, 45530.54469455304, 45549.0, 8879.644814207424, 8975.775605609846, 9031.683891063782, 9042.186203241707, 9046.231070359026, 8764.8685269721, 8924.286057115416, 8925.0, 8932.955335223314, 8938.687145949893, 8915.153060459279, 8963.565829467287, 8967.0, 8976.910230897705, 8987.281017518582, 8932.196102350787, 8966.730998070068, 8980.416272942302, 8982.999999999967, 8985.281177505783, 8843.336749743796, 8906.109389061106, 8906.198442140238, 8906.821863562758, 8908.06465321145, 41824.37263441051, 42063.36904946428, 42127.0, 42134.78932605348, 42162.78918605418, 3440.208751987032, 3442.6557344265625, 3529.294141171776, 3536.1513236823234, 3701.907452313687, 32382.352352953043, 33037.0, 33128.33743325144, 33248.83375583131, 33934.660653393395, 4437.0682156747125, 4479.126570318789, 4495.078508905699, 4504.61710754583, 4510.075434535912, 349692.0, 352144.0, 352897.0, 353009.0, 353583.0, 52619.0, 59632.40367596355, 60058.399416006156, 60105.0, 60158.398416016156, 61937.690311548155, 63828.0, 63868.36131638624, 68170.65914670395, 68188.3181168192, 17014.744778828328, 17085.57286067858, 17184.398546050827, 17188.42173673934, 17209.311627534757, 11271.0, 11536.480858361394, 13241.073124881359, 13413.798793018113, 13422.0, 14308.928455357865, 18791.15439805212, 19288.80711192898, 19310.517237069187, 19784.109715062856, 7116.608586527687, 7224.74713385029, 7246.094238220223, 7294.197638259787, 7409.814754631069, 961.9326647134774, 1039.5383373366672, 1039.8752149741929, 1067.9679609611724, 1091.0704757725532, 31823.204419889225, 33527.32945341079, 34124.82937585296, 36220.637793622256, 36592.26815463729, 1135.6593022093339, 1145.307089211032, 1154.417019405195, 1164.0920082335792, 1176.4176732517458, 16688.165591720364, 17011.788467499395, 17159.828401716073, 17213.1393430328, 17225.1387430628, 545375.0, 549706.0, 550701.0, 550868.0, 551830.0, 56916.0, 57404.42595574074, 57466.7126664364, 57484.13773793396, 57491.42508574944, 1190.547591915084, 1219.5914368686413, 1246.7070238493948, 1279.4754150798128, 1381.6891199480237, 29787.70212297849, 32201.0, 35359.11602209965, 35727.28545429129, 35986.64013359938, 55939.16091258553, 56394.43605563892, 56925.71537142288, 56962.430375695716, 56986.0, 521556.0, 525593.0, 525918.0, 526257.0, 527499.0, 33448.83275583606, 42589.36115958325, 43056.0, 43733.0, 47435.0, 48481.0, 48893.0, 49796.0, 50196.49803501918, 50568.241476377145, 37175.44236836504, 41513.58486415218, 41675.7916210417, 42210.15579688328, 42574.361384579875, 42200.57799421967, 42796.14407711891, 43099.56900430955, 43195.78402108095, 43995.56004440042, 41387.379189312785, 41963.37054944239, 42656.14687706166, 42795.57204427916, 42842.35736464018, 35143.0, 37259.0, 37308.06729831776, 37560.43659345058, 37796.811015945845, 28068.456234907277, 28265.858670707337, 28382.290442739097, 28400.43199136047, 28826.855865720536], "value": 20699.05182042829, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.892015775504, 383.6029709250924, 383.79275191396647, 397.28687006822753, 400.3774131225944, 17565.648687026252, 19576.70634940477, 19811.00944952752, 19839.801601983974, 19853.40439786805, 18511.629767404644, 18740.250389984383, 19007.619847603073, 19066.142023608936, 19518.0, 5630.296212973379, 5646.153077038436, 5778.306603207621, 5824.242848429698, 5827.562932780037, 5551.444855514436, 5674.631148975324, 5675.432456754333, 5691.544676425897, 5715.2855893013375, 5427.402985671592, 5536.916946245809, 5658.8019419320335, 5675.772969081232, 5718.799842005531, 5619.887602247953, 5626.268585083933, 5630.268065151545, 5639.943600564024, 5667.659940403569, 4949.901001979976, 5033.471485494044, 5046.293518907356, 5050.621203409759, 5056.292119103328, 22804.54390912189, 23022.194223202274, 23171.420714482105, 23458.882705586362, 23460.530789384116, 2326.7207935047904, 2397.880105994711, 2444.963325550118, 2503.7496250374998, 2964.5108557088056, 13650.112742671694, 13748.243846588433, 13961.0, 14198.787018194735, 14669.046511976794, 1982.1773963805147, 1997.9600407991759, 1999.8400127989726, 2000.1599328282011, 2027.8479114066504, 75354.24645753582, 77592.61203694002, 78976.21023789688, 79010.0, 79132.60433697852, 8837.381383303236, 9242.537873106317, 9429.811403771886, 9623.615055397846, 9980.451075190935, 12931.54739584129, 12952.611421657366, 13028.47886084565, 13038.608841734573, 13040.478380864848, 7586.165521792598, 7728.18854020331, 7772.106207786064, 7886.211378862183, 7953.602319883983, 7847.372210223169, 7893.486923349964, 7985.401094917905, 8015.078265999368, 8100.392470564613, 3575.284943011408, 3658.414653655402, 3659.359612067931, 3972.443857859902, 4024.879253622396, 1951.5316324082403, 1958.529952811315, 1960.4510736993664, 1974.2399176316935, 2012.4465771912548, 926.6756635177769, 972.8589354543551, 992.8659630949874, 1022.4734261855151, 1025.374521541859, 18472.168752406174, 18656.626867462575, 19068.80931190698, 19171.437659033047, 19642.70535941962, 941.2564074381162, 949.2453499467939, 973.8149751547325, 1029.9854643176466, 1033.3902997231519, 10551.050405463391, 10736.838947415796, 10866.891331086747, 10928.890711092787, 10970.561177552809, 357443.0, 361526.0, 361735.0, 459892.0, 467102.0, 92601.53699231596, 98287.0, 101794.49102754438, 102062.6485459248, 103102.0, 1017.59296281488, 1018.556927736437, 1037.0666400239693, 1063.83509558049, 1066.5253961986996, 17146.0, 17448.787156128037, 17736.467905962843, 17756.733648995534, 17942.37201697934, 42189.367159493246, 42559.36160957526, 43063.784681076395, 43753.56246437495, 44098.77950610355, 54244.45755542552, 54358.184627229835, 56603.43396565982, 61302.38697612967, 64585.677071614344, 8200.26197642215, 8203.138670439517, 8260.752177434686, 8302.833943320979, 8531.573421329032, 8780.824383512421, 13386.464541418623, 13827.86172138306, 13968.37142328618, 14007.789883151965, 11822.290662560274, 11839.467223975114, 12024.699382515508, 12131.393430328271, 12163.635090947286, 11634.476448559666, 11858.52565897389, 12033.134864096079, 12077.0, 12386.0, 11676.124290678063, 11916.34460104668, 12021.579244726392, 12190.695232619255, 12475.875241247835, 8002.119766825528, 8165.632546535301, 8219.794505137419, 8573.65705371803, 8650.610722517376, 11816.822747658964, 11860.406979651156, 11964.760704785682, 12213.14507984468, 12290.262584244974], "value": 9121.704627613119, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.1718508746942, 1466.508719578941, 1470.3530446603493, 1658.3449537432707, 1783.9732404013942, 8509.489430634167, 8941.821163576724, 9000.729978100668, 9212.0, 9230.261579073675, 8919.0, 9110.544472776368, 9146.45121292723, 9147.359684822066, 9164.358494905358, 2040.5204776877497, 2275.5448910218024, 2321.7562155973546, 2332.3935776698054, 2380.9166679166233, 2353.505763789606, 2361.633946738258, 2362.1024010875844, 2362.61016932206, 2372.9288121356385, 2269.307861102363, 2283.703118594589, 2292.7592602776717, 2295.7819007194375, 2298.0807676929194, 1959.7256384106165, 2191.550732099916, 2245.640697488394, 2249.0216755711317, 2251.043306594699, 2261.6381378979286, 2280.2019293247395, 2281.908723651052, 2285.211601997325, 2286.142696488817, 9008.774780630536, 9037.096290370977, 9043.593038313225, 9077.591508382138, 9080.182783549511, 5181.1969144782615, 5264.341957255343, 5264.947350526484, 5269.314989051399, 5278.551323137538, 3416.6070901846356, 3443.777459002043, 3460.446328587414, 3479.599846017715, 3573.1960308930543, 1070.8982646648556, 1075.5590208014755, 1086.630545614487, 1092.4210168610648, 1099.433791597328, 11711.238769480042, 11726.120540959462, 11738.70653233676, 11746.706332341675, 11780.352080635561, 4433.756143412079, 4520.118576877478, 4648.093621743727, 4663.347131401607, 4673.906521869543, 9969.30214884951, 9971.40171589707, 9972.30193886421, 9978.351407158512, 10004.749881252881, 5198.610104242197, 5227.215917612312, 5227.503387178288, 5232.136697444879, 5253.4221235664045, 4398.362237475548, 4762.3808904842845, 4901.534354236342, 4921.212605983025, 4987.975060124676, 4099.282625540519, 4099.754014759124, 4156.866653378537, 4182.414461975326, 4205.3902184183125, 1176.3062586676585, 1217.4764851114105, 1267.4233223883111, 1282.3588205897051, 1286.9806952895715, 787.8930103205006, 954.9952250238705, 960.6061514778908, 966.8839739231197, 972.5720682899502, 5888.735006924699, 6015.789447369409, 6038.275406951107, 6062.42406971337, 6082.665453400017, 905.9139381758722, 993.4337427666161, 995.437577768573, 996.1930836022844, 1011.2163073618005, 4061.817218225187, 4174.102567947906, 4183.91632167355, 4194.832206711759, 4262.808173632194, 11171.0, 11534.94232528832, 11726.589569365031, 11852.703682407837, 11891.524339026342, 11624.593139240085, 11716.88283117175, 11731.824022639667, 11733.941330293294, 11752.353620550952, 8605.95697021511, 8642.870356944652, 8653.913460865437, 8661.0, 8671.479711217347, 5972.790952316648, 6003.429674180946, 6102.267727872683, 6121.755129794758, 6277.811665650038, 10517.842232366675, 10553.788924221319, 10747.892521075002, 10769.353838769699, 10773.353598784099, 10787.406692631666, 10957.780844382909, 11049.558017679203, 11167.329960202414, 11202.0, 7103.9289607103265, 7353.264673532604, 7354.705811767683, 7718.652660630398, 7805.33654639362, 8244.917550824415, 8477.703280385156, 8491.065982742017, 8787.956060219658, 8789.604467798836, 7784.766457006299, 7883.763487095396, 7905.0, 8071.959640201761, 8078.878816817635, 7669.271419215165, 7700.122508739882, 7730.922690773245, 7871.763847084597, 7942.086660033939, 7399.223081576572, 7516.285952834472, 7600.771976840703, 7600.885986710093, 7607.087149542091, 5210.6613070150315, 5230.11088115029, 5323.574114070942, 5360.865978350573, 5417.83746487606, 5244.292020577173, 5360.571154307724, 5441.428649991853, 5476.0, 5484.61607687458], "value": 4701.24573728404, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.501807216886, 326.80881684214734, 329.4695540180308, 331.38362645479407, 334.1379241556784, 5258.526732594066, 5259.86850328742, 5267.815626453075, 5272.973635131829, 5279.5512381447525, 5185.377754669445, 5204.947950520494, 5209.244659524366, 5242.737863106849, 5249.370075590925, 3630.2739452109554, 3921.90195245119, 4030.677545796344, 4043.433919251307, 4047.4738284023038, 4031.8992025199314, 4097.385392191165, 4119.217348703737, 4126.64923481503, 4127.855525056623, 4053.3312003519386, 4071.4503542021894, 4080.510338759353, 4081.1837632473475, 4107.219628270634, 3912.39357899526, 4008.779517126557, 4099.61053699901, 4100.528439229482, 4112.799652186066, 3406.7615266931325, 3559.94660080099, 3562.1806984393475, 3597.676209141164, 3604.4588565061567, 5059.8988020239385, 5074.0, 5083.822066227664, 5095.490450954912, 5099.515546023122, 4413.29387298034, 4644.4658864230705, 4644.790984405709, 4651.557932085649, 4656.627469802408, 5462.672239665632, 5468.031508656881, 5482.698451585161, 5490.886008886568, 5491.505764481216, 3927.0, 3928.626780455852, 3936.7757217172493, 3937.0, 3944.861929832442, 5179.948200517984, 5431.592630552725, 5674.829755107312, 5719.14212868069, 5719.742611582489, 3964.5837187095517, 3978.085040440657, 3985.362342025262, 3989.860354887623, 3991.7006224533275, 4006.779627120478, 4010.19796040793, 4021.6782657387926, 4045.0, 4047.3928910663635, 4644.140833945731, 4651.906961860744, 4662.860114196579, 4665.6034237090225, 4667.8366257181515, 5276.709780962007, 5546.722663866791, 5555.666660000413, 5555.916661250004, 5556.583256255797, 1395.6510872281929, 1402.6773842016394, 1407.3526177958254, 1413.7525932961692, 1417.454280102168, 883.8188171424842, 901.2339511415245, 908.7500937242311, 919.4575200631659, 928.5774972387547, 4724.456687480983, 4728.574428301401, 4740.45484769249, 4762.618990480753, 4763.475687779877, 5016.871203979148, 5032.84901452957, 5035.136999310279, 5058.9494105058475, 5082.847514574569, 4654.487291630166, 4734.502877197913, 4831.492693267227, 4836.975815120902, 4926.3349447824085, 2972.271793410585, 2989.9850500747357, 2991.461536923331, 3007.8195308281574, 3009.5335223040465, 5715.685637289989, 5802.564807639444, 5805.767769289266, 5856.4143585641095, 5858.56060795442, 5453.23654688344, 5565.582581306418, 5742.167385729046, 5758.165066065397, 5815.156802263648, 5644.8024319148635, 5718.656880587178, 5810.360860305363, 5817.301923769175, 5819.82540523785, 5559.388467268516, 5592.972035139798, 5616.326040875121, 5663.631863928831, 5672.404397538199, 5454.181872719124, 5573.3869274380595, 5595.972020139873, 5596.4123767003875, 5608.691521966331, 5764.827055188351, 5775.343342062698, 5786.0, 5813.94186058134, 5837.270341207349, 3975.741576797499, 3991.3015222336558, 3991.880243592697, 4002.939955900722, 4021.6983726221238, 5431.375391829832, 5681.659100453986, 5689.516391106802, 5699.601027928005, 5709.25779648643, 5500.28496295479, 5530.11518157109, 5535.557155427637, 5564.888702226014, 5608.579356548356, 5309.46905309466, 5496.258005169251, 5543.750531226186, 5548.417416171405, 5578.684845788952, 5418.566514678738, 5524.723763811874, 5525.751341189736, 5566.109422492382, 5575.8290758941075, 5459.2629994950175, 5518.0, 5553.8333849984565, 5610.214569960127, 5650.830475085754, 5207.557357624644, 5475.260839786737, 5481.958427898687, 5489.204065410573, 5528.474794894479], "value": 4145.280896140373, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.5209465941798, 777.8677624803782, 802.8835818806269, 828.4987582512581, 840.5167028958349, 15985.84014159858, 16470.505884823473, 17081.40215092472, 17127.486175414728, 17136.48590542284, 13454.596362109129, 13537.120087194326, 13617.45530178794, 13619.523316683919, 13626.454941802316, 655.6393983309173, 778.2295527427863, 802.1016461563057, 807.4105902691039, 809.6437567470324, 804.8108694456798, 805.2752522729531, 806.9919300806976, 807.0839597057353, 807.1000834069999, 678.1150598468996, 836.2306677856357, 839.5508403004394, 839.5969934431446, 840.2479780596362, 699.199416667915, 702.1644243350422, 702.6767686864049, 806.7700705298962, 838.5094719589048, 614.1003429975063, 614.529884638252, 614.6435067660746, 614.6987975891825, 614.8555089553952, 15295.923520382437, 15298.235088245654, 15333.156676382794, 15357.616059598487, 15358.078515289119, 14397.856021439757, 14508.492202772957, 14602.926985365111, 14648.926755366261, 14801.925990370088, 13166.605001849959, 13186.406611702401, 13252.536161234408, 13479.528216512474, 13494.662633434145, 4403.251447253974, 4488.8877778055485, 4541.205289074399, 4592.931106033412, 4642.396488456479, 78722.0, 79126.20873791246, 79175.0, 79379.20620793776, 81012.0, 11135.72160695989, 11208.887911120948, 11235.494402751896, 11329.71675708114, 11476.0, 19754.209831606575, 19771.703424448646, 19772.802271977383, 19909.0, 19952.800471995095, 8760.0, 8987.820243595092, 9048.638054477879, 9060.093990600888, 9194.12655797698, 4919.434265059564, 4932.506749325039, 4965.503449655078, 5047.091523525727, 5092.567131793839, 3535.452004939187, 3685.594584595692, 3723.0506220913494, 3723.6834869035893, 3723.77657340555, 634.7175506899478, 652.5464801962685, 653.8692261547709, 657.9572327798678, 662.7084083003463, 642.4603333200134, 642.8489305013318, 674.130371820356, 732.487258918759, 761.3490465651788, 9726.70819875405, 9755.658551950648, 9762.121409073217, 9841.311108222355, 10244.692659220234, 607.4320510322774, 610.9114178444189, 613.5980932489226, 675.5743881354813, 709.3863807806314, 4387.407699960465, 4554.635629149726, 4558.452985641744, 4560.475545312332, 4644.558766917137, 111899.0, 116330.41834790772, 116626.41686791682, 120751.0, 122894.0, 74103.0, 99064.50467747616, 100006.4999674997, 100159.49920250352, 100340.0, 87748.12251877527, 90581.11222770631, 90613.54693226492, 90944.09055909488, 91429.54285228532, 9139.451632902048, 9253.861192082259, 9400.905990940004, 9514.904850951401, 9515.381500202464, 50293.0, 50489.74755126201, 51355.74322128366, 51731.22403164031, 52333.47666523286, 75795.31535134997, 76053.0, 76262.23737762551, 77952.0, 79400.0, 11151.888481115086, 11255.887441125811, 11313.094952403624, 11406.600768973378, 12294.0, 14105.0, 14364.0, 14430.134191948517, 14538.200398978157, 14583.0, 13661.658458538615, 13732.65668358299, 13870.514531991332, 13910.37403316833, 14381.568552943429, 12904.290264035568, 13407.262600557064, 13508.189508629514, 14318.856811431753, 14322.928385358007, 12140.453679584616, 12382.257064576153, 12748.87251127514, 12922.289274090015, 13134.474621015052, 10110.595576176871, 10323.793524129625, 10509.106725928381, 10566.366018038942, 11118.61084862026, 10286.280336800397, 10298.08955075959, 10324.43215623148, 10435.843462347919, 10530.104941079788], "value": 7523.163134083103, "unit": "score"}], "name": "dromaeo_css", "value": 7257.199644861488, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 111.0, 111.0, 112.0, 109.0, 110.0, 110.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 118.0, 174.0, 119.0, 116.0, 150.0, 118.0, 149.0, 117.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 159.0, 161.0, 160.0, 161.0, 162.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 115.0, 76.0, 76.0, 74.0, 73.0, 108.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 125.0, 83.0, 84.0, 85.0, 137.0, 84.0, 84.0, 135.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 53.0, 55.0, 53.0, 54.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 78.0, 80.0, 75.0, 75.0, 76.0, 75.0, 74.0, 75.0, 75.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 118.0, 118.0, 120.0, 129.0, 139.0, 136.0, 129.0, 156.0, 131.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 160.0, 159.0, 159.0, 155.0, 154.0, 155.0, 160.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 61.0, 66.0, 65.0, 63.0, 62.0, 62.0, 66.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1482.5000000000002, "alertThreshold": 2.0}]} 17:32:16 INFO - Return code: 0 17:32:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:32:16 INFO - # TBPL SUCCESS # 17:32:16 INFO - Running post-action listener: _resource_record_post_action 17:32:16 INFO - ##### 17:32:16 INFO - ##### Finished run-tests step (success) 17:32:16 INFO - ##### 17:32:16 INFO - Running post-run listener: _resource_record_post_run 17:32:16 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 566349824; Read time: 12; Write time: 402080 17:32:16 INFO - TinderboxPrint: CPU usage
12.9% 17:32:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:32:16 INFO - TinderboxPrint: I/O write bytes / time
566,349,824 / 402,080 17:32:16 INFO - TinderboxPrint: CPU idle
8,267.6 (87.0%) 17:32:16 INFO - TinderboxPrint: CPU user
1,189.1 (12.5%) 17:32:16 INFO - TinderboxPrint: Swap in / out
0 / 0 17:32:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 267956224; Read time: 0; Write time: 225320 17:32:16 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297779200; Read time: 0; Write time: 176760 17:32:17 INFO - Running post-run listener: _upload_blobber_files 17:32:17 INFO - Blob upload gear active. 17:32:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:17 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 17:32:17 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:32:17 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:32:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:32:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:32:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:21 INFO - (blobuploader) - INFO - Done attempting. 17:32:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:32:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:32:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:21 INFO - (blobuploader) - INFO - Done attempting. 17:32:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:32:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:32:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:22 INFO - (blobuploader) - INFO - Done attempting. 17:32:22 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:22 INFO - Return code: 0 17:32:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:32:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5e5bb7bbef1740b6532e05af57c6e06fee85f0baf473770d63cecde81a3d601a18608c9f3feabe6c43e23bfe3746091100be105bd49690f8defebe6fd68c288", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1d718a277c7a6ea9186c3292c6330580b384447bd74fc1bc8fd921f604e1e279a67f58707725699b76c65325a37f5de529ab897d39f54b8b087db296be13660", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a67d58be2bbd620ea7be7174cf6087f6727f5c9e029101f6207d7fb964800706c5b7accdf460506223f32e34f97fc45ce464b601ec6bb3ae8fa8e30882c6d1d"} 17:32:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:32:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:32:22 INFO - Contents: 17:32:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5e5bb7bbef1740b6532e05af57c6e06fee85f0baf473770d63cecde81a3d601a18608c9f3feabe6c43e23bfe3746091100be105bd49690f8defebe6fd68c288", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1d718a277c7a6ea9186c3292c6330580b384447bd74fc1bc8fd921f604e1e279a67f58707725699b76c65325a37f5de529ab897d39f54b8b087db296be13660", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a67d58be2bbd620ea7be7174cf6087f6727f5c9e029101f6207d7fb964800706c5b7accdf460506223f32e34f97fc45ce464b601ec6bb3ae8fa8e30882c6d1d"} 17:32:22 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:22 INFO - Copying logs to upload dir... 17:32:22 INFO - mkdir: /builds/slave/test/build/upload/logs 17:32:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.291988 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-05 17:32:22.248177) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 17:32:22.251450) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514 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/sha512/a5e5bb7bbef1740b6532e05af57c6e06fee85f0baf473770d63cecde81a3d601a18608c9f3feabe6c43e23bfe3746091100be105bd49690f8defebe6fd68c288", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1d718a277c7a6ea9186c3292c6330580b384447bd74fc1bc8fd921f604e1e279a67f58707725699b76c65325a37f5de529ab897d39f54b8b087db296be13660", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a67d58be2bbd620ea7be7174cf6087f6727f5c9e029101f6207d7fb964800706c5b7accdf460506223f32e34f97fc45ce464b601ec6bb3ae8fa8e30882c6d1d"} build_url:https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/ATApI5YyS1KWNOM0uiPpjQ/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/sha512/a5e5bb7bbef1740b6532e05af57c6e06fee85f0baf473770d63cecde81a3d601a18608c9f3feabe6c43e23bfe3746091100be105bd49690f8defebe6fd68c288", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1d718a277c7a6ea9186c3292c6330580b384447bd74fc1bc8fd921f604e1e279a67f58707725699b76c65325a37f5de529ab897d39f54b8b087db296be13660", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a67d58be2bbd620ea7be7174cf6087f6727f5c9e029101f6207d7fb964800706c5b7accdf460506223f32e34f97fc45ce464b601ec6bb3ae8fa8e30882c6d1d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 17:32:22.276528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:32:22.276833) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467762069.724692-1353066514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:32:22.358910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 17:32:22.359220) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 17:32:22.359483) ========= ========= Total master_lag: 0.15 =========