builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1468447518.84 results: success (0) buildid: 20160713141243 builduid: f3951c46a3fb48cab5dd879fd58ef295 revision: 0ec4b1228536dabe17e78060f4413fc91b162d58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:18.839723) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:18.840118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:18.840389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:18.855514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:18.855771) ========= 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=745a4373a2a16df560f216e000000264-1468447518.509313-1972003190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 15:05:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.0M=0s 2016-07-13 15:05:19 (36.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128103 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:18.997360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:18.997646) ========= 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=745a4373a2a16df560f216e000000264-1468447518.509313-1972003190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020179 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:19.046514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 15:05:19.046818) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ec4b1228536dabe17e78060f4413fc91b162d58 --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 0ec4b1228536dabe17e78060f4413fc91b162d58 --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=745a4373a2a16df560f216e000000264-1468447518.509313-1972003190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 15:05:19,503 truncating revision to first 12 chars 2016-07-13 15:05:19,503 Setting DEBUG logging. 2016-07-13 15:05:19,503 attempt 1/10 2016-07-13 15:05:19,503 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ec4b1228536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 15:05:20,902 unpacking tar archive at: fx-team-0ec4b1228536/testing/mozharness/ program finished with exit code 0 elapsedTime=1.775974 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 15:05:20.835907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:20.836688) ========= script_repo_revision: 0ec4b1228536dabe17e78060f4413fc91b162d58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:20.837082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:20.837348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:20.846796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-13 15:05:20.847450) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1468447518.509313-1972003190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:21 INFO - MultiFileLogger online at 20160713 15:05:21 in /builds/slave/test 15:05:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:05:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:21 INFO - {'append_to_log': False, 15:05:21 INFO - 'base_work_dir': '/builds/slave/test', 15:05:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:05:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:21 INFO - 'branch': 'Fx-Team-Non-PGO', 15:05:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:21 INFO - 'config_files': ('talos/linux_config.py',), 15:05:21 INFO - 'default_actions': ('clobber', 15:05:21 INFO - 'read-buildbot-config', 15:05:21 INFO - 'download-and-extract', 15:05:21 INFO - 'populate-webroot', 15:05:21 INFO - 'create-virtualenv', 15:05:21 INFO - 'install', 15:05:21 INFO - 'run-tests'), 15:05:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:21 INFO - 'download_minidump_stackwalk': True, 15:05:21 INFO - 'download_symbols': 'ondemand', 15:05:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:21 INFO - 'installer_path': 'installer.exe', 15:05:21 INFO - 'log_level': 'info', 15:05:21 INFO - 'log_name': 'talos', 15:05:21 INFO - 'log_to_console': True, 15:05:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:21 INFO - 'opt_config_files': (), 15:05:21 INFO - 'pip_index': False, 15:05:21 INFO - 'sps_profile': False, 15:05:21 INFO - 'sps_profile_interval': 0, 15:05:21 INFO - 'suite': 'dromaeojs', 15:05:21 INFO - 'system_bits': '32', 15:05:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:21 INFO - 'title': 'talos-linux64-ix-032', 15:05:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:21 INFO - 'use_talos_json': True, 15:05:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:21 INFO - 'work_dir': 'build'} 15:05:21 INFO - ##### 15:05:21 INFO - ##### Running clobber step. 15:05:21 INFO - ##### 15:05:21 INFO - Running pre-action listener: _resource_record_pre_action 15:05:21 INFO - Running main action method: clobber 15:05:21 INFO - rmtree: /builds/slave/test/build 15:05:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:22 INFO - Running post-action listener: _resource_record_post_action 15:05:22 INFO - ##### 15:05:22 INFO - ##### Finished clobber step (success) 15:05:22 INFO - ##### 15:05:22 INFO - ##### 15:05:22 INFO - ##### Running read-buildbot-config step. 15:05:22 INFO - ##### 15:05:22 INFO - Running pre-action listener: _resource_record_pre_action 15:05:22 INFO - Running main action method: read_buildbot_config 15:05:22 INFO - Using buildbot properties: 15:05:22 INFO - { 15:05:22 INFO - "project": "", 15:05:22 INFO - "product": "firefox", 15:05:22 INFO - "script_repo_revision": "production", 15:05:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:05:22 INFO - "repository": "", 15:05:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:05:22 INFO - "buildid": "20160713141243", 15:05:22 INFO - "pgo_build": "False", 15:05:22 INFO - "basedir": "/builds/slave/test", 15:05:22 INFO - "buildnumber": 3150, 15:05:22 INFO - "slavename": "talos-linux64-ix-032", 15:05:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:05:22 INFO - "platform": "ubuntu64_hw", 15:05:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:05:22 INFO - "branch": "fx-team", 15:05:22 INFO - "repo_path": "integration/fx-team", 15:05:22 INFO - "revision": "0ec4b1228536dabe17e78060f4413fc91b162d58", 15:05:22 INFO - "stage_platform": "linux64", 15:05:22 INFO - "builduid": "f3951c46a3fb48cab5dd879fd58ef295", 15:05:22 INFO - "slavebuilddir": "test" 15:05:22 INFO - } 15:05:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:05:22 INFO - Running post-action listener: _resource_record_post_action 15:05:22 INFO - ##### 15:05:22 INFO - ##### Finished read-buildbot-config step (success) 15:05:22 INFO - ##### 15:05:22 INFO - ##### 15:05:22 INFO - ##### Running download-and-extract step. 15:05:22 INFO - ##### 15:05:22 INFO - Running pre-action listener: _resource_record_pre_action 15:05:22 INFO - Running main action method: download_and_extract 15:05:22 INFO - mkdir: /builds/slave/test/build/tests 15:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:22 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:05:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:05:23 INFO - Downloaded 1361 bytes. 15:05:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:23 INFO - Using the following test package requirements: 15:05:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:05:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:05:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'jsshell-linux-x86_64.zip'], 15:05:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:05:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:05:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:05:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:05:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:05:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:23 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:05:24 INFO - Downloaded 22755452 bytes. 15:05:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:05:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:05:25 INFO - Return code: 0 15:05:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:05: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')]} 15:05:25 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:05:26 INFO - Downloaded 22755452 bytes. 15:05:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:05:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:05:28 INFO - Return code: 0 15:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:28 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:05:29 INFO - Downloaded 14403317 bytes. 15:05:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:05:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:05:29 INFO - Return code: 0 15:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:29 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:05:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:05:30 INFO - Downloaded 57039899 bytes. 15:05:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:30 INFO - mkdir: /builds/slave/test/properties 15:05:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:30 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:30 INFO - Contents: 15:05:30 INFO - build_url:https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:31 INFO - Running post-action listener: _resource_record_post_action 15:05:31 INFO - Running post-action listener: set_extra_try_arguments 15:05:31 INFO - ##### 15:05:31 INFO - ##### Finished download-and-extract step (success) 15:05:31 INFO - ##### 15:05:31 INFO - ##### 15:05:31 INFO - ##### Running populate-webroot step. 15:05:31 INFO - ##### 15:05:31 INFO - Running pre-action listener: _resource_record_pre_action 15:05:31 INFO - Running main action method: populate_webroot 15:05:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:05:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:05:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:05:31 INFO - '--tppagecycles', 15:05:31 INFO - '7'], 15:05:31 INFO - 'tests': ['tsvgm']}}, 15:05:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:05:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:05:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:05:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:05:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['damp', 'tps']}, 15:05:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'tests': ['damp', 'tps']}, 15:05:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['dromaeo_dom']}, 15:05:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['basic_compositor_video']}, 15:05:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:05:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other-e10s': {'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['tsvgx', 15:05:31 INFO - 'tsvgr_opacity', 15:05:31 INFO - 'tart', 15:05:31 INFO - 'tscrollx', 15:05:31 INFO - 'cart']}, 15:05:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:05:31 INFO - 'tsvgr_opacity', 15:05:31 INFO - 'tart', 15:05:31 INFO - 'tscrollx', 15:05:31 INFO - 'cart']}, 15:05:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--disable-e10s'], 15:05:31 INFO - 'tests': ['tp5o']}, 15:05:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'tests': ['tp5o']}, 15:05:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--disable-e10s', 15:05:31 INFO - '--xperf_path', 15:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:31 INFO - 'tests': ['tp5n']}, 15:05:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--xperf_path', 15:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:31 INFO - 'tests': ['tp5n']}}, 15:05:31 INFO - 'talos.zip': {'path': '', 15:05:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:05:31 INFO - Running post-action listener: _resource_record_post_action 15:05:31 INFO - ##### 15:05:31 INFO - ##### Finished populate-webroot step (success) 15:05:31 INFO - ##### 15:05:31 INFO - ##### 15:05:31 INFO - ##### Running create-virtualenv step. 15:05:31 INFO - ##### 15:05:31 INFO - Running pre-action listener: _resource_record_pre_action 15:05:31 INFO - Running main action method: create_virtualenv 15:05:31 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:05:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:05:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:31 INFO - Using real prefix '/usr' 15:05:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:32 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:34 INFO - Installing pip.................done. 15:05:34 INFO - Return code: 0 15:05:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:34 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 0x2824030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, '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': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:05:34 INFO - Using env: {'DISPLAY': ':0', 15:05:34 INFO - 'HOME': '/home/cltbld', 15:05:34 INFO - 'LANG': 'en_US.UTF-8', 15:05:34 INFO - 'LANGUAGE': 'en_US:en', 15:05:34 INFO - 'LOGNAME': 'cltbld', 15:05:34 INFO - 'MAIL': '/var/mail/cltbld', 15:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:34 INFO - 'MOZ_NO_REMOTE': '1', 15:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:34 INFO - 'NO_EM_RESTART': '1', 15:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:34 INFO - 'PWD': '/builds/slave/test', 15:05:34 INFO - 'SHELL': '/bin/bash', 15:05:34 INFO - 'SHLVL': '1', 15:05:34 INFO - 'TERM': 'linux', 15:05:34 INFO - 'TMOUT': '86400', 15:05:34 INFO - 'USER': 'cltbld', 15:05:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:34 INFO - '_': '/tools/buildbot/bin/python'} 15:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:05:34 INFO - Cleaning up... 15:05:34 INFO - Return code: 0 15:05:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:34 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 0x2824030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, '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': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:05:34 INFO - Using env: {'DISPLAY': ':0', 15:05:34 INFO - 'HOME': '/home/cltbld', 15:05:34 INFO - 'LANG': 'en_US.UTF-8', 15:05:34 INFO - 'LANGUAGE': 'en_US:en', 15:05:34 INFO - 'LOGNAME': 'cltbld', 15:05:34 INFO - 'MAIL': '/var/mail/cltbld', 15:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:34 INFO - 'MOZ_NO_REMOTE': '1', 15:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:34 INFO - 'NO_EM_RESTART': '1', 15:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:34 INFO - 'PWD': '/builds/slave/test', 15:05:34 INFO - 'SHELL': '/bin/bash', 15:05:34 INFO - 'SHLVL': '1', 15:05:34 INFO - 'TERM': 'linux', 15:05:34 INFO - 'TMOUT': '86400', 15:05:34 INFO - 'USER': 'cltbld', 15:05:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:34 INFO - '_': '/tools/buildbot/bin/python'} 15:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:34 INFO - Downloading/unpacking psutil>=3.1.1 15:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:36 INFO - Installing collected packages: psutil 15:05:36 INFO - Running setup.py install for psutil 15:05:36 INFO - building 'psutil._psutil_linux' extension 15:05:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:05:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:05:36 INFO - building 'psutil._psutil_posix' extension 15:05:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:05:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:05:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:37 INFO - Successfully installed psutil 15:05:37 INFO - Cleaning up... 15:05:37 INFO - Return code: 0 15:05:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:37 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 0x2824030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, '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': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:05:37 INFO - Using env: {'DISPLAY': ':0', 15:05:37 INFO - 'HOME': '/home/cltbld', 15:05:37 INFO - 'LANG': 'en_US.UTF-8', 15:05:37 INFO - 'LANGUAGE': 'en_US:en', 15:05:37 INFO - 'LOGNAME': 'cltbld', 15:05:37 INFO - 'MAIL': '/var/mail/cltbld', 15:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:37 INFO - 'MOZ_NO_REMOTE': '1', 15:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:37 INFO - 'NO_EM_RESTART': '1', 15:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:37 INFO - 'PWD': '/builds/slave/test', 15:05:37 INFO - 'SHELL': '/bin/bash', 15:05:37 INFO - 'SHLVL': '1', 15:05:37 INFO - 'TERM': 'linux', 15:05:37 INFO - 'TMOUT': '86400', 15:05:37 INFO - 'USER': 'cltbld', 15:05:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:37 INFO - '_': '/tools/buildbot/bin/python'} 15:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:05:39 INFO - Installing collected packages: mozsystemmonitor 15:05:39 INFO - Running setup.py install for mozsystemmonitor 15:05:39 INFO - Successfully installed mozsystemmonitor 15:05:39 INFO - Cleaning up... 15:05:39 INFO - Return code: 0 15:05:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2824030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, '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': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:05:39 INFO - Using env: {'DISPLAY': ':0', 15:05:39 INFO - 'HOME': '/home/cltbld', 15:05:39 INFO - 'LANG': 'en_US.UTF-8', 15:05:39 INFO - 'LANGUAGE': 'en_US:en', 15:05:39 INFO - 'LOGNAME': 'cltbld', 15:05:39 INFO - 'MAIL': '/var/mail/cltbld', 15:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:39 INFO - 'MOZ_NO_REMOTE': '1', 15:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:39 INFO - 'NO_EM_RESTART': '1', 15:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:39 INFO - 'PWD': '/builds/slave/test', 15:05:39 INFO - 'SHELL': '/bin/bash', 15:05:39 INFO - 'SHLVL': '1', 15:05:39 INFO - 'TERM': 'linux', 15:05:39 INFO - 'TMOUT': '86400', 15:05:39 INFO - 'USER': 'cltbld', 15:05:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:39 INFO - '_': '/tools/buildbot/bin/python'} 15:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:39 INFO - Downloading/unpacking jsonschema==2.5.1 15:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:05:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:05:41 INFO - warning: no files found matching '*.txt' 15:05:41 INFO - no previously-included directories found matching 'build' 15:05:41 INFO - no previously-included directories found matching 'dist' 15:05:41 INFO - no previously-included directories found matching '.git*' 15:05:41 INFO - Installing collected packages: jsonschema, functools32 15:05:41 INFO - Running setup.py install for functools32 15:05:41 INFO - warning: no files found matching '*.txt' 15:05:41 INFO - no previously-included directories found matching 'build' 15:05:41 INFO - no previously-included directories found matching 'dist' 15:05:41 INFO - no previously-included directories found matching '.git*' 15:05:41 INFO - Successfully installed jsonschema functools32 15:05:41 INFO - Cleaning up... 15:05:42 INFO - Return code: 0 15:05:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:42 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 0x2824030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, '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': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:05:42 INFO - Using env: {'DISPLAY': ':0', 15:05:42 INFO - 'HOME': '/home/cltbld', 15:05:42 INFO - 'LANG': 'en_US.UTF-8', 15:05:42 INFO - 'LANGUAGE': 'en_US:en', 15:05:42 INFO - 'LOGNAME': 'cltbld', 15:05:42 INFO - 'MAIL': '/var/mail/cltbld', 15:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:42 INFO - 'MOZ_NO_REMOTE': '1', 15:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:42 INFO - 'NO_EM_RESTART': '1', 15:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:42 INFO - 'PWD': '/builds/slave/test', 15:05:42 INFO - 'SHELL': '/bin/bash', 15:05:42 INFO - 'SHLVL': '1', 15:05:42 INFO - 'TERM': 'linux', 15:05:42 INFO - 'TMOUT': '86400', 15:05:42 INFO - 'USER': 'cltbld', 15:05:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:42 INFO - '_': '/tools/buildbot/bin/python'} 15:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:05:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:05:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:44 INFO - Downloading docopt-0.6.1.tar.gz 15:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:05:44 INFO - Installing collected packages: blobuploader, requests, docopt 15:05:44 INFO - Running setup.py install for blobuploader 15:05:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:05:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:05:45 INFO - Running setup.py install for requests 15:05:45 INFO - Running setup.py install for docopt 15:05:45 INFO - Successfully installed blobuploader requests docopt 15:05:45 INFO - Cleaning up... 15:05:45 INFO - Return code: 0 15:05:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:45 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 0x2824030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, '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': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:45 INFO - Using env: {'DISPLAY': ':0', 15:05:45 INFO - 'HOME': '/home/cltbld', 15:05:45 INFO - 'LANG': 'en_US.UTF-8', 15:05:45 INFO - 'LANGUAGE': 'en_US:en', 15:05:45 INFO - 'LOGNAME': 'cltbld', 15:05:45 INFO - 'MAIL': '/var/mail/cltbld', 15:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:45 INFO - 'MOZ_NO_REMOTE': '1', 15:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:45 INFO - 'NO_EM_RESTART': '1', 15:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:45 INFO - 'PWD': '/builds/slave/test', 15:05:45 INFO - 'SHELL': '/bin/bash', 15:05:45 INFO - 'SHLVL': '1', 15:05:45 INFO - 'TERM': 'linux', 15:05:45 INFO - 'TMOUT': '86400', 15:05:45 INFO - 'USER': 'cltbld', 15:05:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:45 INFO - '_': '/tools/buildbot/bin/python'} 15:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:45 INFO - Running setup.py (path:/tmp/pip-8PEsbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:45 INFO - Running setup.py (path:/tmp/pip-D2Y7AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:46 INFO - Running setup.py (path:/tmp/pip-htN5u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:46 INFO - Running setup.py (path:/tmp/pip-A8cIlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:46 INFO - Running setup.py (path:/tmp/pip-hF06_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:46 INFO - Running setup.py (path:/tmp/pip-0yANHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:46 INFO - Running setup.py (path:/tmp/pip-NUULnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:46 INFO - Running setup.py (path:/tmp/pip-SwHwYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:46 INFO - Running setup.py (path:/tmp/pip-z4JS6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:46 INFO - Running setup.py (path:/tmp/pip-SEKlZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:46 INFO - Running setup.py (path:/tmp/pip-azWyvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:46 INFO - Running setup.py (path:/tmp/pip-LHHZzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:46 INFO - Running setup.py (path:/tmp/pip-tCBm47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:46 INFO - Running setup.py (path:/tmp/pip-ymhNTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:46 INFO - Running setup.py (path:/tmp/pip-XKTRDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:46 INFO - Running setup.py (path:/tmp/pip-1pNEN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:47 INFO - Running setup.py (path:/tmp/pip-dS9CgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:05:47 INFO - Running setup.py install for manifestparser 15:05:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Running setup.py install for mozcrash 15:05:47 INFO - Running setup.py install for mozdebug 15:05:47 INFO - Running setup.py install for mozdevice 15:05:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Running setup.py install for mozfile 15:05:47 INFO - Running setup.py install for mozhttpd 15:05:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Running setup.py install for mozinfo 15:05:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Running setup.py install for mozInstall 15:05:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Running setup.py install for mozleak 15:05:47 INFO - Running setup.py install for mozlog 15:05:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:05:48 INFO - Running setup.py install for moznetwork 15:05:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:05:48 INFO - Running setup.py install for mozprocess 15:05:48 INFO - Running setup.py install for mozprofile 15:05:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:05:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:05:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:05:48 INFO - Running setup.py install for mozrunner 15:05:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:05:48 INFO - Running setup.py install for mozscreenshot 15:05:48 INFO - Running setup.py install for moztest 15:05:48 INFO - Running setup.py install for mozversion 15:05:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:05:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:05:48 INFO - Cleaning up... 15:05:48 INFO - Return code: 0 15:05:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:48 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 0x2824030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, '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': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:48 INFO - Using env: {'DISPLAY': ':0', 15:05:48 INFO - 'HOME': '/home/cltbld', 15:05:48 INFO - 'LANG': 'en_US.UTF-8', 15:05:48 INFO - 'LANGUAGE': 'en_US:en', 15:05:48 INFO - 'LOGNAME': 'cltbld', 15:05:48 INFO - 'MAIL': '/var/mail/cltbld', 15:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:48 INFO - 'MOZ_NO_REMOTE': '1', 15:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:48 INFO - 'NO_EM_RESTART': '1', 15:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:48 INFO - 'PWD': '/builds/slave/test', 15:05:48 INFO - 'SHELL': '/bin/bash', 15:05:48 INFO - 'SHLVL': '1', 15:05:48 INFO - 'TERM': 'linux', 15:05:48 INFO - 'TMOUT': '86400', 15:05:48 INFO - 'USER': 'cltbld', 15:05:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:48 INFO - '_': '/tools/buildbot/bin/python'} 15:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:49 INFO - Running setup.py (path:/tmp/pip-z0BPbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:49 INFO - Running setup.py (path:/tmp/pip-8mQnPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:49 INFO - Running setup.py (path:/tmp/pip-nvfUbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:49 INFO - Running setup.py (path:/tmp/pip-LbHARU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:49 INFO - Running setup.py (path:/tmp/pip-PlsmBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:49 INFO - Running setup.py (path:/tmp/pip-sQSdA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:49 INFO - Running setup.py (path:/tmp/pip-bNvt4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:49 INFO - Running setup.py (path:/tmp/pip-JeISFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:49 INFO - Running setup.py (path:/tmp/pip-iLj2Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:49 INFO - Running setup.py (path:/tmp/pip-7ioegg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:49 INFO - Running setup.py (path:/tmp/pip-TwKfCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:49 INFO - Running setup.py (path:/tmp/pip-Hz85P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:50 INFO - Running setup.py (path:/tmp/pip-_bDlAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:50 INFO - Running setup.py (path:/tmp/pip-sHDvXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:50 INFO - Running setup.py (path:/tmp/pip-iJ3CjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:50 INFO - Running setup.py (path:/tmp/pip-ajPDYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:50 INFO - Running setup.py (path:/tmp/pip-QZo8WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:52 INFO - Downloading blessings-1.6.tar.gz 15:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:05:52 INFO - Installing collected packages: blessings 15:05:52 INFO - Running setup.py install for blessings 15:05:52 INFO - Successfully installed blessings 15:05:52 INFO - Cleaning up... 15:05:52 INFO - Return code: 0 15:05:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:05:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:52 INFO - Reading from file tmpfile_stdout 15:05:52 INFO - Current package versions: 15:05:52 INFO - argparse == 1.2.1 15:05:52 INFO - blessings == 1.6 15:05:52 INFO - blobuploader == 1.2.4 15:05:52 INFO - docopt == 0.6.1 15:05:52 INFO - functools32 == 3.2.3-2 15:05:52 INFO - jsonschema == 2.5.1 15:05:52 INFO - manifestparser == 1.1 15:05:52 INFO - mozInstall == 1.12 15:05:52 INFO - mozcrash == 0.17 15:05:52 INFO - mozdebug == 0.1 15:05:52 INFO - mozdevice == 0.48 15:05:52 INFO - mozfile == 1.2 15:05:52 INFO - mozhttpd == 0.7 15:05:52 INFO - mozinfo == 0.9 15:05:52 INFO - mozleak == 0.1 15:05:52 INFO - mozlog == 3.2 15:05:52 INFO - moznetwork == 0.27 15:05:52 INFO - mozprocess == 0.23 15:05:52 INFO - mozprofile == 0.28 15:05:52 INFO - mozrunner == 6.12 15:05:52 INFO - mozscreenshot == 0.1 15:05:52 INFO - mozsystemmonitor == 0.3 15:05:52 INFO - moztest == 0.7 15:05:52 INFO - mozversion == 1.4 15:05:52 INFO - psutil == 3.1.1 15:05:52 INFO - requests == 1.2.3 15:05:52 INFO - wsgiref == 0.1.2 15:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:52 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 0x2824030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, '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': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:52 INFO - Using env: {'DISPLAY': ':0', 15:05:52 INFO - 'HOME': '/home/cltbld', 15:05:52 INFO - 'LANG': 'en_US.UTF-8', 15:05:52 INFO - 'LANGUAGE': 'en_US:en', 15:05:52 INFO - 'LOGNAME': 'cltbld', 15:05:52 INFO - 'MAIL': '/var/mail/cltbld', 15:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:52 INFO - 'MOZ_NO_REMOTE': '1', 15:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:52 INFO - 'NO_EM_RESTART': '1', 15:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:52 INFO - 'PWD': '/builds/slave/test', 15:05:52 INFO - 'SHELL': '/bin/bash', 15:05:52 INFO - 'SHLVL': '1', 15:05:52 INFO - 'TERM': 'linux', 15:05:52 INFO - 'TMOUT': '86400', 15:05:52 INFO - 'USER': 'cltbld', 15:05:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:52 INFO - '_': '/tools/buildbot/bin/python'} 15:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:05:52 INFO - Cleaning up... 15:05:52 INFO - Return code: 0 15:05:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:52 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 0x2824030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, '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': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:05:52 INFO - Using env: {'DISPLAY': ':0', 15:05:52 INFO - 'HOME': '/home/cltbld', 15:05:52 INFO - 'LANG': 'en_US.UTF-8', 15:05:52 INFO - 'LANGUAGE': 'en_US:en', 15:05:52 INFO - 'LOGNAME': 'cltbld', 15:05:52 INFO - 'MAIL': '/var/mail/cltbld', 15:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:52 INFO - 'MOZ_NO_REMOTE': '1', 15:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:52 INFO - 'NO_EM_RESTART': '1', 15:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:52 INFO - 'PWD': '/builds/slave/test', 15:05:52 INFO - 'SHELL': '/bin/bash', 15:05:52 INFO - 'SHLVL': '1', 15:05:52 INFO - 'TERM': 'linux', 15:05:52 INFO - 'TMOUT': '86400', 15:05:52 INFO - 'USER': 'cltbld', 15:05:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:52 INFO - '_': '/tools/buildbot/bin/python'} 15:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:05:53 INFO - Cleaning up... 15:05:53 INFO - Return code: 0 15:05:53 INFO - Running post-action listener: _resource_record_post_action 15:05:53 INFO - Running post-action listener: _start_resource_monitoring 15:05:53 INFO - Starting resource monitoring. 15:05:53 INFO - ##### 15:05:53 INFO - ##### Finished create-virtualenv step (success) 15:05:53 INFO - ##### 15:05:53 INFO - ##### 15:05:53 INFO - ##### Running install step. 15:05:53 INFO - ##### 15:05:53 INFO - Running pre-action listener: _resource_record_pre_action 15:05:53 INFO - Running main action method: install 15:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:53 INFO - Reading from file tmpfile_stdout 15:05:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:05:53 INFO - Reading from file tmpfile_stdout 15:05:53 INFO - Output received: 15:05:53 INFO - Usage: mozinstall [options] installer 15:05:53 INFO - Options: 15:05:53 INFO - -h, --help show this help message and exit 15:05:53 INFO - -d DEST, --destination=DEST 15:05:53 INFO - Directory to install application into. [default: 15:05:53 INFO - "/builds/slave/test"] 15:05:53 INFO - --app=APP Application being installed. [default: firefox] 15:05:53 INFO - mkdir: /builds/slave/test/build/application 15:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:06:09 INFO - Reading from file tmpfile_stdout 15:06:09 INFO - Output received: 15:06:09 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:09 INFO - Running post-action listener: _resource_record_post_action 15:06:09 INFO - ##### 15:06:09 INFO - ##### Finished install step (success) 15:06:09 INFO - ##### 15:06:09 INFO - ##### 15:06:09 INFO - ##### Running run-tests step. 15:06:09 INFO - ##### 15:06:09 INFO - Running pre-action listener: _resource_record_pre_action 15:06:09 INFO - Running main action method: run_tests 15:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:09 INFO - Python 2.7.3 15:06:09 INFO - Return code: 0 15:06:09 INFO - grabbing minidump binary from tooltool 15:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:09 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 0x2ae33b0>, '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 0x2ae42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:06:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:06:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:06:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:09 INFO - Return code: 0 15:06:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:06:09 INFO - Using env: {'DISPLAY': ':0', 15:06:09 INFO - 'HOME': '/home/cltbld', 15:06:09 INFO - 'LANG': 'en_US.UTF-8', 15:06:09 INFO - 'LANGUAGE': 'en_US:en', 15:06:09 INFO - 'LOGNAME': 'cltbld', 15:06:09 INFO - 'MAIL': '/var/mail/cltbld', 15:06:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:09 INFO - 'MOZ_NO_REMOTE': '1', 15:06:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:09 INFO - 'NO_EM_RESTART': '1', 15:06:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:09 INFO - 'PWD': '/builds/slave/test', 15:06:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:09 INFO - 'SHELL': '/bin/bash', 15:06:09 INFO - 'SHLVL': '1', 15:06:09 INFO - 'TERM': 'linux', 15:06:09 INFO - 'TMOUT': '86400', 15:06:09 INFO - 'USER': 'cltbld', 15:06:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468447518.509313-1972003190', 15:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:09 INFO - '_': '/tools/buildbot/bin/python'} 15:06:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:06:10 INFO - mozversion application_buildid: 20160713141243 15:06:10 INFO - mozversion application_changeset: 0ec4b1228536dabe17e78060f4413fc91b162d58 15:06:10 INFO - mozversion application_display_name: Nightly 15:06:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:10 INFO - mozversion application_name: Firefox 15:06:10 INFO - mozversion application_remotingname: firefox 15:06:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:06:10 INFO - mozversion application_vendor: Mozilla 15:06:10 INFO - mozversion application_version: 50.0a1 15:06:10 INFO - mozversion platform_buildid: 20160713141243 15:06:10 INFO - mozversion platform_changeset: 0ec4b1228536dabe17e78060f4413fc91b162d58 15:06:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:06:10 INFO - mozversion platform_version: 50.0a1 15:06:10 INFO - using testdate: 1468447570 15:06:10 INFO - actual date: 1468447570 15:06:10 INFO - starting webserver on 'localhost:49687' 15:06:10 INFO - SUITE-START | Running 2 tests 15:06:10 INFO - TEST-START | dromaeo_css 15:06:10 INFO - operating with platform_type : linux_ 15:06:10 INFO - Initialising browser for dromaeo_css test... 15:06:10 INFO - TEST-INFO | started process 20501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJJ6j61/profile http://localhost:49687/getInfo.html) 15:06:15 INFO - PROCESS | 20501 | __metrics Screen width/height:1600/1200 15:06:15 INFO - PROCESS | 20501 | colorDepth:24 15:06:15 INFO - PROCESS | 20501 | Browser inner width/height: 1024/697 15:06:15 INFO - PROCESS | 20501 | __metrics 15:06:16 INFO - PROCESS | 20501 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:06:16 INFO - PROCESS | 20501 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:06:17 INFO - TEST-INFO | 20501: exit 0 15:06:17 INFO - Browser initialized. 15:06:17 INFO - Running cycle 1/1 for dromaeo_css test... 15:06:17 INFO - TEST-INFO | started process 20582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJJ6j61/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:29 INFO - PROCESS | 20582 | RSS: Main: 159027200 15:06:29 INFO - PROCESS | 20582 | 15:07:21 INFO - PROCESS | 20582 | 1468447641155 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:09:32 INFO - PROCESS | 20582 | Cycle 1(1): loaded http://localhost:49687/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49687/tests/dromaeo/cssquery-ext.html) 15:09:33 INFO - PROCESS | 20582 | RSS: Main: 270647296 15:09:33 INFO - PROCESS | 20582 | 15:12:36 INFO - PROCESS | 20582 | Cycle 1(1): loaded http://localhost:49687/tests/dromaeo/cssquery-ext.html (next: http://localhost:49687/tests/dromaeo/cssquery-jquery.html) 15:12:36 INFO - PROCESS | 20582 | RSS: Main: 246083584 15:12:36 INFO - PROCESS | 20582 | 15:15:39 INFO - PROCESS | 20582 | Cycle 1(1): loaded http://localhost:49687/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49687/tests/dromaeo/cssquery-mootools.html) 15:15:39 INFO - PROCESS | 20582 | RSS: Main: 247181312 15:15:39 INFO - PROCESS | 20582 | 15:18:42 INFO - PROCESS | 20582 | Cycle 1(1): loaded http://localhost:49687/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49687/tests/dromaeo/cssquery-prototype.html) 15:18:42 INFO - PROCESS | 20582 | RSS: Main: 246083584 15:18:42 INFO - PROCESS | 20582 | 15:21:45 INFO - PROCESS | 20582 | Cycle 1(1): loaded http://localhost:49687/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49687/tests/dromaeo/cssquery-yui.html) 15:21:46 INFO - PROCESS | 20582 | RSS: Main: 228548608 15:21:46 INFO - PROCESS | 20582 | 15:24:49 INFO - PROCESS | 20582 | Cycle 1(1): loaded http://localhost:49687/tests/dromaeo/cssquery-yui.html (next: http://localhost:49687/tests/dromaeo/cssquery-dojo.html) 15:24:49 INFO - PROCESS | 20582 | RSS: Main: 283906048 15:24:49 INFO - PROCESS | 20582 | 15:24:49 INFO - PROCESS | 20582 | __start_tp_report 15:24:49 INFO - PROCESS | 20582 | _x_x_mozilla_page_load 15:24:49 INFO - PROCESS | 20582 | _x_x_mozilla_page_load_details 15:24:49 INFO - PROCESS | 20582 | |i|pagename|runs| 15:24:49 INFO - PROCESS | 20582 | |0;dojo.html;2603.518349105415;2612.6211699303612;2645.1932160690994;2656.8937242510287;2658.4683063387315;4557.47589027262;4644.953550464495;4675.111728771531;4699.130660827749;4713.316569097479;4631.374764406804;4660.324252983315;4680.882977925554;4697.6241900647865;4709.2229782086;4262.339337402707;4278.4438023056955;4281.207976524337;4323.82704691812;4411.977940110295;4285.335772955182;4355.825766969318;4376;4425;4434.467863856342;4190.036291652907;4344.869653910388;4360.21516127097;4383.846565370197;4391.0559229765595;4223.260929337384;4233.491980962273;4243.681723870691;4271.487421509439;4272.380504826782;4278.743275403485;4327.0480494291205;4338.132373525276;4339.674524410681;4386.407834942273;4451.154280686659;4724.149653062447;4747.952520474785;4760.285957106427;4777.904441911177;4893.388326459192;4996.325496058022;5018.7490625468945;5055.292259083732;5110.795568177268;5035.546800787946;5098.6685865419;5103.387593488768;5123.1546794778815;5134.332536770234;4549.863504094882;4680.765961701902;4747.121782470254;4753.049390121955;4804.5195480451675;5109.080365534165;5125.615578831603;5132.230165475134;5194.3247377840635;5201.869953251199;4963.801447942042;4964.05682920244;4966.6771659842;5007.098722230034;5015.82444614444;4808.951910480921;4933.975330123327;4988.800447982113;5043.067032598981;5095.821646242363;4945.752712364368;4964.553190212826;4978.726170060609;4987.0524600325825;5011.724355160428;4949.1091603510995;4950.133726597831;4953.678010929278;4957.3307603473795;4992.450830408652;3979.8010099495486;4008.899777505586;4149.896252593649;4183.707140500136;4238.597333253336;3676.3750162472443;3684.060564556021;3685.9078523037138;3726.571444283888;3743.5133432654125;4318.892027699269;4326.805293761725;4328.480582330078;4360.389545463638;4368.584984426474;4936.111499929975;4985.277134815431;5001.074801161797;5019.874503137377;5075.441701412841;4333.068390296102;4340.175366680321;4341.739495630272;4361.411209486742;4376.40918476008;4506.504284528699;4509.233430316854;4514;4516.435445569304;4561.201789686792;4536.591706746277;4723.362346083372;4729.69256998294;4773.069251496064;4780.630581301576;5044.798208071636;5047.87380315495;5061.063703214917;5073.670211436245;5122.231665250242;4772.117158325582;4781.808727650994;4792.281157826354;4794.161021821237;4842.491538388418;4757.45289291722;4862.294967229661;4900.093482705711;4902.534259245366;4949.752512374295;4977.228529577921;5011.348524691767;5011.473795251446;5016.623753218596;5044.243363495505;4872.512748725099;4879.438864530624;4896.461389247252;4898.387701537308;4918.188498897642;4731.834385796481;4855.417349918032;4858.732769697701;4924.7537623119415;4953.603711703127;4835.854924352275;4868.926966095441;4876.317315575751;4912.484189160086;4915.754212289443;4709.152352576432;4972.825951091694;4979.701217926936;4984.6261530384645;5012.8496145115705;4669.066186762593;4709.976450117728;4751.881202969954;4767.499412561631;4788.688735232199 15:24:49 INFO - PROCESS | 20582 | |1;ext.html;566.7449647658553;566.8016194331982;575.1459083261353;578.5313895744447;584.2463222443049;28308.292292692666;40401.19197616046;41722.58277417221;41936.79031604846;44916.10167796642;41517;41528.377074343836;41819.372709409385;41848.790756046255;41916.79041604788;8019.879701804478;8164.550949697764;8168.183181681844;8171.550564718938;8172.264496195341;8008.879866802003;8112.513249205037;8115.675372985073;8116.35069194463;8117.22886325801;8105.554194519299;8122.959385203066;8156.673733050671;8162.755117346489;8175.918240817575;8085.878711819328;8140.267375936194;8140.837183256302;8151.06262779779;8151.388645851525;8013.398995075393;8070;8089.838203235902;8090.919090809134;8101.9189808101755;39924.201515969515;40155.19689606221;40170.59829401698;40314.59685403167;40393.798031009654;3075.8923437679796;3107.984460077708;3188.234823642309;3416.1630400551776;3763.9059023524355;30463.23841903948;30814;30820.848783688518;30968;31885;3001.9399612007855;3010.4280186764445;3016.291171574678;3017.4870272053804;3055.6944305569486;183762;184388;184510;184608;184827.07586462115;32567.348653027282;33799.493007604906;33825.492617610755;35722.28555428877;56213.718931405085;34761.65238347635;34809.12977175591;34877.476837847455;34934.30131397358;34968.475472867925;12497.437615307334;12524.937375313066;12546.686332841751;12552.686182845502;12557.56048538315;11029.558817647205;11098.61154859576;11099.38953357557;11123.221374503868;11140.832887506695;7996.560189189534;8027.317677997319;8046.396520261003;8086.878696819553;8111.067227268822;3104.286014216743;3123.640781310178;3146.9055928322186;3156.779025468195;3158.952615710766;818.5211651184125;881.3918396306656;884.8145081648319;885.0529932971787;988.9357191782511;27755;27875.721242787313;28461.57307640387;28579.428411431654;28668.426631467253;951.7192428233687;964.0696727657844;974.9610015599296;1003.4581326083833;1006.5571148694551;14898.553043408716;15019.474318399021;15098.698026039418;15195.92402038005;15350.769738453931;384914;388433;390827;391499;391572;33333;33829;33894;33984.32031359359;34051.65948340485;1206.4993027893502;1209.4497003863396;1209.6854817747449;1210.4734440518228;1219.676785651803;25981.870090649427;27660.58509122405;27696.446071078062;28117.133956386293;28423;45000.32499512444;45487.31769023401;45542.77228613836;45550.77224613856;45581.77209113933;317068;318242;318496;320088;320102;25991.22026339213;26091.739082608932;26260.212193634223;26347;26358.73641263563;42889.793409120735;43947.78026109849;44007.97408422626;44208.11583768371;44639.55360446354;37204.62795372012;37704.81147594354;38019;38037;38307.61692383041;36818.263634726616;37006.074848129014;37161.070973225884;37994.43008354821;38345;26743.598846017714;36132;36797;37015.81492092522;38914;32302.35395292034;33554.83222583871;33839.32321353608;34148.487772683926;34187.65812341845;23398;23711.644325335477;24180.39549011289;24311.635325470485;24414.26757197287 15:24:49 INFO - PROCESS | 20582 | |2;jquery.html;342.3485107839781;372.4246039868403;375.34876988425077;375.5193352508789;379.1128758704631;13189.8021529677;16825.49523514295;16878.156092195386;17654.293828246886;18831.905840470812;16989.745153822703;17470.650586988253;17538;17583.560410989732;17592;5107.259447380127;5148;5241;5270.578353731711;5294.602904782138;3711.2763011212824;4861.222204447289;5198.428172900978;5847.181394604759;6129.080637904305;6211.068339749028;6213.316535181127;6232.283287421959;6235.095911092889;6248.875022499547;5977.342492325841;6309.905351419732;6314.336994615545;6317;6318.178636777189;3445.4659527773233;3611.368010598135;3612.223371975038;5528.06022976095;5528.198411230389;18793.812061879344;20128.194872205095;20705.0682719278;22163.22428714987;22200.777992220195;1854.88870667759;1883.359657716383;1906.1327096171208;2176.7605563388174;2302.067662596651;13599.184048956995;13716.588502344946;13749.518766843112;13923.443062277496;13936;1745.7119575270065;1838.8804727692657;1839.0528877628033;1855.6288742251468;1863.7111247756484;68391;71832.28167718361;72193.27806721919;72877;73801.6309918447;8809.823803523894;9372.203362714246;9387.859182112274;9513.476758778195;10167.847482287772;11549.769004620028;12393.814092788616;12408.503659853504;12966.80549791754;13003.284819335027;7097.396721278749;7107.182673992454;7387.630618469163;7437.776866694008;7569.697212111454;7166.355028047501;7271.727447696632;7283.526570772883;7314.687663627172;7393.149787774475;4344;4413.051193993243;4505.625784135805;4516.187086324428;4556.453225612881;1774.2725482552091;1825.000123846367;1828.7348334491423;1833.3689022120577;1844.2530775036132;778.4473024152915;874.2306770042322;883.8895138107737;891.6923661336829;911.8996910339857;16375.59061023484;17073.914630427018;17205.397811076804;17310;17493.212805423787;835.5947365527715;849.6473963305159;852.6163226548078;862.9137086291321;863.6027427383349;9602.135807777333;9618.903810961801;9948;9960.103590676728;10084.445355505517;381237;408775;410555;410908;415450;83085.58457207796;94506.52746736222;94912;95016.52491737498;95369;862.0517430826042;881.3654168998439;903.575319599787;904.4799240436776;911.2345629671108;16064;16304.755428668343;16442.260098295366;17019.744703829205;17049.82950170532;39230.21539569135;39576;40299.59700402959;40496;40922;57024.71487642535;57813.71093144507;58100.70949645225;58133.70933145307;59755.402445974985;7291.8541629168185;7365.116186057708;7374.963125184339;7569.697212111674;7599.962000189964;10880.619178328721;11209.327440353278;11241.943790280997;11532.538698451968;11583.710407239887;9268.212201962908;9901.455419951972;10095.54570044335;10136.594536218468;10287.742806429898;9852.408855468408;9861.95069024679;9989.750256243362;10045.196384289386;10206.846897296398;9913.603455861974;10151.7462063449;10219;10271.84592231132;10420.791584168122;7349.77950661481;7372.741954031583;7435.776926692208;7453.291937265951;7521.736739214101;9748;10036.648717295151;10175.38947663113;10236.232282578687;10249.538770755484 15:24:49 INFO - PROCESS | 20582 | |3;mootools.html;1268.5433244032154;1322.4379638653572;1384.736899989002;1447.536788227767;1750.544858336832;6693.464522838173;7842.451028428012;8164.550949697764;8166.6325015374305;8170.714025009126;7906.051273847132;8037.598120094001;8048.114707382183;8050;8051.91948080519;2217.168561789333;2247;2248.853824501402;2249.167807911075;2249.5613355395703;2155.8059774620283;2189.343197040889;2227.487677834099;2232.9218477353297;2235.3852690510157;2181.901814418347;2188.3325585696357;2188.616992026397;2189.1134090693295;2240.025588868847;2130.499332656824;2134;2134.775848535897;2141.603803296395;2141.732283464567;2087.8016588424075;2130.8295336373208;2131.712218850451;2134.882581458019;2136.6688163334707;7881.724139655142;7987.161348058428;8074.232947869943;8080.636371363244;8148.796280092985;4429.955700443019;4507.143642707908;4507.346434766973;4509.075639493896;4520.886977825548;2588.5987671910884;2672.398710290189;2705.9323516912036;2714.9185524434297;2716.4974479721313;858.5449711652834;867.223834667975;869.1786261982429;1539.4073281786482;1597.4169428158755;11095.278806877608;11223.607173748962;11226.21416500837;11238.494267757971;11242.831357529562;3985.6412922836503;4037.7173597848455;4170.541240463546;4174.039970806732;4176.749395036308;8732.039475657673;8765.035846056928;8768.07935166811;8776.210141087206;8780.253678437277;4613.538646135359;4620.052889157714;4620.422447194101;4621.237495813153;4622.375979242826;3598.712103031751;3922.1371298314325;4080.81636326366;4237.555056719062;4266.445362102907;3492.214251793377;3539.610642829287;3583.283343331344;3585.515955346047;3684.521012268388;1050.2648146297622;1099.923005389631;1100.6697990602947;1102.1568500097433;1112.821948488238;747.0251322024701;808.9676412943417;822.4407402966041;839.1943734015414;849.9532525711022;5348.090824559834;5357.732113394392;5477.1510415885605;5561.888762224814;5661.46216109469;892.6027917576746;899.4288626722079;901.1439132823843;921.6221349246777;933.5239028095721;3481.0949153220345;3543.627919068461;3634.83643236055;3656.2504686539196;3682.779033258013;9891.604335826487;10127.797444051077;10150;10264.743381415376;10295.691129266133;10117.583538304643;10131.898681013095;10134.54394552247;10151.1371533419;10157.18742500613;7491.737789177353;7513.4740568159705;7681.270279323456;7751.1861254568585;7757.4181936355;5295.232191332312;5311.68129912191;5318.494742999409;5329.1206950852675;5454.8363549092;9325.953370233377;9368.110029547182;9433.151016408556;9442.10300021497;9478.099580539838;8704.825903481767;9104.772380690536;9143.497107659143;9152.771180720269;9423.952880235554;6646.966765166143;6865.622390768356;6870.828229294308;7369.263073692588;7530;7016.859662806817;7087.61018144007;7329.120505539369;7554.433417493819;7572.7728168155045;6686.899696504459;6962.825929351807;6989.7553585624255;7002.124734408199;7026.543274687129;6904.067950826574;6904.965475172592;6912.412444942236;6953.026576279426;6972.163340399185;6401.7119229633845;6482.54622176462;6539.771108011197;6540.345965403612;6614.3385661435395;4554.225781617067;4647.4655414626395;4665.230237010991;4711.740854252912;4729.597984171246;4450.844220452269;4518.277075667877;4522.253828118455;4556.498785133566;4605.723656580616 15:24:49 INFO - PROCESS | 20582 | |4;prototype.html;298.91182101280106;300.54317437495007;306.7683898656514;310.5698607428711;311.47671911189224;4833.685810422325;4838.879028024301;4842.273658951159;4868.805247790088;4871.975640121804;4677;4795.280707893818;4796.30453584231;4806.927896081553;4815.975920120403;3773.2264885698364;3819.4652748615217;3828.770273783575;3839.6928245740414;3852.7880966546827;3829.678760827524;3830.659269255766;3833;3839.404892241707;3851.7111216658723;3550.5384300041087;3770.6417890300513;3790.1093243087853;3817.790021548814;3823.1780167264033;3717.498137751423;3748.2824951909647;3763.924721505582;3773.490578771858;3787.9053023674355;3301.290222602128;3303.587051618548;3304.884329048472;3321.0405860542396;3324.4182268103227;4699.459562150362;4715.952840471586;4735.763211839394;4737.597304229144;4753.33453316536;4102.220578090183;4316.309390497506;4317.676174286909;4334.133173365308;4339;5071.137906555894;5077.543021128116;5079.958608485252;5106.897862042739;5114.667546609458;3620.2035552178477;3621.8551257949653;3626.746127771057;3627.72792040598;3628.6371362863765;5067.822626208065;5297.152455607123;5313.946860531384;5328.973355133238;5329.573634109301;3673.3387990162028;3697.6487233712755;3718.795466249382;3719.051641831316;3733.8879833605033;3740.233252183296;3752.4746535485056;3756.7271800560816;3760.6427389397963;3765.4540091686554;4275.978620106879;4277.379779931893;4279.16556271524;4297.957020429756;4299.312110062375;4826.879328016757;5069.923951140736;5080.949190508121;5093.286939828427;5103.948960510347;1286.6397408725572;1292.954746583865;1300.5643109558405;1300.8959283257507;1303.2050449225965;793.5794029164553;828.1676914700687;829.8340331933638;836.460482988469;840.1724301562956;3987.4218238355274;4004.8598299059395;4011.194962266933;4020.83916643331;4036.535798383165;4620.630349572093;4646.279826626811;4647.604953578983;4647.883802904955;4692.718436893797;3960.960390396059;3974;4033.4756481657196;4062.2281766464275;4073.89815254621;2304.2856714418585;2437.3784684905236;2461.815363847719;2472.8021758259656;2476.962845557318;4397.978010109929;4407.9861631824215;4427.7639791904885;4429.734215947054;4448.599626033672;4682.9531704683195;4712.505186955389;4720.976395118002;5069.619778516552;5175.7153356564995;4788.712677239377;4948.055906735487;4976.954839483677;4984.102861484967;4997.85006449807;5206.765695543634;5213.817516386908;5222.503862133091;5228.163493840967;5243;4838.806447742051;5101.795928162832;5128.974355128201;5171.741412929263;5191.584673226208;4992.550670439678;4993.826450784136;4995.925061124159;5014.6991180529285;5015.874603134951;3709.8516059357326;3733.5519737631657;3733.5706393765063;3735.4210097434943;3737.6262373762406;5033.194688849767;5218.765155568084;5219.686818790885;5259.105951988095;5271.525562699376;5075.244319203836;5079.72061536619;5093.923591146062;5108.335916330853;5111.744412779271;5079.212722028092;5097.419799862055;5097.7960881565805;5105.28526006352;5114.33513643224;4762.76186190696;5040.949590504195;5041.773120209673;5042.84871453857;5049.5960323174795;5099.821506247264;5112.54597793054;5136.6147538935475;5141.511556402136;5146.974265128651;4996.7001979881325;5003.674761140514;5005.399352077774;5040.697558146523;5044.200468739885 15:24:49 INFO - PROCESS | 20582 | |5;yui.html;568.6559631422987;580.7415700013495;603.6468665830486;625.4496043481736;632.1308201223317;12460.12779105463;12546.498140074398;12838.614841554745;13515.526956556523;13518.256495892721;12028.158028937978;12146;12248;12262.754744905118;12270.570530031451;621.5866448811535;758.525921299188;776.5728849132983;800.6357107516067;800.9239122283374;780.1067777394879;782.4483738964017;784.274546044909;785.0500893918337;785.6582386661792;838.8532006898769;840.0591337701783;840.2815592668272;840.487302745328;840.5503055865113;652.4421619515341;670.2058061197497;672.495628278791;673.1249375811475;833.8332333533288;590.9940900590982;601.7713268957812;603.7977277611961;609.1563184988778;610.4109534299378;12690.619281421572;12740;12755.298458584773;12765.55320563785;12771.297578633172;12564.81152782709;12728.299943503103;12821;12977.610671679864;13187.868121318856;11498.885011149865;11612.767744645143;11710.33587862456;12043.879561204363;12061.216020958609;4065.1869626074904;4068.877933661995;4106.568810274908;4234.407182994383;4236.915261694749;59662.40337596612;59683;60021.6998915007;60432.093518597256;62650.37349626491;8948.597313120925;10523.736906577396;10563.366198028143;10568.471576421149;10601.204909631808;17667.204975775865;18781.530461738294;18890.527736806416;18901.905490472458;18910.52723681919;6512.479001679854;6547.934520654732;6672.499562532829;6685.899711504331;6697.397234248941;3649.4160934250394;3659.8279940223724;3661.615530369273;3668.725390258057;3681.1901381695984;2799.846008469513;2885.7258560436726;2908.3456222350223;2914.1548950804454;2914.489964256247;463.3582488253793;471.0602348315065;480.6395203597302;487.6196566677997;488.74096728733826;467.2547287077107;467.88770695032946;471.3824889394904;477.1244765854626;489.1098201273648;7074.327938845801;7097.290270972861;7131.89302160468;7139.143302803697;7218.8917166242545;389.6960370910694;415.89394704350195;428.04118773946135;428.57142857142856;479.8560431870425;3421.2815308784934;3459.3773120837986;3468.514407982884;3468.6011108722314;3549.290141971616;81701.59149204334;94376.52811736034;96042.51978740061;96762;97208.51395742976;81558.59220703976;84016.15293567676;84441;84814.57592711996;85542;75644.62177689186;77101.61449192718;77193;77210.84183737249;77518;6781.728730850711;6841.144856892888;6945.548539344926;6960.129983752031;7013.789586312419;44851.775741121084;45123;45581;46167.538324616326;47261.29108063313;57748;57777;64670;66393;68126;7931.524108553505;7986.3610911128135;8026.3980201483955;8044.597770111588;8069.072056713553;10324;11675.649730508097;11715.414229288332;12044.277343359427;12654.746905062031;11228.214025018497;11634.301941883514;11671.88328116708;12317.815232771694;12319.44562494672;10882.673519794418;11179.552817887194;11218.719532011764;11822.290662560274;11847.348395838311;11404.657860264206;11504.597339093092;11849.229800063313;12283.201591896499;12481.438335274754;9998;9999.600015999278;10034.297599167989;10280.897191028293;10293.84559231597;10044.246681498771;10053.648122315684;10242.539085741011;10385.48072596352;10461.163106951273 15:24:49 INFO - PROCESS | 20582 | __end_tp_report 15:24:49 INFO - PROCESS | 20582 | __start_cc_report 15:24:49 INFO - PROCESS | 20582 | _x_x_mozilla_cycle_collect,1108 15:24:49 INFO - PROCESS | 20582 | __end_cc_report 15:24:49 INFO - PROCESS | 20582 | __startTimestamp1468448689487__endTimestamp 15:24:49 INFO - PROCESS | 20582 | 15:24:49 INFO - PROCESS | 20582 | ------- Summary: start ------- 15:24:49 INFO - PROCESS | 20582 | Number of tests: 6 15:24:49 INFO - PROCESS | 20582 | 15:24:49 INFO - PROCESS | 20582 | [#0] dojo.html Cycles:165 Average:4634.46 Median:4767.50 stddev:489.65 (10.3%) stddev-sans-first:464.50 15:24:49 INFO - PROCESS | 20582 | Values: 2603.5 2612.6 2645.2 2656.9 2658.5 4557.5 4645.0 4675.1 4699.1 4713.3 4631.4 4660.3 4680.9 4697.6 4709.2 4262.3 4278.4 4281.2 4323.8 4412.0 4285.3 4355.8 4376.0 4425.0 4434.5 4190.0 4344.9 4360.2 4383.8 4391.1 4223.3 4233.5 4243.7 4271.5 4272.4 4278.7 4327.0 4338.1 4339.7 4386.4 4451.2 4724.1 4748.0 4760.3 4777.9 4893.4 4996.3 5018.7 5055.3 5110.8 5035.5 5098.7 5103.4 5123.2 5134.3 4549.9 4680.8 4747.1 4753.0 4804.5 5109.1 5125.6 5132.2 5194.3 5201.9 4963.8 4964.1 4966.7 5007.1 5015.8 4809.0 4934.0 4988.8 5043.1 5095.8 4945.8 4964.6 4978.7 4987.1 5011.7 4949.1 4950.1 4953.7 4957.3 4992.5 3979.8 4008.9 4149.9 4183.7 4238.6 3676.4 3684.1 3685.9 3726.6 3743.5 4318.9 4326.8 4328.5 4360.4 4368.6 4936.1 4985.3 5001.1 5019.9 5075.4 4333.1 4340.2 4341.7 4361.4 4376.4 4506.5 4509.2 4514.0 4516.4 4561.2 4536.6 4723.4 4729.7 4773.1 4780.6 5044.8 5047.9 5061.1 5073.7 5122.2 4772.1 4781.8 4792.3 4794.2 4842.5 4757.5 4862.3 4900.1 4902.5 4949.8 4977.2 5011.3 5011.5 5016.6 5044.2 4872.5 4879.4 4896.5 4898.4 4918.2 4731.8 4855.4 4858.7 4924.8 4953.6 4835.9 4868.9 4876.3 4912.5 4915.8 4709.2 4972.8 4979.7 4984.6 5012.8 4669.1 4710.0 4751.9 4767.5 4788.7 15:24:49 INFO - PROCESS | 20582 | 15:24:49 INFO - PROCESS | 20582 | [#1] ext.html Cycles:180 Average:44225.92 Median:35345.38 stddev:81827.23 (231.5%) stddev-sans-first:81991.12 15:24:49 INFO - PROCESS | 20582 | Values: 566.7 566.8 575.1 578.5 584.2 28308.3 40401.2 41722.6 41936.8 44916.1 41517.0 41528.4 41819.4 41848.8 41916.8 8019.9 8164.6 8168.2 8171.6 8172.3 8008.9 8112.5 8115.7 8116.4 8117.2 8105.6 8123.0 8156.7 8162.8 8175.9 8085.9 8140.3 8140.8 8151.1 8151.4 8013.4 8070.0 8089.8 8090.9 8101.9 39924.2 40155.2 40170.6 40314.6 40393.8 3075.9 3108.0 3188.2 3416.2 3763.9 30463.2 30814.0 30820.8 30968.0 31885.0 3001.9 3010.4 3016.3 3017.5 3055.7 183762.0 184388.0 184510.0 184608.0 184827.1 32567.3 33799.5 33825.5 35722.3 56213.7 34761.7 34809.1 34877.5 34934.3 34968.5 12497.4 12524.9 12546.7 12552.7 12557.6 11029.6 11098.6 11099.4 11123.2 11140.8 7996.6 8027.3 8046.4 8086.9 8111.1 3104.3 3123.6 3146.9 3156.8 3159.0 818.5 881.4 884.8 885.1 988.9 27755.0 27875.7 28461.6 28579.4 28668.4 951.7 964.1 975.0 1003.5 1006.6 14898.6 15019.5 15098.7 15195.9 15350.8 384914.0 388433.0 390827.0 391499.0 391572.0 33333.0 33829.0 33894.0 33984.3 34051.7 1206.5 1209.4 1209.7 1210.5 1219.7 25981.9 27660.6 27696.4 28117.1 28423.0 45000.3 45487.3 45542.8 45550.8 45581.8 317068.0 318242.0 318496.0 320088.0 320102.0 25991.2 26091.7 26260.2 26347.0 26358.7 42889.8 43947.8 44008.0 44208.1 44639.6 37204.6 37704.8 38019.0 38037.0 38307.6 36818.3 37006.1 37161.1 37994.4 38345.0 26743.6 36132.0 36797.0 37015.8 38914.0 32302.4 33554.8 33839.3 34148.5 34187.7 23398.0 23711.6 24180.4 24311.6 24414.3 15:24:49 INFO - PROCESS | 20582 | 15:24:49 INFO - PROCESS | 20582 | [#2] jquery.html Cycles:180 Average:25651.49 Median:4459.34 stddev:67393.79 (1511.3%) stddev-sans-first:67556.05 15:24:49 INFO - PROCESS | 20582 | Values: 342.3 372.4 375.3 375.5 379.1 13189.8 16825.5 16878.2 17654.3 18831.9 16989.7 17470.7 17538.0 17583.6 17592.0 5107.3 5148.0 5241.0 5270.6 5294.6 3711.3 4861.2 5198.4 5847.2 6129.1 6211.1 6213.3 6232.3 6235.1 6248.9 5977.3 6309.9 6314.3 6317.0 6318.2 3445.5 3611.4 3612.2 5528.1 5528.2 18793.8 20128.2 20705.1 22163.2 22200.8 1854.9 1883.4 1906.1 2176.8 2302.1 13599.2 13716.6 13749.5 13923.4 13936.0 1745.7 1838.9 1839.1 1855.6 1863.7 68391.0 71832.3 72193.3 72877.0 73801.6 8809.8 9372.2 9387.9 9513.5 10167.8 11549.8 12393.8 12408.5 12966.8 13003.3 7097.4 7107.2 7387.6 7437.8 7569.7 7166.4 7271.7 7283.5 7314.7 7393.1 4344.0 4413.1 4505.6 4516.2 4556.5 1774.3 1825.0 1828.7 1833.4 1844.3 778.4 874.2 883.9 891.7 911.9 16375.6 17073.9 17205.4 17310.0 17493.2 835.6 849.6 852.6 862.9 863.6 9602.1 9618.9 9948.0 9960.1 10084.4 381237.0 408775.0 410555.0 410908.0 415450.0 83085.6 94506.5 94912.0 95016.5 95369.0 862.1 881.4 903.6 904.5 911.2 16064.0 16304.8 16442.3 17019.7 17049.8 39230.2 39576.0 40299.6 40496.0 40922.0 57024.7 57813.7 58100.7 58133.7 59755.4 7291.9 7365.1 7375.0 7569.7 7600.0 10880.6 11209.3 11241.9 11532.5 11583.7 9268.2 9901.5 10095.5 10136.6 10287.7 9852.4 9862.0 9989.8 10045.2 10206.8 9913.6 10151.7 10219.0 10271.8 10420.8 7349.8 7372.7 7435.8 7453.3 7521.7 9748.0 10036.6 10175.4 10236.2 10249.5 15:24:49 INFO - PROCESS | 20582 | 15:24:49 INFO - PROCESS | 20582 | [#3] mootools.html Cycles:180 Average:5234.43 Median:4621.81 stddev:3000.31 (64.9%) stddev-sans-first:2993.93 15:24:49 INFO - PROCESS | 20582 | Values: 1268.5 1322.4 1384.7 1447.5 1750.5 6693.5 7842.5 8164.6 8166.6 8170.7 7906.1 8037.6 8048.1 8050.0 8051.9 2217.2 2247.0 2248.9 2249.2 2249.6 2155.8 2189.3 2227.5 2232.9 2235.4 2181.9 2188.3 2188.6 2189.1 2240.0 2130.5 2134.0 2134.8 2141.6 2141.7 2087.8 2130.8 2131.7 2134.9 2136.7 7881.7 7987.2 8074.2 8080.6 8148.8 4430.0 4507.1 4507.3 4509.1 4520.9 2588.6 2672.4 2705.9 2714.9 2716.5 858.5 867.2 869.2 1539.4 1597.4 11095.3 11223.6 11226.2 11238.5 11242.8 3985.6 4037.7 4170.5 4174.0 4176.7 8732.0 8765.0 8768.1 8776.2 8780.3 4613.5 4620.1 4620.4 4621.2 4622.4 3598.7 3922.1 4080.8 4237.6 4266.4 3492.2 3539.6 3583.3 3585.5 3684.5 1050.3 1099.9 1100.7 1102.2 1112.8 747.0 809.0 822.4 839.2 850.0 5348.1 5357.7 5477.2 5561.9 5661.5 892.6 899.4 901.1 921.6 933.5 3481.1 3543.6 3634.8 3656.3 3682.8 9891.6 10127.8 10150.0 10264.7 10295.7 10117.6 10131.9 10134.5 10151.1 10157.2 7491.7 7513.5 7681.3 7751.2 7757.4 5295.2 5311.7 5318.5 5329.1 5454.8 9326.0 9368.1 9433.2 9442.1 9478.1 8704.8 9104.8 9143.5 9152.8 9424.0 6647.0 6865.6 6870.8 7369.3 7530.0 7016.9 7087.6 7329.1 7554.4 7572.8 6686.9 6962.8 6989.8 7002.1 7026.5 6904.1 6905.0 6912.4 6953.0 6972.2 6401.7 6482.5 6539.8 6540.3 6614.3 4554.2 4647.5 4665.2 4711.7 4729.6 4450.8 4518.3 4522.3 4556.5 4605.7 15:24:49 INFO - PROCESS | 20582 | 15:24:49 INFO - PROCESS | 20582 | [#4] prototype.html Cycles:180 Average:4145.32 Median:4687.84 stddev:1214.77 (25.9%) stddev-sans-first:1183.38 15:24:49 INFO - PROCESS | 20582 | Values: 298.9 300.5 306.8 310.6 311.5 4833.7 4838.9 4842.3 4868.8 4872.0 4677.0 4795.3 4796.3 4806.9 4816.0 3773.2 3819.5 3828.8 3839.7 3852.8 3829.7 3830.7 3833.0 3839.4 3851.7 3550.5 3770.6 3790.1 3817.8 3823.2 3717.5 3748.3 3763.9 3773.5 3787.9 3301.3 3303.6 3304.9 3321.0 3324.4 4699.5 4716.0 4735.8 4737.6 4753.3 4102.2 4316.3 4317.7 4334.1 4339.0 5071.1 5077.5 5080.0 5106.9 5114.7 3620.2 3621.9 3626.7 3627.7 3628.6 5067.8 5297.2 5313.9 5329.0 5329.6 3673.3 3697.6 3718.8 3719.1 3733.9 3740.2 3752.5 3756.7 3760.6 3765.5 4276.0 4277.4 4279.2 4298.0 4299.3 4826.9 5069.9 5080.9 5093.3 5103.9 1286.6 1293.0 1300.6 1300.9 1303.2 793.6 828.2 829.8 836.5 840.2 3987.4 4004.9 4011.2 4020.8 4036.5 4620.6 4646.3 4647.6 4647.9 4692.7 3961.0 3974.0 4033.5 4062.2 4073.9 2304.3 2437.4 2461.8 2472.8 2477.0 4398.0 4408.0 4427.8 4429.7 4448.6 4683.0 4712.5 4721.0 5069.6 5175.7 4788.7 4948.1 4977.0 4984.1 4997.9 5206.8 5213.8 5222.5 5228.2 5243.0 4838.8 5101.8 5129.0 5171.7 5191.6 4992.6 4993.8 4995.9 5014.7 5015.9 3709.9 3733.6 3733.6 3735.4 3737.6 5033.2 5218.8 5219.7 5259.1 5271.5 5075.2 5079.7 5093.9 5108.3 5111.7 5079.2 5097.4 5097.8 5105.3 5114.3 4762.8 5040.9 5041.8 5042.8 5049.6 5099.8 5112.5 5136.6 5141.5 5147.0 4996.7 5003.7 5005.4 5040.7 5044.2 15:24:49 INFO - PROCESS | 20582 | 15:24:49 INFO - PROCESS | 20582 | [#5] yui.html Cycles:180 Average:17515.36 Median:465.31 stddev:25160.09 (5407.2%) stddev-sans-first:25198.49 15:24:49 INFO - PROCESS | 20582 | Values: 568.7 580.7 603.6 625.4 632.1 12460.1 12546.5 12838.6 13515.5 13518.3 12028.2 12146.0 12248.0 12262.8 12270.6 621.6 758.5 776.6 800.6 800.9 780.1 782.4 784.3 785.1 785.7 838.9 840.1 840.3 840.5 840.6 652.4 670.2 672.5 673.1 833.8 591.0 601.8 603.8 609.2 610.4 12690.6 12740.0 12755.3 12765.6 12771.3 12564.8 12728.3 12821.0 12977.6 13187.9 11498.9 11612.8 11710.3 12043.9 12061.2 4065.2 4068.9 4106.6 4234.4 4236.9 59662.4 59683.0 60021.7 60432.1 62650.4 8948.6 10523.7 10563.4 10568.5 10601.2 17667.2 18781.5 18890.5 18901.9 18910.5 6512.5 6547.9 6672.5 6685.9 6697.4 3649.4 3659.8 3661.6 3668.7 3681.2 2799.8 2885.7 2908.3 2914.2 2914.5 463.4 471.1 480.6 487.6 488.7 467.3 467.9 471.4 477.1 489.1 7074.3 7097.3 7131.9 7139.1 7218.9 389.7 415.9 428.0 428.6 479.9 3421.3 3459.4 3468.5 3468.6 3549.3 81701.6 94376.5 96042.5 96762.0 97208.5 81558.6 84016.2 84441.0 84814.6 85542.0 75644.6 77101.6 77193.0 77210.8 77518.0 6781.7 6841.1 6945.5 6960.1 7013.8 44851.8 45123.0 45581.0 46167.5 47261.3 57748.0 57777.0 64670.0 66393.0 68126.0 7931.5 7986.4 8026.4 8044.6 8069.1 10324.0 11675.6 11715.4 12044.3 12654.7 11228.2 11634.3 11671.9 12317.8 12319.4 10882.7 11179.6 11218.7 11822.3 11847.3 11404.7 11504.6 11849.2 12283.2 12481.4 9998.0 9999.6 10034.3 10280.9 10293.8 10044.2 10053.6 10242.5 10385.5 10461.2 15:24:49 INFO - PROCESS | 20582 | -------- Summary: end -------- 15:24:49 INFO - PROCESS | 20582 | 15:24:50 INFO - TEST-INFO | 20582: exit 0 15:24:50 INFO - TEST-OK | dromaeo_css | took 1120191ms 15:24:50 INFO - TEST-START | kraken 15:24:50 INFO - operating with platform_type : linux_ 15:24:50 INFO - Initialising browser for kraken test... 15:24:50 INFO - TEST-INFO | started process 20772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwSGU9j/profile http://localhost:49687/getInfo.html) 15:24:54 INFO - PROCESS | 20772 | __metrics Screen width/height:1600/1200 15:24:54 INFO - PROCESS | 20772 | colorDepth:24 15:24:54 INFO - PROCESS | 20772 | Browser inner width/height: 1024/697 15:24:54 INFO - PROCESS | 20772 | __metrics 15:24:56 INFO - PROCESS | 20772 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:24:56 INFO - PROCESS | 20772 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:24:57 INFO - TEST-INFO | 20772: exit 0 15:24:57 INFO - Browser initialized. 15:24:57 INFO - Running cycle 1/1 for kraken test... 15:24:57 INFO - TEST-INFO | started process 20853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwSGU9j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:09 INFO - PROCESS | 20853 | RSS: Main: 158609408 15:25:09 INFO - PROCESS | 20853 | 15:25:11 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49687/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:12 INFO - PROCESS | 20853 | RSS: Main: 216506368 15:25:12 INFO - PROCESS | 20853 | 15:25:15 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49687/tests/kraken/driver.html?testName=audio-dft) 15:25:16 INFO - PROCESS | 20853 | RSS: Main: 203476992 15:25:16 INFO - PROCESS | 20853 | 15:25:19 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49687/tests/kraken/driver.html?testName=audio-fft) 15:25:19 INFO - PROCESS | 20853 | RSS: Main: 271142912 15:25:19 INFO - PROCESS | 20853 | 15:25:22 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49687/tests/kraken/driver.html?testName=audio-oscillator) 15:25:22 INFO - PROCESS | 20853 | RSS: Main: 181043200 15:25:22 INFO - PROCESS | 20853 | 15:25:24 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49687/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:25 INFO - PROCESS | 20853 | RSS: Main: 186363904 15:25:25 INFO - PROCESS | 20853 | 15:25:28 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49687/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:29 INFO - PROCESS | 20853 | RSS: Main: 221523968 15:25:29 INFO - PROCESS | 20853 | 15:25:32 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49687/tests/kraken/driver.html?testName=imaging-desaturate) 15:25:33 INFO - PROCESS | 20853 | RSS: Main: 222572544 15:25:33 INFO - PROCESS | 20853 | 15:25:36 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49687/tests/kraken/driver.html?testName=json-parse-financial) 15:25:36 INFO - PROCESS | 20853 | RSS: Main: 223035392 15:25:36 INFO - PROCESS | 20853 | 15:25:38 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49687/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:25:39 INFO - PROCESS | 20853 | RSS: Main: 211128320 15:25:39 INFO - PROCESS | 20853 | 15:25:41 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49687/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:25:41 INFO - PROCESS | 20853 | RSS: Main: 216215552 15:25:41 INFO - PROCESS | 20853 | 15:25:43 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49687/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:25:44 INFO - PROCESS | 20853 | RSS: Main: 213422080 15:25:44 INFO - PROCESS | 20853 | 15:25:47 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:25:47 INFO - PROCESS | 20853 | RSS: Main: 225779712 15:25:47 INFO - PROCESS | 20853 | 15:25:50 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:25:51 INFO - PROCESS | 20853 | RSS: Main: 226156544 15:25:51 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:49687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49687/tests/kraken/driver.html?testName=ai-astar) 15:25:53 INFO - PROCESS | 20853 | RSS: Main: 268824576 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | __start_tp_report 15:25:53 INFO - PROCESS | 20853 | _x_x_mozilla_page_load 15:25:53 INFO - PROCESS | 20853 | _x_x_mozilla_page_load_details 15:25:53 INFO - PROCESS | 20853 | |i|pagename|runs| 15:25:53 INFO - PROCESS | 20853 | |0;ai-astar;105;116;113;125;114;113;114;114;114;114 15:25:53 INFO - PROCESS | 20853 | |1;audio-beat-detection;149;123;129;186;122;123;144;127;174;121 15:25:53 INFO - PROCESS | 20853 | |2;audio-dft;163;166;162;161;162;162;162;162;162;162 15:25:53 INFO - PROCESS | 20853 | |3;audio-fft;75;75;76;124;76;78;75;86;102;76 15:25:53 INFO - PROCESS | 20853 | |4;audio-oscillator;84;86;114;85;85;85;124;84;84;121 15:25:53 INFO - PROCESS | 20853 | |5;imaging-gaussian-blur;117;117;125;118;118;117;116;117;117;116 15:25:53 INFO - PROCESS | 20853 | |6;imaging-darkroom;145;146;146;148;146;146;145;146;146;146 15:25:53 INFO - PROCESS | 20853 | |7;imaging-desaturate;95;95;95;94;95;94;94;95;95;94 15:25:53 INFO - PROCESS | 20853 | |8;json-parse-financial;69;64;63;64;65;64;66;64;65;64 15:25:53 INFO - PROCESS | 20853 | |9;json-stringify-tinderbox;65;66;66;66;67;65;66;66;66;65 15:25:53 INFO - PROCESS | 20853 | |10;stanford-crypto-aes;85;82;78;79;85;93;78;89;80;87 15:25:53 INFO - PROCESS | 20853 | |11;stanford-crypto-ccm;125;129;126;127;128;135;129;126;193;129 15:25:53 INFO - PROCESS | 20853 | |12;stanford-crypto-pbkdf2;168;171;167;165;164;169;168;167;167;166 15:25:53 INFO - PROCESS | 20853 | |13;stanford-crypto-sha256-iterative;66;67;67;66;67;65;66;66;66;64 15:25:53 INFO - PROCESS | 20853 | __end_tp_report 15:25:53 INFO - PROCESS | 20853 | __start_cc_report 15:25:53 INFO - PROCESS | 20853 | _x_x_mozilla_cycle_collect,1940 15:25:53 INFO - PROCESS | 20853 | __end_cc_report 15:25:53 INFO - PROCESS | 20853 | __startTimestamp1468448753361__endTimestamp 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | ------- Summary: start ------- 15:25:53 INFO - PROCESS | 20853 | Number of tests: 14 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:4.80 (4.2%) stddev-sans-first:3.77 15:25:53 INFO - PROCESS | 20853 | Values: 105.0 116.0 113.0 125.0 114.0 113.0 114.0 114.0 114.0 114.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:136.50 stddev:23.38 (17.1%) stddev-sans-first:24.57 15:25:53 INFO - PROCESS | 20853 | Values: 149.0 123.0 129.0 186.0 122.0 123.0 144.0 127.0 174.0 121.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 15:25:53 INFO - PROCESS | 20853 | Values: 163.0 166.0 162.0 161.0 162.0 162.0 162.0 162.0 162.0 162.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.00 stddev:16.32 (21.5%) stddev-sans-first:16.96 15:25:53 INFO - PROCESS | 20853 | Values: 75.0 75.0 76.0 124.0 76.0 78.0 75.0 86.0 102.0 76.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:84.50 stddev:17.07 (20.2%) stddev-sans-first:17.61 15:25:53 INFO - PROCESS | 20853 | Values: 84.0 86.0 114.0 85.0 85.0 85.0 124.0 84.0 84.0 121.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:2.62 (2.2%) stddev-sans-first:2.76 15:25:53 INFO - PROCESS | 20853 | Values: 117.0 117.0 125.0 118.0 118.0 117.0 116.0 117.0 117.0 116.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 15:25:53 INFO - PROCESS | 20853 | Values: 145.0 146.0 146.0 148.0 146.0 146.0 145.0 146.0 146.0 146.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:25:53 INFO - PROCESS | 20853 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.50 stddev:1.69 (2.6%) stddev-sans-first:0.87 15:25:53 INFO - PROCESS | 20853 | Values: 69.0 64.0 63.0 64.0 65.0 64.0 66.0 64.0 65.0 64.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 15:25:53 INFO - PROCESS | 20853 | Values: 65.0 66.0 66.0 66.0 67.0 65.0 66.0 66.0 66.0 65.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:85.00 stddev:5.08 (6.0%) stddev-sans-first:5.36 15:25:53 INFO - PROCESS | 20853 | Values: 85.0 82.0 78.0 79.0 85.0 93.0 78.0 89.0 80.0 87.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:129.00 stddev:20.67 (16.0%) stddev-sans-first:21.63 15:25:53 INFO - PROCESS | 20853 | Values: 125.0 129.0 126.0 127.0 128.0 135.0 129.0 126.0 193.0 129.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.50 stddev:1.99 (1.2%) stddev-sans-first:2.09 15:25:53 INFO - PROCESS | 20853 | Values: 168.0 171.0 167.0 165.0 164.0 169.0 168.0 167.0 167.0 166.0 15:25:53 INFO - PROCESS | 20853 | 15:25:53 INFO - PROCESS | 20853 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 15:25:53 INFO - PROCESS | 20853 | Values: 66.0 67.0 67.0 66.0 67.0 65.0 66.0 66.0 66.0 64.0 15:25:53 INFO - PROCESS | 20853 | -------- Summary: end -------- 15:25:53 INFO - PROCESS | 20853 | 15:25:54 INFO - TEST-INFO | 20853: exit 0 15:25:54 INFO - TEST-OK | kraken | took 64145ms 15:25:54 INFO - SUITE-END | took 1184s 15:25:54 INFO - Completed test suite (00:19:44) 15:25:54 INFO - javascript benchmark 15:25:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.518349105415, 2612.6211699303612, 2645.1932160690994, 2656.8937242510287, 2658.4683063387315, 4557.47589027262, 4644.953550464495, 4675.111728771531, 4699.130660827749, 4713.316569097479, 4631.374764406804, 4660.324252983315, 4680.882977925554, 4697.6241900647865, 4709.2229782086, 4262.339337402707, 4278.4438023056955, 4281.207976524337, 4323.82704691812, 4411.977940110295, 4285.335772955182, 4355.825766969318, 4376.0, 4425.0, 4434.467863856342, 4190.036291652907, 4344.869653910388, 4360.21516127097, 4383.846565370197, 4391.0559229765595, 4223.260929337384, 4233.491980962273, 4243.681723870691, 4271.487421509439, 4272.380504826782, 4278.743275403485, 4327.0480494291205, 4338.132373525276, 4339.674524410681, 4386.407834942273, 4451.154280686659, 4724.149653062447, 4747.952520474785, 4760.285957106427, 4777.904441911177, 4893.388326459192, 4996.325496058022, 5018.7490625468945, 5055.292259083732, 5110.795568177268, 5035.546800787946, 5098.6685865419, 5103.387593488768, 5123.1546794778815, 5134.332536770234, 4549.863504094882, 4680.765961701902, 4747.121782470254, 4753.049390121955, 4804.5195480451675, 5109.080365534165, 5125.615578831603, 5132.230165475134, 5194.3247377840635, 5201.869953251199, 4963.801447942042, 4964.05682920244, 4966.6771659842, 5007.098722230034, 5015.82444614444, 4808.951910480921, 4933.975330123327, 4988.800447982113, 5043.067032598981, 5095.821646242363, 4945.752712364368, 4964.553190212826, 4978.726170060609, 4987.0524600325825, 5011.724355160428, 4949.1091603510995, 4950.133726597831, 4953.678010929278, 4957.3307603473795, 4992.450830408652, 3979.8010099495486, 4008.899777505586, 4149.896252593649, 4183.707140500136, 4238.597333253336, 3676.3750162472443, 3684.060564556021, 3685.9078523037138, 3726.571444283888, 3743.5133432654125, 4318.892027699269, 4326.805293761725, 4328.480582330078, 4360.389545463638, 4368.584984426474, 4936.111499929975, 4985.277134815431, 5001.074801161797, 5019.874503137377, 5075.441701412841, 4333.068390296102, 4340.175366680321, 4341.739495630272, 4361.411209486742, 4376.40918476008, 4506.504284528699, 4509.233430316854, 4514.0, 4516.435445569304, 4561.201789686792, 4536.591706746277, 4723.362346083372, 4729.69256998294, 4773.069251496064, 4780.630581301576, 5044.798208071636, 5047.87380315495, 5061.063703214917, 5073.670211436245, 5122.231665250242, 4772.117158325582, 4781.808727650994, 4792.281157826354, 4794.161021821237, 4842.491538388418, 4757.45289291722, 4862.294967229661, 4900.093482705711, 4902.534259245366, 4949.752512374295, 4977.228529577921, 5011.348524691767, 5011.473795251446, 5016.623753218596, 5044.243363495505, 4872.512748725099, 4879.438864530624, 4896.461389247252, 4898.387701537308, 4918.188498897642, 4731.834385796481, 4855.417349918032, 4858.732769697701, 4924.7537623119415, 4953.603711703127, 4835.854924352275, 4868.926966095441, 4876.317315575751, 4912.484189160086, 4915.754212289443, 4709.152352576432, 4972.825951091694, 4979.701217926936, 4984.6261530384645, 5012.8496145115705, 4669.066186762593, 4709.976450117728, 4751.881202969954, 4767.499412561631, 4788.688735232199], "value": 4603.275882499832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7449647658553, 566.8016194331982, 575.1459083261353, 578.5313895744447, 584.2463222443049, 28308.292292692666, 40401.19197616046, 41722.58277417221, 41936.79031604846, 44916.10167796642, 41517.0, 41528.377074343836, 41819.372709409385, 41848.790756046255, 41916.79041604788, 8019.879701804478, 8164.550949697764, 8168.183181681844, 8171.550564718938, 8172.264496195341, 8008.879866802003, 8112.513249205037, 8115.675372985073, 8116.35069194463, 8117.22886325801, 8105.554194519299, 8122.959385203066, 8156.673733050671, 8162.755117346489, 8175.918240817575, 8085.878711819328, 8140.267375936194, 8140.837183256302, 8151.06262779779, 8151.388645851525, 8013.398995075393, 8070.0, 8089.838203235902, 8090.919090809134, 8101.9189808101755, 39924.201515969515, 40155.19689606221, 40170.59829401698, 40314.59685403167, 40393.798031009654, 3075.8923437679796, 3107.984460077708, 3188.234823642309, 3416.1630400551776, 3763.9059023524355, 30463.23841903948, 30814.0, 30820.848783688518, 30968.0, 31885.0, 3001.9399612007855, 3010.4280186764445, 3016.291171574678, 3017.4870272053804, 3055.6944305569486, 183762.0, 184388.0, 184510.0, 184608.0, 184827.07586462115, 32567.348653027282, 33799.493007604906, 33825.492617610755, 35722.28555428877, 56213.718931405085, 34761.65238347635, 34809.12977175591, 34877.476837847455, 34934.30131397358, 34968.475472867925, 12497.437615307334, 12524.937375313066, 12546.686332841751, 12552.686182845502, 12557.56048538315, 11029.558817647205, 11098.61154859576, 11099.38953357557, 11123.221374503868, 11140.832887506695, 7996.560189189534, 8027.317677997319, 8046.396520261003, 8086.878696819553, 8111.067227268822, 3104.286014216743, 3123.640781310178, 3146.9055928322186, 3156.779025468195, 3158.952615710766, 818.5211651184125, 881.3918396306656, 884.8145081648319, 885.0529932971787, 988.9357191782511, 27755.0, 27875.721242787313, 28461.57307640387, 28579.428411431654, 28668.426631467253, 951.7192428233687, 964.0696727657844, 974.9610015599296, 1003.4581326083833, 1006.5571148694551, 14898.553043408716, 15019.474318399021, 15098.698026039418, 15195.92402038005, 15350.769738453931, 384914.0, 388433.0, 390827.0, 391499.0, 391572.0, 33333.0, 33829.0, 33894.0, 33984.32031359359, 34051.65948340485, 1206.4993027893502, 1209.4497003863396, 1209.6854817747449, 1210.4734440518228, 1219.676785651803, 25981.870090649427, 27660.58509122405, 27696.446071078062, 28117.133956386293, 28423.0, 45000.32499512444, 45487.31769023401, 45542.77228613836, 45550.77224613856, 45581.77209113933, 317068.0, 318242.0, 318496.0, 320088.0, 320102.0, 25991.22026339213, 26091.739082608932, 26260.212193634223, 26347.0, 26358.73641263563, 42889.793409120735, 43947.78026109849, 44007.97408422626, 44208.11583768371, 44639.55360446354, 37204.62795372012, 37704.81147594354, 38019.0, 38037.0, 38307.61692383041, 36818.263634726616, 37006.074848129014, 37161.070973225884, 37994.43008354821, 38345.0, 26743.598846017714, 36132.0, 36797.0, 37015.81492092522, 38914.0, 32302.35395292034, 33554.83222583871, 33839.32321353608, 34148.487772683926, 34187.65812341845, 23398.0, 23711.644325335477, 24180.39549011289, 24311.635325470485, 24414.26757197287], "value": 16260.41813845773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.3485107839781, 372.4246039868403, 375.34876988425077, 375.5193352508789, 379.1128758704631, 13189.8021529677, 16825.49523514295, 16878.156092195386, 17654.293828246886, 18831.905840470812, 16989.745153822703, 17470.650586988253, 17538.0, 17583.560410989732, 17592.0, 5107.259447380127, 5148.0, 5241.0, 5270.578353731711, 5294.602904782138, 3711.2763011212824, 4861.222204447289, 5198.428172900978, 5847.181394604759, 6129.080637904305, 6211.068339749028, 6213.316535181127, 6232.283287421959, 6235.095911092889, 6248.875022499547, 5977.342492325841, 6309.905351419732, 6314.336994615545, 6317.0, 6318.178636777189, 3445.4659527773233, 3611.368010598135, 3612.223371975038, 5528.06022976095, 5528.198411230389, 18793.812061879344, 20128.194872205095, 20705.0682719278, 22163.22428714987, 22200.777992220195, 1854.88870667759, 1883.359657716383, 1906.1327096171208, 2176.7605563388174, 2302.067662596651, 13599.184048956995, 13716.588502344946, 13749.518766843112, 13923.443062277496, 13936.0, 1745.7119575270065, 1838.8804727692657, 1839.0528877628033, 1855.6288742251468, 1863.7111247756484, 68391.0, 71832.28167718361, 72193.27806721919, 72877.0, 73801.6309918447, 8809.823803523894, 9372.203362714246, 9387.859182112274, 9513.476758778195, 10167.847482287772, 11549.769004620028, 12393.814092788616, 12408.503659853504, 12966.80549791754, 13003.284819335027, 7097.396721278749, 7107.182673992454, 7387.630618469163, 7437.776866694008, 7569.697212111454, 7166.355028047501, 7271.727447696632, 7283.526570772883, 7314.687663627172, 7393.149787774475, 4344.0, 4413.051193993243, 4505.625784135805, 4516.187086324428, 4556.453225612881, 1774.2725482552091, 1825.000123846367, 1828.7348334491423, 1833.3689022120577, 1844.2530775036132, 778.4473024152915, 874.2306770042322, 883.8895138107737, 891.6923661336829, 911.8996910339857, 16375.59061023484, 17073.914630427018, 17205.397811076804, 17310.0, 17493.212805423787, 835.5947365527715, 849.6473963305159, 852.6163226548078, 862.9137086291321, 863.6027427383349, 9602.135807777333, 9618.903810961801, 9948.0, 9960.103590676728, 10084.445355505517, 381237.0, 408775.0, 410555.0, 410908.0, 415450.0, 83085.58457207796, 94506.52746736222, 94912.0, 95016.52491737498, 95369.0, 862.0517430826042, 881.3654168998439, 903.575319599787, 904.4799240436776, 911.2345629671108, 16064.0, 16304.755428668343, 16442.260098295366, 17019.744703829205, 17049.82950170532, 39230.21539569135, 39576.0, 40299.59700402959, 40496.0, 40922.0, 57024.71487642535, 57813.71093144507, 58100.70949645225, 58133.70933145307, 59755.402445974985, 7291.8541629168185, 7365.116186057708, 7374.963125184339, 7569.697212111674, 7599.962000189964, 10880.619178328721, 11209.327440353278, 11241.943790280997, 11532.538698451968, 11583.710407239887, 9268.212201962908, 9901.455419951972, 10095.54570044335, 10136.594536218468, 10287.742806429898, 9852.408855468408, 9861.95069024679, 9989.750256243362, 10045.196384289386, 10206.846897296398, 9913.603455861974, 10151.7462063449, 10219.0, 10271.84592231132, 10420.791584168122, 7349.77950661481, 7372.741954031583, 7435.776926692208, 7453.291937265951, 7521.736739214101, 9748.0, 10036.648717295151, 10175.38947663113, 10236.232282578687, 10249.538770755484], "value": 8409.963196878733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.5433244032154, 1322.4379638653572, 1384.736899989002, 1447.536788227767, 1750.544858336832, 6693.464522838173, 7842.451028428012, 8164.550949697764, 8166.6325015374305, 8170.714025009126, 7906.051273847132, 8037.598120094001, 8048.114707382183, 8050.0, 8051.91948080519, 2217.168561789333, 2247.0, 2248.853824501402, 2249.167807911075, 2249.5613355395703, 2155.8059774620283, 2189.343197040889, 2227.487677834099, 2232.9218477353297, 2235.3852690510157, 2181.901814418347, 2188.3325585696357, 2188.616992026397, 2189.1134090693295, 2240.025588868847, 2130.499332656824, 2134.0, 2134.775848535897, 2141.603803296395, 2141.732283464567, 2087.8016588424075, 2130.8295336373208, 2131.712218850451, 2134.882581458019, 2136.6688163334707, 7881.724139655142, 7987.161348058428, 8074.232947869943, 8080.636371363244, 8148.796280092985, 4429.955700443019, 4507.143642707908, 4507.346434766973, 4509.075639493896, 4520.886977825548, 2588.5987671910884, 2672.398710290189, 2705.9323516912036, 2714.9185524434297, 2716.4974479721313, 858.5449711652834, 867.223834667975, 869.1786261982429, 1539.4073281786482, 1597.4169428158755, 11095.278806877608, 11223.607173748962, 11226.21416500837, 11238.494267757971, 11242.831357529562, 3985.6412922836503, 4037.7173597848455, 4170.541240463546, 4174.039970806732, 4176.749395036308, 8732.039475657673, 8765.035846056928, 8768.07935166811, 8776.210141087206, 8780.253678437277, 4613.538646135359, 4620.052889157714, 4620.422447194101, 4621.237495813153, 4622.375979242826, 3598.712103031751, 3922.1371298314325, 4080.81636326366, 4237.555056719062, 4266.445362102907, 3492.214251793377, 3539.610642829287, 3583.283343331344, 3585.515955346047, 3684.521012268388, 1050.2648146297622, 1099.923005389631, 1100.6697990602947, 1102.1568500097433, 1112.821948488238, 747.0251322024701, 808.9676412943417, 822.4407402966041, 839.1943734015414, 849.9532525711022, 5348.090824559834, 5357.732113394392, 5477.1510415885605, 5561.888762224814, 5661.46216109469, 892.6027917576746, 899.4288626722079, 901.1439132823843, 921.6221349246777, 933.5239028095721, 3481.0949153220345, 3543.627919068461, 3634.83643236055, 3656.2504686539196, 3682.779033258013, 9891.604335826487, 10127.797444051077, 10150.0, 10264.743381415376, 10295.691129266133, 10117.583538304643, 10131.898681013095, 10134.54394552247, 10151.1371533419, 10157.18742500613, 7491.737789177353, 7513.4740568159705, 7681.270279323456, 7751.1861254568585, 7757.4181936355, 5295.232191332312, 5311.68129912191, 5318.494742999409, 5329.1206950852675, 5454.8363549092, 9325.953370233377, 9368.110029547182, 9433.151016408556, 9442.10300021497, 9478.099580539838, 8704.825903481767, 9104.772380690536, 9143.497107659143, 9152.771180720269, 9423.952880235554, 6646.966765166143, 6865.622390768356, 6870.828229294308, 7369.263073692588, 7530.0, 7016.859662806817, 7087.61018144007, 7329.120505539369, 7554.433417493819, 7572.7728168155045, 6686.899696504459, 6962.825929351807, 6989.7553585624255, 7002.124734408199, 7026.543274687129, 6904.067950826574, 6904.965475172592, 6912.412444942236, 6953.026576279426, 6972.163340399185, 6401.7119229633845, 6482.54622176462, 6539.771108011197, 6540.345965403612, 6614.3385661435395, 4554.225781617067, 4647.4655414626395, 4665.230237010991, 4711.740854252912, 4729.597984171246, 4450.844220452269, 4518.277075667877, 4522.253828118455, 4556.498785133566, 4605.723656580616], "value": 4193.750392810394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.91182101280106, 300.54317437495007, 306.7683898656514, 310.5698607428711, 311.47671911189224, 4833.685810422325, 4838.879028024301, 4842.273658951159, 4868.805247790088, 4871.975640121804, 4677.0, 4795.280707893818, 4796.30453584231, 4806.927896081553, 4815.975920120403, 3773.2264885698364, 3819.4652748615217, 3828.770273783575, 3839.6928245740414, 3852.7880966546827, 3829.678760827524, 3830.659269255766, 3833.0, 3839.404892241707, 3851.7111216658723, 3550.5384300041087, 3770.6417890300513, 3790.1093243087853, 3817.790021548814, 3823.1780167264033, 3717.498137751423, 3748.2824951909647, 3763.924721505582, 3773.490578771858, 3787.9053023674355, 3301.290222602128, 3303.587051618548, 3304.884329048472, 3321.0405860542396, 3324.4182268103227, 4699.459562150362, 4715.952840471586, 4735.763211839394, 4737.597304229144, 4753.33453316536, 4102.220578090183, 4316.309390497506, 4317.676174286909, 4334.133173365308, 4339.0, 5071.137906555894, 5077.543021128116, 5079.958608485252, 5106.897862042739, 5114.667546609458, 3620.2035552178477, 3621.8551257949653, 3626.746127771057, 3627.72792040598, 3628.6371362863765, 5067.822626208065, 5297.152455607123, 5313.946860531384, 5328.973355133238, 5329.573634109301, 3673.3387990162028, 3697.6487233712755, 3718.795466249382, 3719.051641831316, 3733.8879833605033, 3740.233252183296, 3752.4746535485056, 3756.7271800560816, 3760.6427389397963, 3765.4540091686554, 4275.978620106879, 4277.379779931893, 4279.16556271524, 4297.957020429756, 4299.312110062375, 4826.879328016757, 5069.923951140736, 5080.949190508121, 5093.286939828427, 5103.948960510347, 1286.6397408725572, 1292.954746583865, 1300.5643109558405, 1300.8959283257507, 1303.2050449225965, 793.5794029164553, 828.1676914700687, 829.8340331933638, 836.460482988469, 840.1724301562956, 3987.4218238355274, 4004.8598299059395, 4011.194962266933, 4020.83916643331, 4036.535798383165, 4620.630349572093, 4646.279826626811, 4647.604953578983, 4647.883802904955, 4692.718436893797, 3960.960390396059, 3974.0, 4033.4756481657196, 4062.2281766464275, 4073.89815254621, 2304.2856714418585, 2437.3784684905236, 2461.815363847719, 2472.8021758259656, 2476.962845557318, 4397.978010109929, 4407.9861631824215, 4427.7639791904885, 4429.734215947054, 4448.599626033672, 4682.9531704683195, 4712.505186955389, 4720.976395118002, 5069.619778516552, 5175.7153356564995, 4788.712677239377, 4948.055906735487, 4976.954839483677, 4984.102861484967, 4997.85006449807, 5206.765695543634, 5213.817516386908, 5222.503862133091, 5228.163493840967, 5243.0, 4838.806447742051, 5101.795928162832, 5128.974355128201, 5171.741412929263, 5191.584673226208, 4992.550670439678, 4993.826450784136, 4995.925061124159, 5014.6991180529285, 5015.874603134951, 3709.8516059357326, 3733.5519737631657, 3733.5706393765063, 3735.4210097434943, 3737.6262373762406, 5033.194688849767, 5218.765155568084, 5219.686818790885, 5259.105951988095, 5271.525562699376, 5075.244319203836, 5079.72061536619, 5093.923591146062, 5108.335916330853, 5111.744412779271, 5079.212722028092, 5097.419799862055, 5097.7960881565805, 5105.28526006352, 5114.33513643224, 4762.76186190696, 5040.949590504195, 5041.773120209673, 5042.84871453857, 5049.5960323174795, 5099.821506247264, 5112.54597793054, 5136.6147538935475, 5141.511556402136, 5146.974265128651, 4996.7001979881325, 5003.674761140514, 5005.399352077774, 5040.697558146523, 5044.200468739885], "value": 3760.9876696208153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.6559631422987, 580.7415700013495, 603.6468665830486, 625.4496043481736, 632.1308201223317, 12460.12779105463, 12546.498140074398, 12838.614841554745, 13515.526956556523, 13518.256495892721, 12028.158028937978, 12146.0, 12248.0, 12262.754744905118, 12270.570530031451, 621.5866448811535, 758.525921299188, 776.5728849132983, 800.6357107516067, 800.9239122283374, 780.1067777394879, 782.4483738964017, 784.274546044909, 785.0500893918337, 785.6582386661792, 838.8532006898769, 840.0591337701783, 840.2815592668272, 840.487302745328, 840.5503055865113, 652.4421619515341, 670.2058061197497, 672.495628278791, 673.1249375811475, 833.8332333533288, 590.9940900590982, 601.7713268957812, 603.7977277611961, 609.1563184988778, 610.4109534299378, 12690.619281421572, 12740.0, 12755.298458584773, 12765.55320563785, 12771.297578633172, 12564.81152782709, 12728.299943503103, 12821.0, 12977.610671679864, 13187.868121318856, 11498.885011149865, 11612.767744645143, 11710.33587862456, 12043.879561204363, 12061.216020958609, 4065.1869626074904, 4068.877933661995, 4106.568810274908, 4234.407182994383, 4236.915261694749, 59662.40337596612, 59683.0, 60021.6998915007, 60432.093518597256, 62650.37349626491, 8948.597313120925, 10523.736906577396, 10563.366198028143, 10568.471576421149, 10601.204909631808, 17667.204975775865, 18781.530461738294, 18890.527736806416, 18901.905490472458, 18910.52723681919, 6512.479001679854, 6547.934520654732, 6672.499562532829, 6685.899711504331, 6697.397234248941, 3649.4160934250394, 3659.8279940223724, 3661.615530369273, 3668.725390258057, 3681.1901381695984, 2799.846008469513, 2885.7258560436726, 2908.3456222350223, 2914.1548950804454, 2914.489964256247, 463.3582488253793, 471.0602348315065, 480.6395203597302, 487.6196566677997, 488.74096728733826, 467.2547287077107, 467.88770695032946, 471.3824889394904, 477.1244765854626, 489.1098201273648, 7074.327938845801, 7097.290270972861, 7131.89302160468, 7139.143302803697, 7218.8917166242545, 389.6960370910694, 415.89394704350195, 428.04118773946135, 428.57142857142856, 479.8560431870425, 3421.2815308784934, 3459.3773120837986, 3468.514407982884, 3468.6011108722314, 3549.290141971616, 81701.59149204334, 94376.52811736034, 96042.51978740061, 96762.0, 97208.51395742976, 81558.59220703976, 84016.15293567676, 84441.0, 84814.57592711996, 85542.0, 75644.62177689186, 77101.61449192718, 77193.0, 77210.84183737249, 77518.0, 6781.728730850711, 6841.144856892888, 6945.548539344926, 6960.129983752031, 7013.789586312419, 44851.775741121084, 45123.0, 45581.0, 46167.538324616326, 47261.29108063313, 57748.0, 57777.0, 64670.0, 66393.0, 68126.0, 7931.524108553505, 7986.3610911128135, 8026.3980201483955, 8044.597770111588, 8069.072056713553, 10324.0, 11675.649730508097, 11715.414229288332, 12044.277343359427, 12654.746905062031, 11228.214025018497, 11634.301941883514, 11671.88328116708, 12317.815232771694, 12319.44562494672, 10882.673519794418, 11179.552817887194, 11218.719532011764, 11822.290662560274, 11847.348395838311, 11404.657860264206, 11504.597339093092, 11849.229800063313, 12283.201591896499, 12481.438335274754, 9998.0, 9999.600015999278, 10034.297599167989, 10280.897191028293, 10293.84559231597, 10044.246681498771, 10053.648122315684, 10242.539085741011, 10385.48072596352, 10461.163106951273], "value": 6296.717608078701, "unit": "score"}], "name": "dromaeo_css", "value": 6300.036958993445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 113.0, 125.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 129.0, 186.0, 122.0, 123.0, 144.0, 127.0, 174.0, 121.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 124.0, 76.0, 78.0, 75.0, 86.0, 102.0, 76.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 114.0, 85.0, 85.0, 85.0, 124.0, 84.0, 84.0, 121.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 125.0, 118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 148.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 63.0, 64.0, 65.0, 64.0, 66.0, 64.0, 65.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 78.0, 79.0, 85.0, 93.0, 78.0, 89.0, 80.0, 87.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 126.0, 127.0, 128.0, 135.0, 129.0, 126.0, 193.0, 129.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 167.0, 165.0, 164.0, 169.0, 168.0, 167.0, 167.0, 166.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 64.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1536.3999999999999, "alertThreshold": 2.0}]} 15:25:54 INFO - Return code: 0 15:25:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:25:54 INFO - # TBPL SUCCESS # 15:25:54 INFO - Running post-action listener: _resource_record_post_action 15:25:54 INFO - ##### 15:25:54 INFO - ##### Finished run-tests step (success) 15:25:54 INFO - ##### 15:25:54 INFO - Running post-run listener: _resource_record_post_run 15:25:54 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548773888; Read time: 12; Write time: 1171168 15:25:54 INFO - TinderboxPrint: CPU usage
13.1% 15:25:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:25:54 INFO - TinderboxPrint: I/O write bytes / time
548,773,888 / 1,171,168 15:25:54 INFO - TinderboxPrint: CPU idle
8,331.6 (86.9%) 15:25:54 INFO - TinderboxPrint: CPU user
1,202.1 (12.5%) 15:25:54 INFO - TinderboxPrint: Swap in / out
0 / 0 15:25:54 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 250540032; Read time: 0; Write time: 718524 15:25:54 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 297619456; Read time: 0; Write time: 452644 15:25:55 INFO - Running post-run listener: _upload_blobber_files 15:25:55 INFO - Blob upload gear active. 15:25:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:25:55 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 15:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:25:55 INFO - (blobuploader) - INFO - Open directory for files ... 15:25:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:25:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:59 INFO - (blobuploader) - INFO - Done attempting. 15:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:59 INFO - (blobuploader) - INFO - Done attempting. 15:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:00 INFO - (blobuploader) - INFO - Done attempting. 15:26:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:26:00 INFO - Return code: 0 15:26:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:26:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:26:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c93178fb87f1e84998949d3546904765575bf3188cd3ae1ce5f8ed30b70577f2af8a96eac7b06b6f521a884c4ca25068ddc4f445670b8d16a079d86c91fe0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f4c24b4a76e80da6cd44a8035cc79855c9ec75c34a4f7774e5aabdea3ad16b1af25cedd7666ad18dc91749c41d5c81a50063968e2ad04e8e471d5f24112e1e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1aeb675de3cd7af11dc07531dbcbed636d939febf538a3bcbfd996e3a4b9098d85f8a267b4b6abf9c33d525f96c5bf512cdacccfb5b3d4c4849585f654f26b92"} 15:26:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:26:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:26:00 INFO - Contents: 15:26:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c93178fb87f1e84998949d3546904765575bf3188cd3ae1ce5f8ed30b70577f2af8a96eac7b06b6f521a884c4ca25068ddc4f445670b8d16a079d86c91fe0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f4c24b4a76e80da6cd44a8035cc79855c9ec75c34a4f7774e5aabdea3ad16b1af25cedd7666ad18dc91749c41d5c81a50063968e2ad04e8e471d5f24112e1e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1aeb675de3cd7af11dc07531dbcbed636d939febf538a3bcbfd996e3a4b9098d85f8a267b4b6abf9c33d525f96c5bf512cdacccfb5b3d4c4849585f654f26b92"} 15:26:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:26:00 INFO - Copying logs to upload dir... 15:26:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:26:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.499152 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-13 15:26:00.360334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:26:00.363400) ========= 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=745a4373a2a16df560f216e000000264-1468447518.509313-1972003190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c93178fb87f1e84998949d3546904765575bf3188cd3ae1ce5f8ed30b70577f2af8a96eac7b06b6f521a884c4ca25068ddc4f445670b8d16a079d86c91fe0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f4c24b4a76e80da6cd44a8035cc79855c9ec75c34a4f7774e5aabdea3ad16b1af25cedd7666ad18dc91749c41d5c81a50063968e2ad04e8e471d5f24112e1e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1aeb675de3cd7af11dc07531dbcbed636d939febf538a3bcbfd996e3a4b9098d85f8a267b4b6abf9c33d525f96c5bf512cdacccfb5b3d4c4849585f654f26b92"} build_url:https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c93178fb87f1e84998949d3546904765575bf3188cd3ae1ce5f8ed30b70577f2af8a96eac7b06b6f521a884c4ca25068ddc4f445670b8d16a079d86c91fe0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f4c24b4a76e80da6cd44a8035cc79855c9ec75c34a4f7774e5aabdea3ad16b1af25cedd7666ad18dc91749c41d5c81a50063968e2ad04e8e471d5f24112e1e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1aeb675de3cd7af11dc07531dbcbed636d939febf538a3bcbfd996e3a4b9098d85f8a267b4b6abf9c33d525f96c5bf512cdacccfb5b3d4c4849585f654f26b92"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:26:00.388131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:26:00.388419) ========= 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=745a4373a2a16df560f216e000000264-1468447518.509313-1972003190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004761 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:26:00.470712) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:26:00.471000) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:26:00.471277) ========= ========= Total master_lag: 0.16 =========