builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1468748454.1 results: success (0) buildid: 20160717011854 builduid: 2c2eb125228b49dd85d0206822a47d5b revision: 23bdc280b66e339a0fe8d5c2e9bfdfc601b01d54 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.097716) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.098193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.098490) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.113297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.113664) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-17 02:40:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-17 02:40:54 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.197075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.197421) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014020 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.247119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.247496) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 23bdc280b66e339a0fe8d5c2e9bfdfc601b01d54 --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 23bdc280b66e339a0fe8d5c2e9bfdfc601b01d54 --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=9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-17 02:40:54,607 truncating revision to first 12 chars 2016-07-17 02:40:54,607 Setting DEBUG logging. 2016-07-17 02:40:54,608 attempt 1/10 2016-07-17 02:40:54,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/23bdc280b66e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 02:40:54,995 unpacking tar archive at: fx-team-23bdc280b66e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736351 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.997482) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.997806) ========= script_repo_revision: 23bdc280b66e339a0fe8d5c2e9bfdfc601b01d54 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.998212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:54.998531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 02:40:55.009746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-17 02:40:55.010141) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:40:55 INFO - MultiFileLogger online at 20160717 02:40:55 in /builds/slave/test 02:40:55 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 02:40:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:40:55 INFO - {'append_to_log': False, 02:40:55 INFO - 'base_work_dir': '/builds/slave/test', 02:40:55 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:40:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:40:55 INFO - 'branch': 'Fx-Team-Non-PGO', 02:40:55 INFO - 'buildbot_json_path': 'buildprops.json', 02:40:55 INFO - 'config_files': ('talos/linux_config.py',), 02:40:55 INFO - 'default_actions': ('clobber', 02:40:55 INFO - 'read-buildbot-config', 02:40:55 INFO - 'download-and-extract', 02:40:55 INFO - 'populate-webroot', 02:40:55 INFO - 'create-virtualenv', 02:40:55 INFO - 'install', 02:40:55 INFO - 'run-tests'), 02:40:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:40:55 INFO - 'download_minidump_stackwalk': True, 02:40:55 INFO - 'download_symbols': 'ondemand', 02:40:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:40:55 INFO - 'tooltool.py': '/tools/tooltool.py', 02:40:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:40:55 INFO - '/tools/misc-python/virtualenv.py')}, 02:40:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:40:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:40:55 INFO - 'installer_path': 'installer.exe', 02:40:55 INFO - 'log_level': 'info', 02:40:55 INFO - 'log_name': 'talos', 02:40:55 INFO - 'log_to_console': True, 02:40:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:40:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:40:55 INFO - 'opt_config_files': (), 02:40:55 INFO - 'pip_index': False, 02:40:55 INFO - 'sps_profile': False, 02:40:55 INFO - 'sps_profile_interval': 0, 02:40:55 INFO - 'suite': 'dromaeojs', 02:40:55 INFO - 'system_bits': '32', 02:40:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:40:55 INFO - 'title': 'talos-linux64-ix-013', 02:40:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:40:55 INFO - 'use_talos_json': True, 02:40:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:40:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:40:55 INFO - 'work_dir': 'build'} 02:40:55 INFO - ##### 02:40:55 INFO - ##### Running clobber step. 02:40:55 INFO - ##### 02:40:55 INFO - Running pre-action listener: _resource_record_pre_action 02:40:55 INFO - Running main action method: clobber 02:40:55 INFO - rmtree: /builds/slave/test/build 02:40:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:40:55 INFO - Running post-action listener: _resource_record_post_action 02:40:55 INFO - ##### 02:40:55 INFO - ##### Finished clobber step (success) 02:40:55 INFO - ##### 02:40:55 INFO - ##### 02:40:55 INFO - ##### Running read-buildbot-config step. 02:40:55 INFO - ##### 02:40:55 INFO - Running pre-action listener: _resource_record_pre_action 02:40:55 INFO - Running main action method: read_buildbot_config 02:40:55 INFO - Using buildbot properties: 02:40:55 INFO - { 02:40:55 INFO - "project": "", 02:40:55 INFO - "product": "firefox", 02:40:55 INFO - "script_repo_revision": "production", 02:40:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:40:55 INFO - "repository": "", 02:40:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:40:55 INFO - "buildid": "20160717011854", 02:40:55 INFO - "pgo_build": "False", 02:40:55 INFO - "basedir": "/builds/slave/test", 02:40:55 INFO - "buildnumber": 1996, 02:40:55 INFO - "slavename": "talos-linux64-ix-013", 02:40:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:40:55 INFO - "platform": "ubuntu64_hw", 02:40:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:40:55 INFO - "branch": "fx-team", 02:40:55 INFO - "repo_path": "integration/fx-team", 02:40:55 INFO - "revision": "23bdc280b66e339a0fe8d5c2e9bfdfc601b01d54", 02:40:55 INFO - "stage_platform": "linux64", 02:40:55 INFO - "builduid": "2c2eb125228b49dd85d0206822a47d5b", 02:40:55 INFO - "slavebuilddir": "test" 02:40:55 INFO - } 02:40:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:40:55 INFO - Running post-action listener: _resource_record_post_action 02:40:55 INFO - ##### 02:40:55 INFO - ##### Finished read-buildbot-config step (success) 02:40:55 INFO - ##### 02:40:55 INFO - ##### 02:40:55 INFO - ##### Running download-and-extract step. 02:40:55 INFO - ##### 02:40:55 INFO - Running pre-action listener: _resource_record_pre_action 02:40:55 INFO - Running main action method: download_and_extract 02:40:55 INFO - mkdir: /builds/slave/test/build/tests 02:40:55 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')]} 02:40:55 INFO - https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:40:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:40:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:40:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:40:56 INFO - Downloaded 1361 bytes. 02:40:56 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:40:56 INFO - Using the following test package requirements: 02:40:56 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:40:56 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:40:56 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:40:56 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:56 INFO - u'jsshell-linux-x86_64.zip'], 02:40:56 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:40:56 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:40:56 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:40:56 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:40:56 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:40:56 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:40:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:56 INFO - https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:40:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:40:57 INFO - Downloaded 22763853 bytes. 02:40:57 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'] 02:40:57 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 02:40:58 INFO - Return code: 0 02:40:58 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 02:40:58 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')]} 02:40:58 INFO - https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:40:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:40:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:41:00 INFO - Downloaded 22763853 bytes. 02:41:00 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'] 02:41:00 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 02:41:01 INFO - Return code: 0 02:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:01 INFO - https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:41:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:41:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:41:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:41:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:41:02 INFO - Downloaded 14403317 bytes. 02:41:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:41:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:41:02 INFO - Return code: 0 02:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:02 INFO - https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:41:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:41:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:41:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:41:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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 02:41:03 INFO - Downloaded 57069020 bytes. 02:41:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:41:03 INFO - mkdir: /builds/slave/test/properties 02:41:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:41:03 INFO - Writing to file /builds/slave/test/properties/build_url 02:41:03 INFO - Contents: 02:41:03 INFO - build_url:https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:41:04 INFO - Running post-action listener: _resource_record_post_action 02:41:04 INFO - Running post-action listener: set_extra_try_arguments 02:41:04 INFO - ##### 02:41:04 INFO - ##### Finished download-and-extract step (success) 02:41:04 INFO - ##### 02:41:04 INFO - ##### 02:41:04 INFO - ##### Running populate-webroot step. 02:41:04 INFO - ##### 02:41:04 INFO - Running pre-action listener: _resource_record_pre_action 02:41:04 INFO - Running main action method: populate_webroot 02:41:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:41:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:41:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:41:04 INFO - '--tppagecycles', 02:41:04 INFO - '7'], 02:41:04 INFO - 'tests': ['tsvgm']}}, 02:41:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:41:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:41:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:41:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:41:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:04 INFO - 'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:04 INFO - 'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['damp', 'tps']}, 02:41:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:04 INFO - 'tests': ['damp', 'tps']}, 02:41:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['dromaeo_dom']}, 02:41:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:41:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['basic_compositor_video']}, 02:41:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:41:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['a11yr', 02:41:04 INFO - 'ts_paint', 02:41:04 INFO - 'tpaint', 02:41:04 INFO - 'sessionrestore', 02:41:04 INFO - 'sessionrestore_no_auto_restore', 02:41:04 INFO - 'tabpaint']}, 02:41:04 INFO - 'other-e10s': {'tests': ['a11yr', 02:41:04 INFO - 'ts_paint', 02:41:04 INFO - 'tpaint', 02:41:04 INFO - 'sessionrestore', 02:41:04 INFO - 'sessionrestore_no_auto_restore', 02:41:04 INFO - 'tabpaint']}, 02:41:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:41:04 INFO - 'ts_paint', 02:41:04 INFO - 'tpaint', 02:41:04 INFO - 'sessionrestore', 02:41:04 INFO - 'sessionrestore_no_auto_restore', 02:41:04 INFO - 'tabpaint']}, 02:41:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:41:04 INFO - 'ts_paint', 02:41:04 INFO - 'tpaint', 02:41:04 INFO - 'sessionrestore', 02:41:04 INFO - 'sessionrestore_no_auto_restore', 02:41:04 INFO - 'tabpaint']}, 02:41:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['a11yr', 02:41:04 INFO - 'ts_paint', 02:41:04 INFO - 'tpaint', 02:41:04 INFO - 'sessionrestore', 02:41:04 INFO - 'sessionrestore_no_auto_restore', 02:41:04 INFO - 'tabpaint']}, 02:41:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['a11yr', 02:41:04 INFO - 'ts_paint', 02:41:04 INFO - 'tpaint', 02:41:04 INFO - 'sessionrestore', 02:41:04 INFO - 'sessionrestore_no_auto_restore', 02:41:04 INFO - 'tabpaint']}, 02:41:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['tsvgx', 02:41:04 INFO - 'tsvgr_opacity', 02:41:04 INFO - 'tart', 02:41:04 INFO - 'tscrollx', 02:41:04 INFO - 'cart']}, 02:41:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:41:04 INFO - 'tsvgr_opacity', 02:41:04 INFO - 'tart', 02:41:04 INFO - 'tscrollx', 02:41:04 INFO - 'cart']}, 02:41:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:04 INFO - 'talos_options': ['--disable-e10s'], 02:41:04 INFO - 'tests': ['tp5o']}, 02:41:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:04 INFO - 'tests': ['tp5o']}, 02:41:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:04 INFO - 'talos_options': ['--disable-e10s', 02:41:04 INFO - '--xperf_path', 02:41:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:04 INFO - 'tests': ['tp5n']}, 02:41:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:04 INFO - 'talos_options': ['--xperf_path', 02:41:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:04 INFO - 'tests': ['tp5n']}}, 02:41:04 INFO - 'talos.zip': {'path': '', 02:41:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:41:04 INFO - Running post-action listener: _resource_record_post_action 02:41:04 INFO - ##### 02:41:04 INFO - ##### Finished populate-webroot step (success) 02:41:04 INFO - ##### 02:41:04 INFO - ##### 02:41:04 INFO - ##### Running create-virtualenv step. 02:41:04 INFO - ##### 02:41:04 INFO - Running pre-action listener: _resource_record_pre_action 02:41:04 INFO - Running main action method: create_virtualenv 02:41:04 INFO - Creating virtualenv /builds/slave/test/build/venv 02:41:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:41:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:41:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:41:04 INFO - Using real prefix '/usr' 02:41:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:41:05 INFO - Installing distribute.............................................................................................................................................................................................done. 02:41:07 INFO - Installing pip.................done. 02:41:07 INFO - Return code: 0 02:41:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e04030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', '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 02:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:41:07 INFO - Using env: {'DISPLAY': ':0', 02:41:07 INFO - 'HOME': '/home/cltbld', 02:41:07 INFO - 'LANG': 'en_US.UTF-8', 02:41:07 INFO - 'LANGUAGE': 'en_US:en', 02:41:07 INFO - 'LOGNAME': 'cltbld', 02:41:07 INFO - 'MAIL': '/var/mail/cltbld', 02:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:07 INFO - 'MOZ_NO_REMOTE': '1', 02:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:07 INFO - 'NO_EM_RESTART': '1', 02:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:07 INFO - 'PWD': '/builds/slave/test', 02:41:07 INFO - 'SHELL': '/bin/bash', 02:41:07 INFO - 'SHLVL': '1', 02:41:07 INFO - 'TERM': 'linux', 02:41:07 INFO - 'TMOUT': '86400', 02:41:07 INFO - 'USER': 'cltbld', 02:41:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:07 INFO - '_': '/tools/buildbot/bin/python'} 02:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:41:07 INFO - Cleaning up... 02:41:07 INFO - Return code: 0 02:41:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e04030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', '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 02:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:41:07 INFO - Using env: {'DISPLAY': ':0', 02:41:07 INFO - 'HOME': '/home/cltbld', 02:41:07 INFO - 'LANG': 'en_US.UTF-8', 02:41:07 INFO - 'LANGUAGE': 'en_US:en', 02:41:07 INFO - 'LOGNAME': 'cltbld', 02:41:07 INFO - 'MAIL': '/var/mail/cltbld', 02:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:07 INFO - 'MOZ_NO_REMOTE': '1', 02:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:07 INFO - 'NO_EM_RESTART': '1', 02:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:07 INFO - 'PWD': '/builds/slave/test', 02:41:07 INFO - 'SHELL': '/bin/bash', 02:41:07 INFO - 'SHLVL': '1', 02:41:07 INFO - 'TERM': 'linux', 02:41:07 INFO - 'TMOUT': '86400', 02:41:07 INFO - 'USER': 'cltbld', 02:41:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:07 INFO - '_': '/tools/buildbot/bin/python'} 02:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:07 INFO - Downloading/unpacking psutil>=3.1.1 02:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:41:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:09 INFO - Installing collected packages: psutil 02:41:09 INFO - Running setup.py install for psutil 02:41:09 INFO - building 'psutil._psutil_linux' extension 02:41:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:41:09 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 02:41:09 INFO - building 'psutil._psutil_posix' extension 02:41:09 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 02:41:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:41:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:10 INFO - Successfully installed psutil 02:41:10 INFO - Cleaning up... 02:41:10 INFO - Return code: 0 02:41:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e04030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', '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 02:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:41:10 INFO - Using env: {'DISPLAY': ':0', 02:41:10 INFO - 'HOME': '/home/cltbld', 02:41:10 INFO - 'LANG': 'en_US.UTF-8', 02:41:10 INFO - 'LANGUAGE': 'en_US:en', 02:41:10 INFO - 'LOGNAME': 'cltbld', 02:41:10 INFO - 'MAIL': '/var/mail/cltbld', 02:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:10 INFO - 'MOZ_NO_REMOTE': '1', 02:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:10 INFO - 'NO_EM_RESTART': '1', 02:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:10 INFO - 'PWD': '/builds/slave/test', 02:41:10 INFO - 'SHELL': '/bin/bash', 02:41:10 INFO - 'SHLVL': '1', 02:41:10 INFO - 'TERM': 'linux', 02:41:10 INFO - 'TMOUT': '86400', 02:41:10 INFO - 'USER': 'cltbld', 02:41:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:10 INFO - '_': '/tools/buildbot/bin/python'} 02:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:41:12 INFO - Installing collected packages: mozsystemmonitor 02:41:12 INFO - Running setup.py install for mozsystemmonitor 02:41:12 INFO - Successfully installed mozsystemmonitor 02:41:12 INFO - Cleaning up... 02:41:12 INFO - Return code: 0 02:41:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e04030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', '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 02:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:41:12 INFO - Using env: {'DISPLAY': ':0', 02:41:12 INFO - 'HOME': '/home/cltbld', 02:41:12 INFO - 'LANG': 'en_US.UTF-8', 02:41:12 INFO - 'LANGUAGE': 'en_US:en', 02:41:12 INFO - 'LOGNAME': 'cltbld', 02:41:12 INFO - 'MAIL': '/var/mail/cltbld', 02:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:12 INFO - 'MOZ_NO_REMOTE': '1', 02:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:12 INFO - 'NO_EM_RESTART': '1', 02:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:12 INFO - 'PWD': '/builds/slave/test', 02:41:12 INFO - 'SHELL': '/bin/bash', 02:41:12 INFO - 'SHLVL': '1', 02:41:12 INFO - 'TERM': 'linux', 02:41:12 INFO - 'TMOUT': '86400', 02:41:12 INFO - 'USER': 'cltbld', 02:41:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:12 INFO - '_': '/tools/buildbot/bin/python'} 02:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:12 INFO - Downloading/unpacking jsonschema==2.5.1 02:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:41:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:14 INFO - Downloading functools32-3.2.3-2.tar.gz 02:41:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:41:14 INFO - warning: no files found matching '*.txt' 02:41:14 INFO - no previously-included directories found matching 'build' 02:41:14 INFO - no previously-included directories found matching 'dist' 02:41:14 INFO - no previously-included directories found matching '.git*' 02:41:14 INFO - Installing collected packages: jsonschema, functools32 02:41:14 INFO - Running setup.py install for functools32 02:41:15 INFO - warning: no files found matching '*.txt' 02:41:15 INFO - no previously-included directories found matching 'build' 02:41:15 INFO - no previously-included directories found matching 'dist' 02:41:15 INFO - no previously-included directories found matching '.git*' 02:41:15 INFO - Successfully installed jsonschema functools32 02:41:15 INFO - Cleaning up... 02:41:15 INFO - Return code: 0 02:41:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e04030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', '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 02:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:41:15 INFO - Using env: {'DISPLAY': ':0', 02:41:15 INFO - 'HOME': '/home/cltbld', 02:41:15 INFO - 'LANG': 'en_US.UTF-8', 02:41:15 INFO - 'LANGUAGE': 'en_US:en', 02:41:15 INFO - 'LOGNAME': 'cltbld', 02:41:15 INFO - 'MAIL': '/var/mail/cltbld', 02:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:15 INFO - 'MOZ_NO_REMOTE': '1', 02:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:15 INFO - 'NO_EM_RESTART': '1', 02:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:15 INFO - 'PWD': '/builds/slave/test', 02:41:15 INFO - 'SHELL': '/bin/bash', 02:41:15 INFO - 'SHLVL': '1', 02:41:15 INFO - 'TERM': 'linux', 02:41:15 INFO - 'TMOUT': '86400', 02:41:15 INFO - 'USER': 'cltbld', 02:41:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:15 INFO - '_': '/tools/buildbot/bin/python'} 02:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:15 INFO - Downloading/unpacking blobuploader==1.2.4 02:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:17 INFO - Downloading blobuploader-1.2.4.tar.gz 02:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:41:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:41:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:17 INFO - Downloading docopt-0.6.1.tar.gz 02:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:41:18 INFO - Installing collected packages: blobuploader, requests, docopt 02:41:18 INFO - Running setup.py install for blobuploader 02:41:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:41:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:41:18 INFO - Running setup.py install for requests 02:41:18 INFO - Running setup.py install for docopt 02:41:18 INFO - Successfully installed blobuploader requests docopt 02:41:18 INFO - Cleaning up... 02:41:18 INFO - Return code: 0 02:41:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e04030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', '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 02:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:18 INFO - Using env: {'DISPLAY': ':0', 02:41:18 INFO - 'HOME': '/home/cltbld', 02:41:18 INFO - 'LANG': 'en_US.UTF-8', 02:41:18 INFO - 'LANGUAGE': 'en_US:en', 02:41:18 INFO - 'LOGNAME': 'cltbld', 02:41:18 INFO - 'MAIL': '/var/mail/cltbld', 02:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:18 INFO - 'MOZ_NO_REMOTE': '1', 02:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:18 INFO - 'NO_EM_RESTART': '1', 02:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:18 INFO - 'PWD': '/builds/slave/test', 02:41:18 INFO - 'SHELL': '/bin/bash', 02:41:18 INFO - 'SHLVL': '1', 02:41:18 INFO - 'TERM': 'linux', 02:41:18 INFO - 'TMOUT': '86400', 02:41:18 INFO - 'USER': 'cltbld', 02:41:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:18 INFO - '_': '/tools/buildbot/bin/python'} 02:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:18 INFO - Running setup.py (path:/tmp/pip-x5slPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:18 INFO - Running setup.py (path:/tmp/pip-sqDyhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:18 INFO - Running setup.py (path:/tmp/pip-hvyetL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:19 INFO - Running setup.py (path:/tmp/pip-1WE1f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:19 INFO - Running setup.py (path:/tmp/pip-wPAOpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:19 INFO - Running setup.py (path:/tmp/pip-_Wkr0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:19 INFO - Running setup.py (path:/tmp/pip-EC19WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:19 INFO - Running setup.py (path:/tmp/pip-IOxLDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:19 INFO - Running setup.py (path:/tmp/pip-wwl2Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:19 INFO - Running setup.py (path:/tmp/pip-w7MMBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:19 INFO - Running setup.py (path:/tmp/pip-7eQ8ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:19 INFO - Running setup.py (path:/tmp/pip-XjUH5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:19 INFO - Running setup.py (path:/tmp/pip-aSg6bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:19 INFO - Running setup.py (path:/tmp/pip-blhebB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:19 INFO - Running setup.py (path:/tmp/pip-YjN2Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:19 INFO - Running setup.py (path:/tmp/pip-8r0u6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:19 INFO - Running setup.py (path:/tmp/pip-D1PZXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:41:20 INFO - Running setup.py install for manifestparser 02:41:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:41:20 INFO - Running setup.py install for mozcrash 02:41:20 INFO - Running setup.py install for mozdebug 02:41:20 INFO - Running setup.py install for mozdevice 02:41:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:41:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:41:20 INFO - Running setup.py install for mozfile 02:41:20 INFO - Running setup.py install for mozhttpd 02:41:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:41:20 INFO - Running setup.py install for mozinfo 02:41:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:41:20 INFO - Running setup.py install for mozInstall 02:41:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:41:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:41:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:41:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:41:20 INFO - Running setup.py install for mozleak 02:41:20 INFO - Running setup.py install for mozlog 02:41:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Running setup.py install for moznetwork 02:41:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Running setup.py install for mozprocess 02:41:21 INFO - Running setup.py install for mozprofile 02:41:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Running setup.py install for mozrunner 02:41:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Running setup.py install for mozscreenshot 02:41:21 INFO - Running setup.py install for moztest 02:41:21 INFO - Running setup.py install for mozversion 02:41:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:41:21 INFO - Cleaning up... 02:41:21 INFO - Return code: 0 02:41:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e04030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', '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 02:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:21 INFO - Using env: {'DISPLAY': ':0', 02:41:21 INFO - 'HOME': '/home/cltbld', 02:41:21 INFO - 'LANG': 'en_US.UTF-8', 02:41:21 INFO - 'LANGUAGE': 'en_US:en', 02:41:21 INFO - 'LOGNAME': 'cltbld', 02:41:21 INFO - 'MAIL': '/var/mail/cltbld', 02:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:21 INFO - 'MOZ_NO_REMOTE': '1', 02:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:21 INFO - 'NO_EM_RESTART': '1', 02:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:21 INFO - 'PWD': '/builds/slave/test', 02:41:21 INFO - 'SHELL': '/bin/bash', 02:41:21 INFO - 'SHLVL': '1', 02:41:21 INFO - 'TERM': 'linux', 02:41:21 INFO - 'TMOUT': '86400', 02:41:21 INFO - 'USER': 'cltbld', 02:41:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:21 INFO - '_': '/tools/buildbot/bin/python'} 02:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:22 INFO - Running setup.py (path:/tmp/pip-Hq5OoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:22 INFO - Running setup.py (path:/tmp/pip-7kkreD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:22 INFO - Running setup.py (path:/tmp/pip-oJymFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:22 INFO - Running setup.py (path:/tmp/pip-apQJGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:22 INFO - Running setup.py (path:/tmp/pip-NsMm6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:22 INFO - Running setup.py (path:/tmp/pip-3AAHCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:22 INFO - Running setup.py (path:/tmp/pip-XzmgLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:22 INFO - Running setup.py (path:/tmp/pip-IlATlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:22 INFO - Running setup.py (path:/tmp/pip-v69QJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:22 INFO - Running setup.py (path:/tmp/pip-nP7xuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:22 INFO - Running setup.py (path:/tmp/pip-0sLVRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:22 INFO - Running setup.py (path:/tmp/pip-ntOnks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:22 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)) 02:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:22 INFO - Running setup.py (path:/tmp/pip-Si1RbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:23 INFO - Running setup.py (path:/tmp/pip-gsQRz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:23 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)) 02:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:23 INFO - Running setup.py (path:/tmp/pip-fmmJYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:23 INFO - Running setup.py (path:/tmp/pip-vj3mQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:23 INFO - Running setup.py (path:/tmp/pip-SN9uiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:25 INFO - Downloading blessings-1.6.tar.gz 02:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:41:25 INFO - Installing collected packages: blessings 02:41:25 INFO - Running setup.py install for blessings 02:41:25 INFO - Successfully installed blessings 02:41:25 INFO - Cleaning up... 02:41:25 INFO - Return code: 0 02:41:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:41:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:25 INFO - Reading from file tmpfile_stdout 02:41:25 INFO - Current package versions: 02:41:25 INFO - argparse == 1.2.1 02:41:25 INFO - blessings == 1.6 02:41:25 INFO - blobuploader == 1.2.4 02:41:25 INFO - docopt == 0.6.1 02:41:25 INFO - functools32 == 3.2.3-2 02:41:25 INFO - jsonschema == 2.5.1 02:41:25 INFO - manifestparser == 1.1 02:41:25 INFO - mozInstall == 1.12 02:41:25 INFO - mozcrash == 0.17 02:41:25 INFO - mozdebug == 0.1 02:41:25 INFO - mozdevice == 0.48 02:41:25 INFO - mozfile == 1.2 02:41:25 INFO - mozhttpd == 0.7 02:41:25 INFO - mozinfo == 0.9 02:41:25 INFO - mozleak == 0.1 02:41:25 INFO - mozlog == 3.2 02:41:25 INFO - moznetwork == 0.27 02:41:25 INFO - mozprocess == 0.23 02:41:25 INFO - mozprofile == 0.28 02:41:25 INFO - mozrunner == 6.12 02:41:25 INFO - mozscreenshot == 0.1 02:41:25 INFO - mozsystemmonitor == 0.3 02:41:25 INFO - moztest == 0.7 02:41:25 INFO - mozversion == 1.4 02:41:25 INFO - psutil == 3.1.1 02:41:25 INFO - requests == 1.2.3 02:41:25 INFO - wsgiref == 0.1.2 02:41:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41: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')]} 02:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41: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')]} 02:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e04030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', '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 02:41:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:25 INFO - Using env: {'DISPLAY': ':0', 02:41:25 INFO - 'HOME': '/home/cltbld', 02:41:25 INFO - 'LANG': 'en_US.UTF-8', 02:41:25 INFO - 'LANGUAGE': 'en_US:en', 02:41:25 INFO - 'LOGNAME': 'cltbld', 02:41:25 INFO - 'MAIL': '/var/mail/cltbld', 02:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:25 INFO - 'MOZ_NO_REMOTE': '1', 02:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:25 INFO - 'NO_EM_RESTART': '1', 02:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:25 INFO - 'PWD': '/builds/slave/test', 02:41:25 INFO - 'SHELL': '/bin/bash', 02:41:25 INFO - 'SHLVL': '1', 02:41:25 INFO - 'TERM': 'linux', 02:41:25 INFO - 'TMOUT': '86400', 02:41:25 INFO - 'USER': 'cltbld', 02:41:25 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:25 INFO - '_': '/tools/buildbot/bin/python'} 02:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:41:25 INFO - Cleaning up... 02:41:25 INFO - Return code: 0 02:41:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:41: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')]} 02:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41: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')]} 02:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:25 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 0x1e04030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', '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 02:41:25 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 02:41:25 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 02:41:25 INFO - Using env: {'DISPLAY': ':0', 02:41:25 INFO - 'HOME': '/home/cltbld', 02:41:25 INFO - 'LANG': 'en_US.UTF-8', 02:41:25 INFO - 'LANGUAGE': 'en_US:en', 02:41:25 INFO - 'LOGNAME': 'cltbld', 02:41:25 INFO - 'MAIL': '/var/mail/cltbld', 02:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:25 INFO - 'MOZ_NO_REMOTE': '1', 02:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:25 INFO - 'NO_EM_RESTART': '1', 02:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:25 INFO - 'PWD': '/builds/slave/test', 02:41:25 INFO - 'SHELL': '/bin/bash', 02:41:25 INFO - 'SHLVL': '1', 02:41:25 INFO - 'TERM': 'linux', 02:41:25 INFO - 'TMOUT': '86400', 02:41:25 INFO - 'USER': 'cltbld', 02:41:25 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:25 INFO - '_': '/tools/buildbot/bin/python'} 02:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:41:26 INFO - Cleaning up... 02:41:26 INFO - Return code: 0 02:41:26 INFO - Running post-action listener: _resource_record_post_action 02:41:26 INFO - Running post-action listener: _start_resource_monitoring 02:41:26 INFO - Starting resource monitoring. 02:41:26 INFO - ##### 02:41:26 INFO - ##### Finished create-virtualenv step (success) 02:41:26 INFO - ##### 02:41:26 INFO - ##### 02:41:26 INFO - ##### Running install step. 02:41:26 INFO - ##### 02:41:26 INFO - Running pre-action listener: _resource_record_pre_action 02:41:26 INFO - Running main action method: install 02:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:26 INFO - Reading from file tmpfile_stdout 02:41:26 INFO - Detecting whether we're running mozinstall >=1.0... 02:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:41:26 INFO - Reading from file tmpfile_stdout 02:41:26 INFO - Output received: 02:41:26 INFO - Usage: mozinstall [options] installer 02:41:26 INFO - Options: 02:41:26 INFO - -h, --help show this help message and exit 02:41:26 INFO - -d DEST, --destination=DEST 02:41:26 INFO - Directory to install application into. [default: 02:41:26 INFO - "/builds/slave/test"] 02:41:26 INFO - --app=APP Application being installed. [default: firefox] 02:41:26 INFO - mkdir: /builds/slave/test/build/application 02:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:41:42 INFO - Reading from file tmpfile_stdout 02:41:42 INFO - Output received: 02:41:42 INFO - /builds/slave/test/build/application/firefox/firefox 02:41:42 INFO - Running post-action listener: _resource_record_post_action 02:41:42 INFO - ##### 02:41:42 INFO - ##### Finished install step (success) 02:41:42 INFO - ##### 02:41:42 INFO - ##### 02:41:42 INFO - ##### Running run-tests step. 02:41:42 INFO - ##### 02:41:42 INFO - Running pre-action listener: _resource_record_pre_action 02:41:42 INFO - Running main action method: run_tests 02:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:41:42 INFO - Python 2.7.3 02:41:42 INFO - Return code: 0 02:41:42 INFO - grabbing minidump binary from tooltool 02:41: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')]} 02:41:42 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 0x20c33b0>, '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 0x20c42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:41:42 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 02:41:42 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 02:41:42 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 02:41:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:41:42 INFO - Return code: 0 02:41:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:41:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:41:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:41:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:41:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:41:42 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/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:41:42 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/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 02:41:42 INFO - Using env: {'DISPLAY': ':0', 02:41:42 INFO - 'HOME': '/home/cltbld', 02:41:42 INFO - 'LANG': 'en_US.UTF-8', 02:41:42 INFO - 'LANGUAGE': 'en_US:en', 02:41:42 INFO - 'LOGNAME': 'cltbld', 02:41:42 INFO - 'MAIL': '/var/mail/cltbld', 02:41:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:41:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:42 INFO - 'MOZ_NO_REMOTE': '1', 02:41:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:42 INFO - 'NO_EM_RESTART': '1', 02:41:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:42 INFO - 'PWD': '/builds/slave/test', 02:41:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:41:42 INFO - 'SHELL': '/bin/bash', 02:41:42 INFO - 'SHLVL': '1', 02:41:42 INFO - 'TERM': 'linux', 02:41:42 INFO - 'TMOUT': '86400', 02:41:42 INFO - 'USER': 'cltbld', 02:41:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215', 02:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:42 INFO - '_': '/tools/buildbot/bin/python'} 02:41:42 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/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:41:43 INFO - mozversion application_buildid: 20160717011854 02:41:43 INFO - mozversion application_changeset: 23bdc280b66e339a0fe8d5c2e9bfdfc601b01d54 02:41:43 INFO - mozversion application_display_name: Nightly 02:41:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:41:43 INFO - mozversion application_name: Firefox 02:41:43 INFO - mozversion application_remotingname: firefox 02:41:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:41:43 INFO - mozversion application_vendor: Mozilla 02:41:43 INFO - mozversion application_version: 50.0a1 02:41:43 INFO - mozversion platform_buildid: 20160717011854 02:41:43 INFO - mozversion platform_changeset: 23bdc280b66e339a0fe8d5c2e9bfdfc601b01d54 02:41:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:41:43 INFO - mozversion platform_version: 50.0a1 02:41:43 INFO - using testdate: 1468748503 02:41:43 INFO - actual date: 1468748503 02:41:43 INFO - starting webserver on 'localhost:40814' 02:41:43 INFO - SUITE-START | Running 2 tests 02:41:43 INFO - TEST-START | dromaeo_css 02:41:43 INFO - operating with platform_type : linux_ 02:41:43 INFO - Initialising browser for dromaeo_css test... 02:41:43 INFO - TEST-INFO | started process 8270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuNFWYs/profile http://localhost:40814/getInfo.html) 02:41:46 INFO - PROCESS | 8270 | JavaScript error: , line 0: uncaught exception: undefined 02:41:47 INFO - PROCESS | 8270 | __metrics Screen width/height:1600/1200 02:41:47 INFO - PROCESS | 8270 | colorDepth:24 02:41:47 INFO - PROCESS | 8270 | Browser inner width/height: 1024/697 02:41:47 INFO - PROCESS | 8270 | __metrics 02:41:48 INFO - PROCESS | 8270 | 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" 02:41:48 INFO - PROCESS | 8270 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:41:48 INFO - PROCESS | 8270 | console.error: PushService: 02:41:48 INFO - PROCESS | 8270 | stateChangeProcessEnqueue: Error transitioning state 02:41:48 INFO - PROCESS | 8270 | UnknownError 02:41:49 INFO - TEST-INFO | 8270: exit 0 02:41:49 INFO - Browser initialized. 02:41:49 INFO - Running cycle 1/1 for dromaeo_css test... 02:41:49 INFO - TEST-INFO | started process 8354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuNFWYs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:01 INFO - PROCESS | 8354 | RSS: Main: 159465472 02:42:01 INFO - PROCESS | 8354 | 02:42:52 INFO - PROCESS | 8354 | 1468748572254 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] 02:45:06 INFO - PROCESS | 8354 | Cycle 1(1): loaded http://localhost:40814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40814/tests/dromaeo/cssquery-ext.html) 02:45:07 INFO - PROCESS | 8354 | RSS: Main: 269082624 02:45:07 INFO - PROCESS | 8354 | 02:48:10 INFO - PROCESS | 8354 | Cycle 1(1): loaded http://localhost:40814/tests/dromaeo/cssquery-ext.html (next: http://localhost:40814/tests/dromaeo/cssquery-jquery.html) 02:48:11 INFO - PROCESS | 8354 | RSS: Main: 240754688 02:48:11 INFO - PROCESS | 8354 | 02:51:13 INFO - PROCESS | 8354 | Cycle 1(1): loaded http://localhost:40814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40814/tests/dromaeo/cssquery-mootools.html) 02:51:13 INFO - PROCESS | 8354 | RSS: Main: 240492544 02:51:13 INFO - PROCESS | 8354 | 02:54:16 INFO - PROCESS | 8354 | Cycle 1(1): loaded http://localhost:40814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40814/tests/dromaeo/cssquery-prototype.html) 02:54:16 INFO - PROCESS | 8354 | RSS: Main: 241442816 02:54:16 INFO - PROCESS | 8354 | 02:57:19 INFO - PROCESS | 8354 | Cycle 1(1): loaded http://localhost:40814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40814/tests/dromaeo/cssquery-yui.html) 02:57:20 INFO - PROCESS | 8354 | RSS: Main: 216162304 02:57:20 INFO - PROCESS | 8354 | 03:00:23 INFO - PROCESS | 8354 | Cycle 1(1): loaded http://localhost:40814/tests/dromaeo/cssquery-yui.html (next: http://localhost:40814/tests/dromaeo/cssquery-dojo.html) 03:00:23 INFO - PROCESS | 8354 | RSS: Main: 330874880 03:00:23 INFO - PROCESS | 8354 | 03:00:23 INFO - PROCESS | 8354 | __start_tp_report 03:00:23 INFO - PROCESS | 8354 | _x_x_mozilla_page_load 03:00:23 INFO - PROCESS | 8354 | _x_x_mozilla_page_load_details 03:00:23 INFO - PROCESS | 8354 | |i|pagename|runs| 03:00:23 INFO - PROCESS | 8354 | |0;dojo.html;2655.3627129488927;2656.163308557803;2699.136276391555;2706.9458610827796;2717.7689896358806;4636.7681615919155;4748.074125545516;4750;4884.365032545768;4905.117078925792;4758.52414758524;4773.331733557305;4780.378550788401;4813.49458306878;4838.540338667821;4328.783560821947;4364.694471387004;4420.9336859947125;4451.732896026248;4459.777011149446;4426.867193984185;4444.666650001247;4467.441569803775;4469.08383781324;4501.032278060216;4245.193413251503;4276.700630955835;4284.550122237151;4339.262325404688;4340.110277393127;4369.759663218521;4381.78091095444;4394.1651086293505;4431.7119387240045;4432.645388368923;4407.338899165119;4429.734215947021;4437.356583295436;4439.112177564468;4476.350929115292;4608.953910460919;4736.313234581001;4749.810007599692;4775.785089670973;4812.711237325771;5092;5124.5131712487255;5134.743262836843;5181.896362072737;5195.428502864682;5140.691558506502;5199.454057323965;5243.4232234454175;5245.86885327866;5255.737213139366;4635.675502714845;4708.128996135726;4708.223143181337;4742.9762851186215;4807.687500312469;5176.275321454999;5194.662346947436;5226.242194881797;5226.5818734501145;5228.92156617651;4840.056189043103;4998.975005125024;5016.2224855147515;5064.215046667772;5079.288899554065;4994.475580064113;5030.673006254582;5050.696958182521;5108.463611320833;5123.3339665843205;5040.546350828443;5049.798008079709;5050.924236136461;5055.772490237948;5082.872928176826;4981.352424184833;4989.55094041538;5000.224965130411;5001.44984051754;5015.3730783652045;3920.2355540669296;3950.249452603996;3955.6835453164254;4005.839766409311;4007.8196481158416;3523.9956612365863;3581.7313701472494;3598.460230965376;3611.8194090295906;3688.4098544232793;4385.254506733863;4390.8902277442685;4398.714083584557;4442.911141777146;4443;5106.463821298785;5139.743012849342;5146.897062058738;5148.613853960893;5153.510416510426;4269.082147338338;4306.5262821089655;4317.697761156752;4327.394164816928;4369.868903932887;4599.241125214302;4599.494055653875;4602.88492787683;4608.631309495232;4656.208444564432;4716.882077948078;4780.163471392562;4781.617470602413;4787.329773831597;4790.329353890388;5071.112555302881;5112.3865136183895;5121.8975620486635;5140.511651393112;5146.485351464824;4805.519448055166;4810.4708482067645;4825.059113472839;4829.468758436499;4881.121398148367;4932.4327702314695;4975.029869175476;5053.31780209667;5069.340985671839;5114.360704911886;5043.9243411348125;5115.948840511547;5129.051125541638;5147.279380886754;5171.81898633546;4968.130577148912;4977.950220497749;4983.825566105169;5000.924986125284;5029.59763218949;4766.737829419277;4952;4970.279309500174;4992.900141997213;5044.369453818273;4943.159662857395;4969.527894849984;4987.975060124676;4996.975015124901;4998.2502624606595;5032.6980381177245;5037.395512538519;5042.722650254272;5056.418511871182;5109.080365534091;4671.649626277975;4843.200871856105;4873.731944743073;4881.365422495053;4921.507849215193 03:00:23 INFO - PROCESS | 8354 | |1;ext.html;554.9248401882412;575.8071046199523;579.4350508254452;580.05161560848;598.410565592891;27106.728932710666;29671.703282967163;29757.553636695466;40387.59612403875;41309.380359294635;41812;42185;42250.78874605623;42264.57735422645;42277.36583951243;7390.778276651709;7764.689412423496;7903;7908.920910790905;7909;7441.776746697581;7676.577788221645;7679.884801727979;9927.305088643798;10204.285700001003;10202.642907498239;10271.28101032928;10286.897131028707;10290;10290.588376464932;10088.192944564416;10090.293679442406;10137.695869123938;10155.949220253926;10165.339252948535;7449.962750186269;9617.326787124905;9966.850497242547;9970.700878973643;10313.381197128196;39967.40048899269;39970;40228.59771402278;40250.39624405636;40276.59723402758;2826.703196164394;2859.4281143771327;2890.2340879666904;2915.300327921305;2953.3945541164226;30151.547726784116;30676.2330941726;30851.845740771376;31362.21594460134;31589.052328430185;3343.2477692519233;3394.6096198937194;3418.7948723076697;3437.8371897854036;3455.378031954247;277001;277716;278000;278291;278920;32373.676263237066;56510.717446412506;57567;57660.42339576551;57671.71164144152;32509.18727031843;34497.310053798785;34742.47886281708;34749.82625086858;34819.82590087033;12352.691182720324;12387.69030774238;12405.75188496225;12429.875701243052;12454.626361209179;9701.951490242503;11065.446727663584;11082.335059896432;11137.944310278559;11168.553257869595;7812.68749250035;7989.081255655674;8014.078380986261;8145.144759800254;8209;2972.524396096614;3026.9848650756603;3029.909102726922;3048.527478240876;3068.432340017104;874.8600223964136;895.6014573514724;930.5672862119147;959.827231098395;960.9615615375307;27742.722572774015;28997.275068123043;29018.41963160767;29267.560986585217;29582.112536623936;912.5665308978315;956.2350119904188;964.0793042644258;976.62888102522;1011.2298163793479;15245.3901843925;15448.768268475756;15544.76682849758;15589.142597157039;15635.530934071996;397949;405955;407644;409179;410723;49916.75041624768;50228.49771502238;50232;50302.24546631803;50383.24425133626;1065.7122576904349;1125.150511363915;1171.6485054483792;1185.4428418643224;1199.0407673860877;25761.355966100997;29816.70183298139;29958;29974.70025299719;30001.54997674993;43401;43918.780406097765;43926;43942.780286098365;43974.560254398326;320367;327724;328561;328891;329346;25238.621420679072;26024.479510409306;26030.479390412464;27288.863555682095;27925;43156.56843431525;43342.133157336044;43418.78290608527;44047.33928991132;44727.32909006302;36455.27089458249;36616.63383366132;37081.443778343884;37132;37659.62340376561;37258.813705931294;37980;38116;38148.80925595354;38189.61810381972;36540.451893222154;36818.631813682594;37164.25671486609;37346.25307493889;37366.439503408015;29653.851730741208;32148.19629509281;34482.48276275908;34489;34781.826090869385;25226.36934076663;25919.22242332733;25933.740662593886;25944.8702756485;26462.603060953716 03:00:23 INFO - PROCESS | 8354 | |2;jquery.html;344.7949416788325;373.5610657477464;375.24201113750223;375.5212104566677;392.02972642709295;12874.29191394473;16336;16391.918040409797;17238.138093095356;18229.0885455727;16256.105914174716;16572.668546629062;17659.117044147806;17687.204075816586;17947.371841985532;4253.787310634471;4986.975065124679;5116.2069879168785;5123.692578445305;5123.897522049557;5010.073136469747;5053.823116190934;5070.74646267687;5076.416212135597;5077.873053173664;4875.658703890729;5045.34410526631;5064.215046667772;5074.441811400761;5080.110980578403;5000.749962501878;5010.549050585447;5010.774515146791;5014.874628134289;5019.64862459628;4338.414314067623;4492.707973981681;4523.547645235483;4527.139843429771;4536.614387777043;21293.36119916405;21455.892720536296;21629.24297649575;22199.889000554893;22200.666989995163;1961.1076959983316;1975.9308424205083;2022.090059473243;2192.3642143778284;2327.697399338092;8787;9426.434413935185;11558.711032224177;13367.131136476099;13858.722825543433;1741.6255505066472;1758.2878934031737;1758.5251981964798;1766.9558261043449;1818.6271814278173;65575;72275.63862180708;72425;73355;73811;8901.73294801157;9408.858867116998;9824.852627210597;10068.093871551595;10528.789424211473;12787.744245115045;13550.796738048937;13555.661108472366;14056.508022219174;14066.85933140676;6957.339052790078;7135.785926422215;7195.409652525087;7212.567245965154;7261.5280006799385;6385.233771947396;6507.934920650828;6509.1863517060365;6638.900416493757;6761.019652150509;4395.099004704028;4424.756638384855;4442.68500878342;4462.754548499864;4496.572825581565;1713.3917459302018;1766.6201766620238;1778.1642627964836;1799.073477159264;1831.8900865948085;801.2828518475932;828.4987582512614;859.0764927702744;868.1101870582703;868.7220089571402;16181.838181618268;17274.395396161075;17499.38752143669;17825.197866096056;18049.909750451425;863.9092895246034;865.3769286113987;869.1786261982365;872.6291326186346;895.8163576466809;9332.906670933204;9626.759331016641;9830.557624906896;9838;9873.160781333523;397300;401094;401310;414604;419781;47947.280790788165;48764.51235487671;50126;54702.72648636731;88390.55804720936;940.8165407745424;945.5555888732284;949.2358651285781;975.6780262513354;995.721198064543;15832;16039.358425662842;16073.75889361684;16111.838881611502;16239.756403653719;27810.72189278162;38628.22743545169;39601.405978910916;39727.2054558913;40098.59901400949;51435.48564514307;52855;53040;53735.73132134314;54807.725961369935;7112.679929403086;7311.561306321638;9964.352317099656;10050.798984020132;10684.198685098803;10952.452377381258;11224.887751122384;11719.941400292944;11748.823767643322;12001.879981200425;10151.137153341753;10216.948915255376;10230.693079207636;10489.947550262199;10543.736406589896;9989.500524973868;10062.094411503;10218.693439196835;10317.27779055489;10491.318064325795;10149.137323327599;10247.948760256151;10303.021212984755;10500.107490863362;10762.946185269024;10388.636397726043;10457.790844182922;10820.729481763019;10834.67495975122;11000.944995274973;9808.509574521102;10072.798544028932;10203.693889183336;10242.436665983443;10405.635802746867 03:00:23 INFO - PROCESS | 8354 | |3;mootools.html;1323.7617228898794;1395.5743498233037;1415.5399495164074;1633;1653.9834601653988;7499.175090740021;7960.203979602037;8040.718574849881;8060.758177254685;8065.4354195206215;6812.386885180333;7018.894716579255;7509.249075092502;7723.266289702469;7921.960390198041;2218.367765186926;2251.0883092347626;2253.9323820285335;2254.582902163097;2255.052877791323;1877.3710806879644;1992.183204885997;2030.0763152765455;2072.616565935299;2073.5956488484753;2077.314486219544;2153.472399262183;2155.181031208139;2170.8588941718817;2173.576152650234;2137.1665050630268;2146.8175205107586;2150.946226344346;2180.7928246816527;2188.5075857931997;2045.089934978935;2056.670932650769;2065.8863762493056;2067.555475572744;2068.5759419319156;8090.635921383493;8142.022957245109;8151.144129866338;8151.225633564802;8153.1846815317995;4430.069685366077;4552.954470455286;4563.133004729091;4564.064366804831;4565.338025986247;2790.204791634395;2854.5004624190683;2911.9953616002445;2917.9270518237213;2922.7515661168613;867.7960679240374;873.2664561768082;888.2050564744582;890.7728529225006;890.9109089091104;10840.186985976005;10854.511546980404;10861.18541109412;10866.076383507412;10876.728081798019;4082.510098788164;4159.147374788161;4311.892202694895;4338.848140315137;4341.956580434218;9243.584038718274;9324.90675093254;9326.90673093274;9330.533473326306;9332.300077494216;4681.32120842476;4682.227432473672;4682.836100736526;4686.929696054562;4688.929666055012;4193.916121677549;4273.102648443862;4276.87169384919;4282.336237883071;4283.550227226158;3660.9816950915606;3679.8712045078296;3710.666040056408;3754.9436758448646;3758.285925674113;1085.451846817368;1163.5113252433998;1186.5135294529202;1201.2852352850216;1203.0676225924979;750.2722359311459;751.9511231769917;770.3606007014165;778.6496076765478;789.542065601961;5247.501487358695;5337.119375303031;5463.69949652765;5629.605927585111;5724.227229324071;871.1506281375608;871.5511511571419;877.7103555826562;882.1883866842392;922.1239822168966;3541.256336169382;3543.4153364694535;3555.804430756333;3576.7853928764357;3589.748717589796;9692.660756873476;9916.057974492413;9919.504024798876;10086.344387614781;10118.089371956412;9679;9854.408735475894;9904.702858914245;9914.752131196634;9927.851082233772;7319.74380896666;7332.816679583053;7451.701931922662;7468.775936721907;7476;4990.326305948795;5218.582513398843;5298.523132918056;5301.23132145829;5345.22494238341;9060.456372617664;9172.54137293146;9208.723738287863;9224.677136300197;9286.34995550332;9094.818103637757;9439.575219115293;9543.713688589354;9544.093311135432;9550.617975280911;6419.101325814297;6507.73969041252;6509.316521765336;6510.251321098134;6621.437177839937;7429.368503677032;7486.6256687166515;7517;7518.812029699301;7521.360684341892;6680.198376194888;6786.355296246848;6838.965805170942;6922;6935.895961560682;6648.102506161799;6737.9326206737305;6748.898766518408;6825.726970921108;6922.238553759184;5794;6034.63792172471;6038.69806509664;6122.846928826815;6174.38256174379;4392.494863090786;4470.396496472935;4511.210538155744;4520.276755719069;4622.884427889329;4688.2733176357715;4700.388949436551;4713.528647135259;4748.857534273978;4814.20565606671 03:00:23 INFO - PROCESS | 8354 | |4;prototype.html;300.7038067503509;305.2216847040049;309.151379463373;309.7785083665179;310.399377205108;4910.98649553683;4948.268106162841;4956.603471722263;4956.925646115311;4967.640370823857;4895.11887860185;4916.213405855064;4918.458969513351;4919.212925931843;4921.311016457699;3689.8339574719134;3756.586775454698;3819;3874.341361968472;3875.8255878485393;3798.202377500714;3848.7113466489986;3850.8652197173105;3852.84588616455;3865.091703449687;3799.7910114943666;3816.503854498911;3835.1179228777396;3837.6546110850018;3870.283997460479;3684.7420680552373;3729.832157552903;3823.9044023899346;3830.9616903830884;3848.3457812171996;3400.846961886696;3401.9829900850586;3405.897823065312;3411.6076651184935;3415.351083294166;4793.496682848286;4809.807607695688;4848.5636292733825;4853.126437241295;4863.732494712789;4128.587141285878;4363.258246098171;4375.321825117112;4382.780860956971;4433.401490798766;5151.974240128813;5153.1963812665645;5156.716380599066;5180.559652429548;5185.792568297264;3676.9080772980888;3679.9448008279896;3687.3731465650903;3689.1699367642336;3696.057505336122;5092.516210959953;5415.756290966916;5451.291332126838;5460.071787796084;5472.863178420532;3713.925721485555;3715.479832823407;3719.702423806089;3750.6061863504483;3762.811859407019;3784.9810750946067;3808.7143464240294;3815.1797363566966;3818.560865500503;3825.4261860721112;4348.239058164809;4358.760268185217;4392.538783427694;4399.076193999296;4405.207062728676;5033.194688849767;5103.489651034867;5141.2288156776785;5149.485051494896;5152.969406118791;1287.6458973782098;1296.9157004794658;1298.8311519502593;1302.6547964789338;1309.3829121035515;807.567951146134;828.8561784737025;830.7632324787406;835.9832803343899;867.6616119713317;4449.57729015743;4469.173202957463;4469.955300447019;4479.417675702203;4485.573870482299;5217.843464696065;5230.450802665665;5234.502722241381;5245.269061209868;5255.894882102337;4350.303951367766;4437.622802061861;4446.9777651111535;4453.821847126079;4457.465104187453;2765.1980925531775;2774.4312415954682;2790.483760504313;2801.453716525258;2829.7877659175642;4893.926591101136;4923.876903077452;4974.403071631427;4977.352944117314;4995.801007758112;5177.663451875616;5321.441248668912;5322.946770532245;5403.891922161535;5404.162354835007;4920.065187614342;4922.529616620274;4929.338157395038;4952.826651067196;4964.329815474937;5184.196449550326;5210.47895210476;5212.817551385683;5224.190250511177;5260.736963151904;4969.527894849984;5120.590352771695;5130.5639020682165;5132.46109158533;5138.409082955508;4906.705597664151;4912.680675756064;4927.926081108858;4936.2102063669645;4968.652194346361;3742.7567208131386;3762.793046382366;3763.6800871925097;3766.1714422826935;3775.6601905828607;5072.873178170576;5240.218325769257;5249.7112658804135;5314.458806945942;5326.680399176062;5017.494751574586;5022.246663000579;5026.321446604661;5050.474762618691;5057.949420505748;4992.580082643256;5012.348394708664;5034.697918124924;5047.192449208109;5080.949190508048;4781.378420805412;4953.380827396575;4956;4980.975095124501;4993.6254780892305;4918.163912135017;5013.674111182761;5129.435762066244;5167.405748338989;5171.767270472913;5037.168867136881;5040.067587496325;5042.520960508746;5053.140966035856;5055 03:00:23 INFO - PROCESS | 8354 | |5;yui.html;610.3743662745683;618.4155972605888;637.5568979559207;681.5195287322438;742.9116344555225;12870.742585148304;13594.252316122609;13982.30088495575;14014.579562613126;14018.789718154236;13331.266780327078;13359.131656442325;13455.865441345584;13471.259080750555;13483.797743033861;624.0576729138987;768.7040489411575;776.9300762931335;785.5443842571295;794.6185830801219;804.8470790549777;806.2219957740779;808.5431731071955;809.0049239435498;810.6352141536303;836.7991681996308;837.7403005068418;837.9162083791603;838.6854929401475;838.6980686952692;644.7324360390433;790.9604519774045;807.5356669914764;810.5622963599649;828.1387357148558;599.286848650105;600.8858316919772;602.1479606357;604.0094245437487;605.2102006881018;13188.802167967488;13197.538086167035;13228.86771132286;13229.933850330783;13258.602241932758;12481.31352775597;12889.355532223444;12897.67755806103;12921.741565168739;13247.867521324759;11623.418829058597;11675.591354302644;11712.837533865893;11716.414179291087;12026.458809353513;3815.1606646537716;3834.5206849143856;3872.883813485572;3885.0870045539277;3997.1006523531973;59206.783287755025;59211.815763684914;59479;59564.70217648927;59592.70203648954;9827.508624568885;9899.554520046615;10074.546645400975;10101.747456313651;10409.5836166554;19400.126994285292;19455.416337509898;19466.610667786565;19540;19605.31381401644;6702.564333318319;6821.488388370892;6897.517173797786;6907;6978.930210697929;3610.98194509031;3636.0546257972587;3662.5788034375855;3683.171286460525;3710;2824.8163869348427;2947.5578663200263;3161.0832858470785;3309.5201195826953;3320.1367644412626;432.38169417732945;535.8419266316446;536.5466181076984;537.7687594334395;540.1115165552644;494.90844193824256;528.698641774185;604.5465900574569;607.4077774170237;622.5362105231541;8255;8340;8426.831463370698;8458;8568.186022327869;554.0857584984807;558.7094710750387;585.4759989809097;598.2342601470125;599.4994179859779;3873.1672690371142;4114.506259248849;4158.688098392633;4173.91652166961;4223.083329593036;100801.49599252103;102770.48614757028;105178.4741076305;107665;108144;67006;68365.31634683689;69646.30353696398;81826.59086704528;83034.16965830386;53144.734276329145;74881.62559187169;75269.24730752732;76400.23599764043;77774;8630.439021463584;8680.91319086801;8721.345899057469;9002.729918102468;9038.954805225932;45217.32174017327;45628;45876.77061614671;46199.76900115478;46236.53763462322;66443.66778166078;66489.66755166193;66691;67244.6637766808;67936.6603166981;10302.690919272434;10589.311694739818;10764.461776910966;10828.296160749525;11520.711982200512;13087.345632718136;13210.180012414648;13237.89095625273;13668.179909205479;13827.79258311106;11991.280523168638;12019.819702704292;12249.203801752858;12250.019998399928;12608.747825043265;11778.882211177779;11803.940980295043;11961.461734221806;12188.268703877795;12213.267203967791;11699.415029248334;11998.04015678761;12021.699457513632;12256;12408.503659853504;9462.581417648227;9729.124378805658;9857.063578959987;9914.355566888129;9931.553080111556;9648.75878103053;9814.072256468775;10483.633072842415;10588.735281618021;10733.141348692243 03:00:23 INFO - PROCESS | 8354 | __end_tp_report 03:00:23 INFO - PROCESS | 8354 | __start_cc_report 03:00:23 INFO - PROCESS | 8354 | _x_x_mozilla_cycle_collect,1004 03:00:23 INFO - PROCESS | 8354 | __end_cc_report 03:00:23 INFO - PROCESS | 8354 | __startTimestamp1468749623416__endTimestamp 03:00:23 INFO - PROCESS | 8354 | 03:00:23 INFO - PROCESS | 8354 | ------- Summary: start ------- 03:00:23 INFO - PROCESS | 8354 | Number of tests: 6 03:00:23 INFO - PROCESS | 8354 | 03:00:23 INFO - PROCESS | 8354 | [#0] dojo.html Cycles:165 Average:4701.42 Median:4829.47 stddev:517.73 (10.7%) stddev-sans-first:493.81 03:00:23 INFO - PROCESS | 8354 | Values: 2655.4 2656.2 2699.1 2706.9 2717.8 4636.8 4748.1 4750.0 4884.4 4905.1 4758.5 4773.3 4780.4 4813.5 4838.5 4328.8 4364.7 4420.9 4451.7 4459.8 4426.9 4444.7 4467.4 4469.1 4501.0 4245.2 4276.7 4284.6 4339.3 4340.1 4369.8 4381.8 4394.2 4431.7 4432.6 4407.3 4429.7 4437.4 4439.1 4476.4 4609.0 4736.3 4749.8 4775.8 4812.7 5092.0 5124.5 5134.7 5181.9 5195.4 5140.7 5199.5 5243.4 5245.9 5255.7 4635.7 4708.1 4708.2 4743.0 4807.7 5176.3 5194.7 5226.2 5226.6 5228.9 4840.1 4999.0 5016.2 5064.2 5079.3 4994.5 5030.7 5050.7 5108.5 5123.3 5040.5 5049.8 5050.9 5055.8 5082.9 4981.4 4989.6 5000.2 5001.4 5015.4 3920.2 3950.2 3955.7 4005.8 4007.8 3524.0 3581.7 3598.5 3611.8 3688.4 4385.3 4390.9 4398.7 4442.9 4443.0 5106.5 5139.7 5146.9 5148.6 5153.5 4269.1 4306.5 4317.7 4327.4 4369.9 4599.2 4599.5 4602.9 4608.6 4656.2 4716.9 4780.2 4781.6 4787.3 4790.3 5071.1 5112.4 5121.9 5140.5 5146.5 4805.5 4810.5 4825.1 4829.5 4881.1 4932.4 4975.0 5053.3 5069.3 5114.4 5043.9 5115.9 5129.1 5147.3 5171.8 4968.1 4978.0 4983.8 5000.9 5029.6 4766.7 4952.0 4970.3 4992.9 5044.4 4943.2 4969.5 4988.0 4997.0 4998.3 5032.7 5037.4 5042.7 5056.4 5109.1 4671.6 4843.2 4873.7 4881.4 4921.5 03:00:23 INFO - PROCESS | 8354 | 03:00:23 INFO - PROCESS | 8354 | [#1] ext.html Cycles:180 Average:48443.45 Median:18976.34 stddev:90015.40 (474.4%) stddev-sans-first:90196.10 03:00:23 INFO - PROCESS | 8354 | Values: 554.9 575.8 579.4 580.1 598.4 27106.7 29671.7 29757.6 40387.6 41309.4 41812.0 42185.0 42250.8 42264.6 42277.4 7390.8 7764.7 7903.0 7908.9 7909.0 7441.8 7676.6 7679.9 9927.3 10204.3 10202.6 10271.3 10286.9 10290.0 10290.6 10088.2 10090.3 10137.7 10155.9 10165.3 7450.0 9617.3 9966.9 9970.7 10313.4 39967.4 39970.0 40228.6 40250.4 40276.6 2826.7 2859.4 2890.2 2915.3 2953.4 30151.5 30676.2 30851.8 31362.2 31589.1 3343.2 3394.6 3418.8 3437.8 3455.4 277001.0 277716.0 278000.0 278291.0 278920.0 32373.7 56510.7 57567.0 57660.4 57671.7 32509.2 34497.3 34742.5 34749.8 34819.8 12352.7 12387.7 12405.8 12429.9 12454.6 9702.0 11065.4 11082.3 11137.9 11168.6 7812.7 7989.1 8014.1 8145.1 8209.0 2972.5 3027.0 3029.9 3048.5 3068.4 874.9 895.6 930.6 959.8 961.0 27742.7 28997.3 29018.4 29267.6 29582.1 912.6 956.2 964.1 976.6 1011.2 15245.4 15448.8 15544.8 15589.1 15635.5 397949.0 405955.0 407644.0 409179.0 410723.0 49916.8 50228.5 50232.0 50302.2 50383.2 1065.7 1125.2 1171.6 1185.4 1199.0 25761.4 29816.7 29958.0 29974.7 30001.5 43401.0 43918.8 43926.0 43942.8 43974.6 320367.0 327724.0 328561.0 328891.0 329346.0 25238.6 26024.5 26030.5 27288.9 27925.0 43156.6 43342.1 43418.8 44047.3 44727.3 36455.3 36616.6 37081.4 37132.0 37659.6 37258.8 37980.0 38116.0 38148.8 38189.6 36540.5 36818.6 37164.3 37346.3 37366.4 29653.9 32148.2 34482.5 34489.0 34781.8 25226.4 25919.2 25933.7 25944.9 26462.6 03:00:23 INFO - PROCESS | 8354 | 03:00:23 INFO - PROCESS | 8354 | [#2] jquery.html Cycles:180 Average:24538.89 Median:220596.30 stddev:66843.75 (30.3%) stddev-sans-first:67006.58 03:00:23 INFO - PROCESS | 8354 | Values: 344.8 373.6 375.2 375.5 392.0 12874.3 16336.0 16391.9 17238.1 18229.1 16256.1 16572.7 17659.1 17687.2 17947.4 4253.8 4987.0 5116.2 5123.7 5123.9 5010.1 5053.8 5070.7 5076.4 5077.9 4875.7 5045.3 5064.2 5074.4 5080.1 5000.7 5010.5 5010.8 5014.9 5019.6 4338.4 4492.7 4523.5 4527.1 4536.6 21293.4 21455.9 21629.2 22199.9 22200.7 1961.1 1975.9 2022.1 2192.4 2327.7 8787.0 9426.4 11558.7 13367.1 13858.7 1741.6 1758.3 1758.5 1767.0 1818.6 65575.0 72275.6 72425.0 73355.0 73811.0 8901.7 9408.9 9824.9 10068.1 10528.8 12787.7 13550.8 13555.7 14056.5 14066.9 6957.3 7135.8 7195.4 7212.6 7261.5 6385.2 6507.9 6509.2 6638.9 6761.0 4395.1 4424.8 4442.7 4462.8 4496.6 1713.4 1766.6 1778.2 1799.1 1831.9 801.3 828.5 859.1 868.1 868.7 16181.8 17274.4 17499.4 17825.2 18049.9 863.9 865.4 869.2 872.6 895.8 9332.9 9626.8 9830.6 9838.0 9873.2 397300.0 401094.0 401310.0 414604.0 419781.0 47947.3 48764.5 50126.0 54702.7 88390.6 940.8 945.6 949.2 975.7 995.7 15832.0 16039.4 16073.8 16111.8 16239.8 27810.7 38628.2 39601.4 39727.2 40098.6 51435.5 52855.0 53040.0 53735.7 54807.7 7112.7 7311.6 9964.4 10050.8 10684.2 10952.5 11224.9 11719.9 11748.8 12001.9 10151.1 10216.9 10230.7 10489.9 10543.7 9989.5 10062.1 10218.7 10317.3 10491.3 10149.1 10247.9 10303.0 10500.1 10762.9 10388.6 10457.8 10820.7 10834.7 11000.9 9808.5 10072.8 10203.7 10242.4 10405.6 03:00:23 INFO - PROCESS | 8354 | 03:00:23 INFO - PROCESS | 8354 | [#3] mootools.html Cycles:180 Average:5187.79 Median:5299.88 stddev:2961.06 (55.9%) stddev-sans-first:2955.13 03:00:23 INFO - PROCESS | 8354 | Values: 1323.8 1395.6 1415.5 1633.0 1654.0 7499.2 7960.2 8040.7 8060.8 8065.4 6812.4 7018.9 7509.2 7723.3 7922.0 2218.4 2251.1 2253.9 2254.6 2255.1 1877.4 1992.2 2030.1 2072.6 2073.6 2077.3 2153.5 2155.2 2170.9 2173.6 2137.2 2146.8 2150.9 2180.8 2188.5 2045.1 2056.7 2065.9 2067.6 2068.6 8090.6 8142.0 8151.1 8151.2 8153.2 4430.1 4553.0 4563.1 4564.1 4565.3 2790.2 2854.5 2912.0 2917.9 2922.8 867.8 873.3 888.2 890.8 890.9 10840.2 10854.5 10861.2 10866.1 10876.7 4082.5 4159.1 4311.9 4338.8 4342.0 9243.6 9324.9 9326.9 9330.5 9332.3 4681.3 4682.2 4682.8 4686.9 4688.9 4193.9 4273.1 4276.9 4282.3 4283.6 3661.0 3679.9 3710.7 3754.9 3758.3 1085.5 1163.5 1186.5 1201.3 1203.1 750.3 752.0 770.4 778.6 789.5 5247.5 5337.1 5463.7 5629.6 5724.2 871.2 871.6 877.7 882.2 922.1 3541.3 3543.4 3555.8 3576.8 3589.7 9692.7 9916.1 9919.5 10086.3 10118.1 9679.0 9854.4 9904.7 9914.8 9927.9 7319.7 7332.8 7451.7 7468.8 7476.0 4990.3 5218.6 5298.5 5301.2 5345.2 9060.5 9172.5 9208.7 9224.7 9286.3 9094.8 9439.6 9543.7 9544.1 9550.6 6419.1 6507.7 6509.3 6510.3 6621.4 7429.4 7486.6 7517.0 7518.8 7521.4 6680.2 6786.4 6839.0 6922.0 6935.9 6648.1 6737.9 6748.9 6825.7 6922.2 5794.0 6034.6 6038.7 6122.8 6174.4 4392.5 4470.4 4511.2 4520.3 4622.9 4688.3 4700.4 4713.5 4748.9 4814.2 03:00:23 INFO - PROCESS | 8354 | 03:00:23 INFO - PROCESS | 8354 | [#4] prototype.html Cycles:180 Average:4248.20 Median:4914.45 stddev:1229.05 (25.0%) stddev-sans-first:1196.25 03:00:23 INFO - PROCESS | 8354 | Values: 300.7 305.2 309.2 309.8 310.4 4911.0 4948.3 4956.6 4956.9 4967.6 4895.1 4916.2 4918.5 4919.2 4921.3 3689.8 3756.6 3819.0 3874.3 3875.8 3798.2 3848.7 3850.9 3852.8 3865.1 3799.8 3816.5 3835.1 3837.7 3870.3 3684.7 3729.8 3823.9 3831.0 3848.3 3400.8 3402.0 3405.9 3411.6 3415.4 4793.5 4809.8 4848.6 4853.1 4863.7 4128.6 4363.3 4375.3 4382.8 4433.4 5152.0 5153.2 5156.7 5180.6 5185.8 3676.9 3679.9 3687.4 3689.2 3696.1 5092.5 5415.8 5451.3 5460.1 5472.9 3713.9 3715.5 3719.7 3750.6 3762.8 3785.0 3808.7 3815.2 3818.6 3825.4 4348.2 4358.8 4392.5 4399.1 4405.2 5033.2 5103.5 5141.2 5149.5 5153.0 1287.6 1296.9 1298.8 1302.7 1309.4 807.6 828.9 830.8 836.0 867.7 4449.6 4469.2 4470.0 4479.4 4485.6 5217.8 5230.5 5234.5 5245.3 5255.9 4350.3 4437.6 4447.0 4453.8 4457.5 2765.2 2774.4 2790.5 2801.5 2829.8 4893.9 4923.9 4974.4 4977.4 4995.8 5177.7 5321.4 5322.9 5403.9 5404.2 4920.1 4922.5 4929.3 4952.8 4964.3 5184.2 5210.5 5212.8 5224.2 5260.7 4969.5 5120.6 5130.6 5132.5 5138.4 4906.7 4912.7 4927.9 4936.2 4968.7 3742.8 3762.8 3763.7 3766.2 3775.7 5072.9 5240.2 5249.7 5314.5 5326.7 5017.5 5022.2 5026.3 5050.5 5057.9 4992.6 5012.3 5034.7 5047.2 5080.9 4781.4 4953.4 4956.0 4981.0 4993.6 4918.2 5013.7 5129.4 5167.4 5171.8 5037.2 5040.1 5042.5 5053.1 5055.0 03:00:23 INFO - PROCESS | 8354 | 03:00:23 INFO - PROCESS | 8354 | [#5] yui.html Cycles:180 Average:17849.88 Median:46218.15 stddev:25289.41 (54.7%) stddev-sans-first:25327.22 03:00:23 INFO - PROCESS | 8354 | Values: 610.4 618.4 637.6 681.5 742.9 12870.7 13594.3 13982.3 14014.6 14018.8 13331.3 13359.1 13455.9 13471.3 13483.8 624.1 768.7 776.9 785.5 794.6 804.8 806.2 808.5 809.0 810.6 836.8 837.7 837.9 838.7 838.7 644.7 791.0 807.5 810.6 828.1 599.3 600.9 602.1 604.0 605.2 13188.8 13197.5 13228.9 13229.9 13258.6 12481.3 12889.4 12897.7 12921.7 13247.9 11623.4 11675.6 11712.8 11716.4 12026.5 3815.2 3834.5 3872.9 3885.1 3997.1 59206.8 59211.8 59479.0 59564.7 59592.7 9827.5 9899.6 10074.5 10101.7 10409.6 19400.1 19455.4 19466.6 19540.0 19605.3 6702.6 6821.5 6897.5 6907.0 6978.9 3611.0 3636.1 3662.6 3683.2 3710.0 2824.8 2947.6 3161.1 3309.5 3320.1 432.4 535.8 536.5 537.8 540.1 494.9 528.7 604.5 607.4 622.5 8255.0 8340.0 8426.8 8458.0 8568.2 554.1 558.7 585.5 598.2 599.5 3873.2 4114.5 4158.7 4173.9 4223.1 100801.5 102770.5 105178.5 107665.0 108144.0 67006.0 68365.3 69646.3 81826.6 83034.2 53144.7 74881.6 75269.2 76400.2 77774.0 8630.4 8680.9 8721.3 9002.7 9039.0 45217.3 45628.0 45876.8 46199.8 46236.5 66443.7 66489.7 66691.0 67244.7 67936.7 10302.7 10589.3 10764.5 10828.3 11520.7 13087.3 13210.2 13237.9 13668.2 13827.8 11991.3 12019.8 12249.2 12250.0 12608.7 11778.9 11803.9 11961.5 12188.3 12213.3 11699.4 11998.0 12021.7 12256.0 12408.5 9462.6 9729.1 9857.1 9914.4 9931.6 9648.8 9814.1 10483.6 10588.7 10733.1 03:00:23 INFO - PROCESS | 8354 | -------- Summary: end -------- 03:00:23 INFO - PROCESS | 8354 | 03:00:24 INFO - TEST-INFO | 8354: exit 0 03:00:24 INFO - TEST-OK | dromaeo_css | took 1121183ms 03:00:24 INFO - TEST-START | kraken 03:00:24 INFO - operating with platform_type : linux_ 03:00:24 INFO - Initialising browser for kraken test... 03:00:24 INFO - TEST-INFO | started process 8541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplf6Tq8/profile http://localhost:40814/getInfo.html) 03:00:27 INFO - PROCESS | 8541 | JavaScript error: , line 0: uncaught exception: undefined 03:00:28 INFO - PROCESS | 8541 | __metrics Screen width/height:1600/1200 03:00:28 INFO - PROCESS | 8541 | colorDepth:24 03:00:28 INFO - PROCESS | 8541 | Browser inner width/height: 1024/697 03:00:28 INFO - PROCESS | 8541 | __metrics 03:00:29 INFO - PROCESS | 8541 | 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" 03:00:29 INFO - PROCESS | 8541 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:00:29 INFO - PROCESS | 8541 | console.error: PushService: 03:00:29 INFO - PROCESS | 8541 | stateChangeProcessEnqueue: Error transitioning state 03:00:29 INFO - PROCESS | 8541 | UnknownError 03:00:30 INFO - TEST-INFO | 8541: exit 0 03:00:30 INFO - Browser initialized. 03:00:30 INFO - Running cycle 1/1 for kraken test... 03:00:30 INFO - TEST-INFO | started process 8625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplf6Tq8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:42 INFO - PROCESS | 8625 | RSS: Main: 159977472 03:00:42 INFO - PROCESS | 8625 | 03:00:45 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40814/tests/kraken/driver.html?testName=audio-beat-detection) 03:00:46 INFO - PROCESS | 8625 | RSS: Main: 219082752 03:00:46 INFO - PROCESS | 8625 | 03:00:48 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40814/tests/kraken/driver.html?testName=audio-dft) 03:00:49 INFO - PROCESS | 8625 | RSS: Main: 205615104 03:00:49 INFO - PROCESS | 8625 | 03:00:52 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40814/tests/kraken/driver.html?testName=audio-fft) 03:00:53 INFO - PROCESS | 8625 | RSS: Main: 273080320 03:00:53 INFO - PROCESS | 8625 | 03:00:55 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40814/tests/kraken/driver.html?testName=audio-oscillator) 03:00:56 INFO - PROCESS | 8625 | RSS: Main: 182677504 03:00:56 INFO - PROCESS | 8625 | 03:00:58 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:00:59 INFO - PROCESS | 8625 | RSS: Main: 185708544 03:00:59 INFO - PROCESS | 8625 | 03:01:02 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40814/tests/kraken/driver.html?testName=imaging-darkroom) 03:01:02 INFO - PROCESS | 8625 | RSS: Main: 222560256 03:01:02 INFO - PROCESS | 8625 | 03:01:06 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40814/tests/kraken/driver.html?testName=imaging-desaturate) 03:01:06 INFO - PROCESS | 8625 | RSS: Main: 218357760 03:01:06 INFO - PROCESS | 8625 | 03:01:09 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40814/tests/kraken/driver.html?testName=json-parse-financial) 03:01:10 INFO - PROCESS | 8625 | RSS: Main: 221220864 03:01:10 INFO - PROCESS | 8625 | 03:01:12 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:01:12 INFO - PROCESS | 8625 | RSS: Main: 211603456 03:01:12 INFO - PROCESS | 8625 | 03:01:14 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40814/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:01:15 INFO - PROCESS | 8625 | RSS: Main: 215183360 03:01:15 INFO - PROCESS | 8625 | 03:01:17 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:01:18 INFO - PROCESS | 8625 | RSS: Main: 211460096 03:01:18 INFO - PROCESS | 8625 | 03:01:20 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:01:21 INFO - PROCESS | 8625 | RSS: Main: 225665024 03:01:21 INFO - PROCESS | 8625 | 03:01:24 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:01:24 INFO - PROCESS | 8625 | RSS: Main: 224731136 03:01:24 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | Cycle 1(1): loaded http://localhost:40814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40814/tests/kraken/driver.html?testName=ai-astar) 03:01:26 INFO - PROCESS | 8625 | RSS: Main: 266694656 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | __start_tp_report 03:01:26 INFO - PROCESS | 8625 | _x_x_mozilla_page_load 03:01:26 INFO - PROCESS | 8625 | _x_x_mozilla_page_load_details 03:01:26 INFO - PROCESS | 8625 | |i|pagename|runs| 03:01:26 INFO - PROCESS | 8625 | |0;ai-astar;105;115;116;115;113;114;113;114;113;113 03:01:26 INFO - PROCESS | 8625 | |1;audio-beat-detection;150;120;121;179;122;127;147;132;165;125 03:01:26 INFO - PROCESS | 8625 | |2;audio-dft;161;160;161;162;163;161;161;161;161;161 03:01:26 INFO - PROCESS | 8625 | |3;audio-fft;75;80;76;109;77;78;75;76;99;76 03:01:26 INFO - PROCESS | 8625 | |4;audio-oscillator;85;85;123;84;85;84;120;84;85;135 03:01:26 INFO - PROCESS | 8625 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 03:01:26 INFO - PROCESS | 8625 | |6;imaging-darkroom;146;147;145;145;147;146;146;145;146;147 03:01:26 INFO - PROCESS | 8625 | |7;imaging-desaturate;96;96;95;95;95;95;96;95;95;95 03:01:26 INFO - PROCESS | 8625 | |8;json-parse-financial;63;63;62;62;63;63;70;62;63;62 03:01:26 INFO - PROCESS | 8625 | |9;json-stringify-tinderbox;66;66;65;66;66;66;66;65;67;65 03:01:26 INFO - PROCESS | 8625 | |10;stanford-crypto-aes;78;80;79;79;79;78;78;84;79;77 03:01:26 INFO - PROCESS | 8625 | |11;stanford-crypto-ccm;132;126;136;128;128;126;133;127;172;131 03:01:26 INFO - PROCESS | 8625 | |12;stanford-crypto-pbkdf2;163;161;161;165;167;166;165;165;164;167 03:01:26 INFO - PROCESS | 8625 | |13;stanford-crypto-sha256-iterative;68;68;68;67;65;65;65;65;68;64 03:01:26 INFO - PROCESS | 8625 | __end_tp_report 03:01:26 INFO - PROCESS | 8625 | __start_cc_report 03:01:26 INFO - PROCESS | 8625 | _x_x_mozilla_cycle_collect,1920 03:01:26 INFO - PROCESS | 8625 | __end_cc_report 03:01:26 INFO - PROCESS | 8625 | __startTimestamp1468749686874__endTimestamp 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | ------- Summary: start ------- 03:01:26 INFO - PROCESS | 8625 | Number of tests: 14 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.03 (2.7%) stddev-sans-first:1.12 03:01:26 INFO - PROCESS | 8625 | Values: 105.0 115.0 116.0 115.0 113.0 114.0 113.0 114.0 113.0 113.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:139.50 stddev:20.61 (14.8%) stddev-sans-first:21.46 03:01:26 INFO - PROCESS | 8625 | Values: 150.0 120.0 121.0 179.0 122.0 127.0 147.0 132.0 165.0 125.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:01:26 INFO - PROCESS | 8625 | Values: 161.0 160.0 161.0 162.0 163.0 161.0 161.0 161.0 161.0 161.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.50 stddev:11.87 (15.5%) stddev-sans-first:12.31 03:01:26 INFO - PROCESS | 8625 | Values: 75.0 80.0 76.0 109.0 77.0 78.0 75.0 76.0 99.0 76.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:84.50 stddev:20.36 (24.1%) stddev-sans-first:21.13 03:01:26 INFO - PROCESS | 8625 | Values: 85.0 85.0 123.0 84.0 85.0 84.0 120.0 84.0 85.0 135.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:01:26 INFO - PROCESS | 8625 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 03:01:26 INFO - PROCESS | 8625 | Values: 146.0 147.0 145.0 145.0 147.0 146.0 146.0 145.0 146.0 147.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:01:26 INFO - PROCESS | 8625 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.00 stddev:2.41 (3.8%) stddev-sans-first:2.55 03:01:26 INFO - PROCESS | 8625 | Values: 63.0 63.0 62.0 62.0 63.0 63.0 70.0 62.0 63.0 62.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 03:01:26 INFO - PROCESS | 8625 | Values: 66.0 66.0 65.0 66.0 66.0 66.0 66.0 65.0 67.0 65.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:1.91 (2.4%) stddev-sans-first:1.99 03:01:26 INFO - PROCESS | 8625 | Values: 78.0 80.0 79.0 79.0 79.0 78.0 78.0 84.0 79.0 77.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:131.50 stddev:13.79 (10.5%) stddev-sans-first:14.61 03:01:26 INFO - PROCESS | 8625 | Values: 132.0 126.0 136.0 128.0 128.0 126.0 133.0 127.0 172.0 131.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.00 stddev:2.17 (1.3%) stddev-sans-first:2.24 03:01:26 INFO - PROCESS | 8625 | Values: 163.0 161.0 161.0 165.0 167.0 166.0 165.0 165.0 164.0 167.0 03:01:26 INFO - PROCESS | 8625 | 03:01:26 INFO - PROCESS | 8625 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.50 stddev:1.64 (2.4%) stddev-sans-first:1.62 03:01:26 INFO - PROCESS | 8625 | Values: 68.0 68.0 68.0 67.0 65.0 65.0 65.0 65.0 68.0 64.0 03:01:26 INFO - PROCESS | 8625 | -------- Summary: end -------- 03:01:26 INFO - PROCESS | 8625 | 03:01:27 INFO - TEST-INFO | 8625: exit 0 03:01:28 INFO - TEST-OK | kraken | took 63763ms 03:01:28 INFO - SUITE-END | took 1184s 03:01:28 INFO - Completed test suite (00:19:44) 03:01:28 INFO - javascript benchmark 03:01:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2655.3627129488927, 2656.163308557803, 2699.136276391555, 2706.9458610827796, 2717.7689896358806, 4636.7681615919155, 4748.074125545516, 4750.0, 4884.365032545768, 4905.117078925792, 4758.52414758524, 4773.331733557305, 4780.378550788401, 4813.49458306878, 4838.540338667821, 4328.783560821947, 4364.694471387004, 4420.9336859947125, 4451.732896026248, 4459.777011149446, 4426.867193984185, 4444.666650001247, 4467.441569803775, 4469.08383781324, 4501.032278060216, 4245.193413251503, 4276.700630955835, 4284.550122237151, 4339.262325404688, 4340.110277393127, 4369.759663218521, 4381.78091095444, 4394.1651086293505, 4431.7119387240045, 4432.645388368923, 4407.338899165119, 4429.734215947021, 4437.356583295436, 4439.112177564468, 4476.350929115292, 4608.953910460919, 4736.313234581001, 4749.810007599692, 4775.785089670973, 4812.711237325771, 5092.0, 5124.5131712487255, 5134.743262836843, 5181.896362072737, 5195.428502864682, 5140.691558506502, 5199.454057323965, 5243.4232234454175, 5245.86885327866, 5255.737213139366, 4635.675502714845, 4708.128996135726, 4708.223143181337, 4742.9762851186215, 4807.687500312469, 5176.275321454999, 5194.662346947436, 5226.242194881797, 5226.5818734501145, 5228.92156617651, 4840.056189043103, 4998.975005125024, 5016.2224855147515, 5064.215046667772, 5079.288899554065, 4994.475580064113, 5030.673006254582, 5050.696958182521, 5108.463611320833, 5123.3339665843205, 5040.546350828443, 5049.798008079709, 5050.924236136461, 5055.772490237948, 5082.872928176826, 4981.352424184833, 4989.55094041538, 5000.224965130411, 5001.44984051754, 5015.3730783652045, 3920.2355540669296, 3950.249452603996, 3955.6835453164254, 4005.839766409311, 4007.8196481158416, 3523.9956612365863, 3581.7313701472494, 3598.460230965376, 3611.8194090295906, 3688.4098544232793, 4385.254506733863, 4390.8902277442685, 4398.714083584557, 4442.911141777146, 4443.0, 5106.463821298785, 5139.743012849342, 5146.897062058738, 5148.613853960893, 5153.510416510426, 4269.082147338338, 4306.5262821089655, 4317.697761156752, 4327.394164816928, 4369.868903932887, 4599.241125214302, 4599.494055653875, 4602.88492787683, 4608.631309495232, 4656.208444564432, 4716.882077948078, 4780.163471392562, 4781.617470602413, 4787.329773831597, 4790.329353890388, 5071.112555302881, 5112.3865136183895, 5121.8975620486635, 5140.511651393112, 5146.485351464824, 4805.519448055166, 4810.4708482067645, 4825.059113472839, 4829.468758436499, 4881.121398148367, 4932.4327702314695, 4975.029869175476, 5053.31780209667, 5069.340985671839, 5114.360704911886, 5043.9243411348125, 5115.948840511547, 5129.051125541638, 5147.279380886754, 5171.81898633546, 4968.130577148912, 4977.950220497749, 4983.825566105169, 5000.924986125284, 5029.59763218949, 4766.737829419277, 4952.0, 4970.279309500174, 4992.900141997213, 5044.369453818273, 4943.159662857395, 4969.527894849984, 4987.975060124676, 4996.975015124901, 4998.2502624606595, 5032.6980381177245, 5037.395512538519, 5042.722650254272, 5056.418511871182, 5109.080365534091, 4671.649626277975, 4843.200871856105, 4873.731944743073, 4881.365422495053, 4921.507849215193], "value": 4667.1887192412105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.9248401882412, 575.8071046199523, 579.4350508254452, 580.05161560848, 598.410565592891, 27106.728932710666, 29671.703282967163, 29757.553636695466, 40387.59612403875, 41309.380359294635, 41812.0, 42185.0, 42250.78874605623, 42264.57735422645, 42277.36583951243, 7390.778276651709, 7764.689412423496, 7903.0, 7908.920910790905, 7909.0, 7441.776746697581, 7676.577788221645, 7679.884801727979, 9927.305088643798, 10204.285700001003, 10202.642907498239, 10271.28101032928, 10286.897131028707, 10290.0, 10290.588376464932, 10088.192944564416, 10090.293679442406, 10137.695869123938, 10155.949220253926, 10165.339252948535, 7449.962750186269, 9617.326787124905, 9966.850497242547, 9970.700878973643, 10313.381197128196, 39967.40048899269, 39970.0, 40228.59771402278, 40250.39624405636, 40276.59723402758, 2826.703196164394, 2859.4281143771327, 2890.2340879666904, 2915.300327921305, 2953.3945541164226, 30151.547726784116, 30676.2330941726, 30851.845740771376, 31362.21594460134, 31589.052328430185, 3343.2477692519233, 3394.6096198937194, 3418.7948723076697, 3437.8371897854036, 3455.378031954247, 277001.0, 277716.0, 278000.0, 278291.0, 278920.0, 32373.676263237066, 56510.717446412506, 57567.0, 57660.42339576551, 57671.71164144152, 32509.18727031843, 34497.310053798785, 34742.47886281708, 34749.82625086858, 34819.82590087033, 12352.691182720324, 12387.69030774238, 12405.75188496225, 12429.875701243052, 12454.626361209179, 9701.951490242503, 11065.446727663584, 11082.335059896432, 11137.944310278559, 11168.553257869595, 7812.68749250035, 7989.081255655674, 8014.078380986261, 8145.144759800254, 8209.0, 2972.524396096614, 3026.9848650756603, 3029.909102726922, 3048.527478240876, 3068.432340017104, 874.8600223964136, 895.6014573514724, 930.5672862119147, 959.827231098395, 960.9615615375307, 27742.722572774015, 28997.275068123043, 29018.41963160767, 29267.560986585217, 29582.112536623936, 912.5665308978315, 956.2350119904188, 964.0793042644258, 976.62888102522, 1011.2298163793479, 15245.3901843925, 15448.768268475756, 15544.76682849758, 15589.142597157039, 15635.530934071996, 397949.0, 405955.0, 407644.0, 409179.0, 410723.0, 49916.75041624768, 50228.49771502238, 50232.0, 50302.24546631803, 50383.24425133626, 1065.7122576904349, 1125.150511363915, 1171.6485054483792, 1185.4428418643224, 1199.0407673860877, 25761.355966100997, 29816.70183298139, 29958.0, 29974.70025299719, 30001.54997674993, 43401.0, 43918.780406097765, 43926.0, 43942.780286098365, 43974.560254398326, 320367.0, 327724.0, 328561.0, 328891.0, 329346.0, 25238.621420679072, 26024.479510409306, 26030.479390412464, 27288.863555682095, 27925.0, 43156.56843431525, 43342.133157336044, 43418.78290608527, 44047.33928991132, 44727.32909006302, 36455.27089458249, 36616.63383366132, 37081.443778343884, 37132.0, 37659.62340376561, 37258.813705931294, 37980.0, 38116.0, 38148.80925595354, 38189.61810381972, 36540.451893222154, 36818.631813682594, 37164.25671486609, 37346.25307493889, 37366.439503408015, 29653.851730741208, 32148.19629509281, 34482.48276275908, 34489.0, 34781.826090869385, 25226.36934076663, 25919.22242332733, 25933.740662593886, 25944.8702756485, 26462.603060953716], "value": 17045.599253741148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.7949416788325, 373.5610657477464, 375.24201113750223, 375.5212104566677, 392.02972642709295, 12874.29191394473, 16336.0, 16391.918040409797, 17238.138093095356, 18229.0885455727, 16256.105914174716, 16572.668546629062, 17659.117044147806, 17687.204075816586, 17947.371841985532, 4253.787310634471, 4986.975065124679, 5116.2069879168785, 5123.692578445305, 5123.897522049557, 5010.073136469747, 5053.823116190934, 5070.74646267687, 5076.416212135597, 5077.873053173664, 4875.658703890729, 5045.34410526631, 5064.215046667772, 5074.441811400761, 5080.110980578403, 5000.749962501878, 5010.549050585447, 5010.774515146791, 5014.874628134289, 5019.64862459628, 4338.414314067623, 4492.707973981681, 4523.547645235483, 4527.139843429771, 4536.614387777043, 21293.36119916405, 21455.892720536296, 21629.24297649575, 22199.889000554893, 22200.666989995163, 1961.1076959983316, 1975.9308424205083, 2022.090059473243, 2192.3642143778284, 2327.697399338092, 8787.0, 9426.434413935185, 11558.711032224177, 13367.131136476099, 13858.722825543433, 1741.6255505066472, 1758.2878934031737, 1758.5251981964798, 1766.9558261043449, 1818.6271814278173, 65575.0, 72275.63862180708, 72425.0, 73355.0, 73811.0, 8901.73294801157, 9408.858867116998, 9824.852627210597, 10068.093871551595, 10528.789424211473, 12787.744245115045, 13550.796738048937, 13555.661108472366, 14056.508022219174, 14066.85933140676, 6957.339052790078, 7135.785926422215, 7195.409652525087, 7212.567245965154, 7261.5280006799385, 6385.233771947396, 6507.934920650828, 6509.1863517060365, 6638.900416493757, 6761.019652150509, 4395.099004704028, 4424.756638384855, 4442.68500878342, 4462.754548499864, 4496.572825581565, 1713.3917459302018, 1766.6201766620238, 1778.1642627964836, 1799.073477159264, 1831.8900865948085, 801.2828518475932, 828.4987582512614, 859.0764927702744, 868.1101870582703, 868.7220089571402, 16181.838181618268, 17274.395396161075, 17499.38752143669, 17825.197866096056, 18049.909750451425, 863.9092895246034, 865.3769286113987, 869.1786261982365, 872.6291326186346, 895.8163576466809, 9332.906670933204, 9626.759331016641, 9830.557624906896, 9838.0, 9873.160781333523, 397300.0, 401094.0, 401310.0, 414604.0, 419781.0, 47947.280790788165, 48764.51235487671, 50126.0, 54702.72648636731, 88390.55804720936, 940.8165407745424, 945.5555888732284, 949.2358651285781, 975.6780262513354, 995.721198064543, 15832.0, 16039.358425662842, 16073.75889361684, 16111.838881611502, 16239.756403653719, 27810.72189278162, 38628.22743545169, 39601.405978910916, 39727.2054558913, 40098.59901400949, 51435.48564514307, 52855.0, 53040.0, 53735.73132134314, 54807.725961369935, 7112.679929403086, 7311.561306321638, 9964.352317099656, 10050.798984020132, 10684.198685098803, 10952.452377381258, 11224.887751122384, 11719.941400292944, 11748.823767643322, 12001.879981200425, 10151.137153341753, 10216.948915255376, 10230.693079207636, 10489.947550262199, 10543.736406589896, 9989.500524973868, 10062.094411503, 10218.693439196835, 10317.27779055489, 10491.318064325795, 10149.137323327599, 10247.948760256151, 10303.021212984755, 10500.107490863362, 10762.946185269024, 10388.636397726043, 10457.790844182922, 10820.729481763019, 10834.67495975122, 11000.944995274973, 9808.509574521102, 10072.798544028932, 10203.693889183336, 10242.436665983443, 10405.635802746867], "value": 8266.040669329135, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.7617228898794, 1395.5743498233037, 1415.5399495164074, 1633.0, 1653.9834601653988, 7499.175090740021, 7960.203979602037, 8040.718574849881, 8060.758177254685, 8065.4354195206215, 6812.386885180333, 7018.894716579255, 7509.249075092502, 7723.266289702469, 7921.960390198041, 2218.367765186926, 2251.0883092347626, 2253.9323820285335, 2254.582902163097, 2255.052877791323, 1877.3710806879644, 1992.183204885997, 2030.0763152765455, 2072.616565935299, 2073.5956488484753, 2077.314486219544, 2153.472399262183, 2155.181031208139, 2170.8588941718817, 2173.576152650234, 2137.1665050630268, 2146.8175205107586, 2150.946226344346, 2180.7928246816527, 2188.5075857931997, 2045.089934978935, 2056.670932650769, 2065.8863762493056, 2067.555475572744, 2068.5759419319156, 8090.635921383493, 8142.022957245109, 8151.144129866338, 8151.225633564802, 8153.1846815317995, 4430.069685366077, 4552.954470455286, 4563.133004729091, 4564.064366804831, 4565.338025986247, 2790.204791634395, 2854.5004624190683, 2911.9953616002445, 2917.9270518237213, 2922.7515661168613, 867.7960679240374, 873.2664561768082, 888.2050564744582, 890.7728529225006, 890.9109089091104, 10840.186985976005, 10854.511546980404, 10861.18541109412, 10866.076383507412, 10876.728081798019, 4082.510098788164, 4159.147374788161, 4311.892202694895, 4338.848140315137, 4341.956580434218, 9243.584038718274, 9324.90675093254, 9326.90673093274, 9330.533473326306, 9332.300077494216, 4681.32120842476, 4682.227432473672, 4682.836100736526, 4686.929696054562, 4688.929666055012, 4193.916121677549, 4273.102648443862, 4276.87169384919, 4282.336237883071, 4283.550227226158, 3660.9816950915606, 3679.8712045078296, 3710.666040056408, 3754.9436758448646, 3758.285925674113, 1085.451846817368, 1163.5113252433998, 1186.5135294529202, 1201.2852352850216, 1203.0676225924979, 750.2722359311459, 751.9511231769917, 770.3606007014165, 778.6496076765478, 789.542065601961, 5247.501487358695, 5337.119375303031, 5463.69949652765, 5629.605927585111, 5724.227229324071, 871.1506281375608, 871.5511511571419, 877.7103555826562, 882.1883866842392, 922.1239822168966, 3541.256336169382, 3543.4153364694535, 3555.804430756333, 3576.7853928764357, 3589.748717589796, 9692.660756873476, 9916.057974492413, 9919.504024798876, 10086.344387614781, 10118.089371956412, 9679.0, 9854.408735475894, 9904.702858914245, 9914.752131196634, 9927.851082233772, 7319.74380896666, 7332.816679583053, 7451.701931922662, 7468.775936721907, 7476.0, 4990.326305948795, 5218.582513398843, 5298.523132918056, 5301.23132145829, 5345.22494238341, 9060.456372617664, 9172.54137293146, 9208.723738287863, 9224.677136300197, 9286.34995550332, 9094.818103637757, 9439.575219115293, 9543.713688589354, 9544.093311135432, 9550.617975280911, 6419.101325814297, 6507.73969041252, 6509.316521765336, 6510.251321098134, 6621.437177839937, 7429.368503677032, 7486.6256687166515, 7517.0, 7518.812029699301, 7521.360684341892, 6680.198376194888, 6786.355296246848, 6838.965805170942, 6922.0, 6935.895961560682, 6648.102506161799, 6737.9326206737305, 6748.898766518408, 6825.726970921108, 6922.238553759184, 5794.0, 6034.63792172471, 6038.69806509664, 6122.846928826815, 6174.38256174379, 4392.494863090786, 4470.396496472935, 4511.210538155744, 4520.276755719069, 4622.884427889329, 4688.2733176357715, 4700.388949436551, 4713.528647135259, 4748.857534273978, 4814.20565606671], "value": 4142.689679858683, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.7038067503509, 305.2216847040049, 309.151379463373, 309.7785083665179, 310.399377205108, 4910.98649553683, 4948.268106162841, 4956.603471722263, 4956.925646115311, 4967.640370823857, 4895.11887860185, 4916.213405855064, 4918.458969513351, 4919.212925931843, 4921.311016457699, 3689.8339574719134, 3756.586775454698, 3819.0, 3874.341361968472, 3875.8255878485393, 3798.202377500714, 3848.7113466489986, 3850.8652197173105, 3852.84588616455, 3865.091703449687, 3799.7910114943666, 3816.503854498911, 3835.1179228777396, 3837.6546110850018, 3870.283997460479, 3684.7420680552373, 3729.832157552903, 3823.9044023899346, 3830.9616903830884, 3848.3457812171996, 3400.846961886696, 3401.9829900850586, 3405.897823065312, 3411.6076651184935, 3415.351083294166, 4793.496682848286, 4809.807607695688, 4848.5636292733825, 4853.126437241295, 4863.732494712789, 4128.587141285878, 4363.258246098171, 4375.321825117112, 4382.780860956971, 4433.401490798766, 5151.974240128813, 5153.1963812665645, 5156.716380599066, 5180.559652429548, 5185.792568297264, 3676.9080772980888, 3679.9448008279896, 3687.3731465650903, 3689.1699367642336, 3696.057505336122, 5092.516210959953, 5415.756290966916, 5451.291332126838, 5460.071787796084, 5472.863178420532, 3713.925721485555, 3715.479832823407, 3719.702423806089, 3750.6061863504483, 3762.811859407019, 3784.9810750946067, 3808.7143464240294, 3815.1797363566966, 3818.560865500503, 3825.4261860721112, 4348.239058164809, 4358.760268185217, 4392.538783427694, 4399.076193999296, 4405.207062728676, 5033.194688849767, 5103.489651034867, 5141.2288156776785, 5149.485051494896, 5152.969406118791, 1287.6458973782098, 1296.9157004794658, 1298.8311519502593, 1302.6547964789338, 1309.3829121035515, 807.567951146134, 828.8561784737025, 830.7632324787406, 835.9832803343899, 867.6616119713317, 4449.57729015743, 4469.173202957463, 4469.955300447019, 4479.417675702203, 4485.573870482299, 5217.843464696065, 5230.450802665665, 5234.502722241381, 5245.269061209868, 5255.894882102337, 4350.303951367766, 4437.622802061861, 4446.9777651111535, 4453.821847126079, 4457.465104187453, 2765.1980925531775, 2774.4312415954682, 2790.483760504313, 2801.453716525258, 2829.7877659175642, 4893.926591101136, 4923.876903077452, 4974.403071631427, 4977.352944117314, 4995.801007758112, 5177.663451875616, 5321.441248668912, 5322.946770532245, 5403.891922161535, 5404.162354835007, 4920.065187614342, 4922.529616620274, 4929.338157395038, 4952.826651067196, 4964.329815474937, 5184.196449550326, 5210.47895210476, 5212.817551385683, 5224.190250511177, 5260.736963151904, 4969.527894849984, 5120.590352771695, 5130.5639020682165, 5132.46109158533, 5138.409082955508, 4906.705597664151, 4912.680675756064, 4927.926081108858, 4936.2102063669645, 4968.652194346361, 3742.7567208131386, 3762.793046382366, 3763.6800871925097, 3766.1714422826935, 3775.6601905828607, 5072.873178170576, 5240.218325769257, 5249.7112658804135, 5314.458806945942, 5326.680399176062, 5017.494751574586, 5022.246663000579, 5026.321446604661, 5050.474762618691, 5057.949420505748, 4992.580082643256, 5012.348394708664, 5034.697918124924, 5047.192449208109, 5080.949190508048, 4781.378420805412, 4953.380827396575, 4956.0, 4980.975095124501, 4993.6254780892305, 4918.163912135017, 5013.674111182761, 5129.435762066244, 5167.405748338989, 5171.767270472913, 5037.168867136881, 5040.067587496325, 5042.520960508746, 5053.140966035856, 5055.0], "value": 3855.3240349966673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.3743662745683, 618.4155972605888, 637.5568979559207, 681.5195287322438, 742.9116344555225, 12870.742585148304, 13594.252316122609, 13982.30088495575, 14014.579562613126, 14018.789718154236, 13331.266780327078, 13359.131656442325, 13455.865441345584, 13471.259080750555, 13483.797743033861, 624.0576729138987, 768.7040489411575, 776.9300762931335, 785.5443842571295, 794.6185830801219, 804.8470790549777, 806.2219957740779, 808.5431731071955, 809.0049239435498, 810.6352141536303, 836.7991681996308, 837.7403005068418, 837.9162083791603, 838.6854929401475, 838.6980686952692, 644.7324360390433, 790.9604519774045, 807.5356669914764, 810.5622963599649, 828.1387357148558, 599.286848650105, 600.8858316919772, 602.1479606357, 604.0094245437487, 605.2102006881018, 13188.802167967488, 13197.538086167035, 13228.86771132286, 13229.933850330783, 13258.602241932758, 12481.31352775597, 12889.355532223444, 12897.67755806103, 12921.741565168739, 13247.867521324759, 11623.418829058597, 11675.591354302644, 11712.837533865893, 11716.414179291087, 12026.458809353513, 3815.1606646537716, 3834.5206849143856, 3872.883813485572, 3885.0870045539277, 3997.1006523531973, 59206.783287755025, 59211.815763684914, 59479.0, 59564.70217648927, 59592.70203648954, 9827.508624568885, 9899.554520046615, 10074.546645400975, 10101.747456313651, 10409.5836166554, 19400.126994285292, 19455.416337509898, 19466.610667786565, 19540.0, 19605.31381401644, 6702.564333318319, 6821.488388370892, 6897.517173797786, 6907.0, 6978.930210697929, 3610.98194509031, 3636.0546257972587, 3662.5788034375855, 3683.171286460525, 3710.0, 2824.8163869348427, 2947.5578663200263, 3161.0832858470785, 3309.5201195826953, 3320.1367644412626, 432.38169417732945, 535.8419266316446, 536.5466181076984, 537.7687594334395, 540.1115165552644, 494.90844193824256, 528.698641774185, 604.5465900574569, 607.4077774170237, 622.5362105231541, 8255.0, 8340.0, 8426.831463370698, 8458.0, 8568.186022327869, 554.0857584984807, 558.7094710750387, 585.4759989809097, 598.2342601470125, 599.4994179859779, 3873.1672690371142, 4114.506259248849, 4158.688098392633, 4173.91652166961, 4223.083329593036, 100801.49599252103, 102770.48614757028, 105178.4741076305, 107665.0, 108144.0, 67006.0, 68365.31634683689, 69646.30353696398, 81826.59086704528, 83034.16965830386, 53144.734276329145, 74881.62559187169, 75269.24730752732, 76400.23599764043, 77774.0, 8630.439021463584, 8680.91319086801, 8721.345899057469, 9002.729918102468, 9038.954805225932, 45217.32174017327, 45628.0, 45876.77061614671, 46199.76900115478, 46236.53763462322, 66443.66778166078, 66489.66755166193, 66691.0, 67244.6637766808, 67936.6603166981, 10302.690919272434, 10589.311694739818, 10764.461776910966, 10828.296160749525, 11520.711982200512, 13087.345632718136, 13210.180012414648, 13237.89095625273, 13668.179909205479, 13827.79258311106, 11991.280523168638, 12019.819702704292, 12249.203801752858, 12250.019998399928, 12608.747825043265, 11778.882211177779, 11803.940980295043, 11961.461734221806, 12188.268703877795, 12213.267203967791, 11699.415029248334, 11998.04015678761, 12021.699457513632, 12256.0, 12408.503659853504, 9462.581417648227, 9729.124378805658, 9857.063578959987, 9914.355566888129, 9931.553080111556, 9648.75878103053, 9814.072256468775, 10483.633072842415, 10588.735281618021, 10733.141348692243], "value": 6670.938624429358, "unit": "score"}], "name": "dromaeo_css", "value": 6420.820605412834, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 116.0, 115.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 121.0, 179.0, 122.0, 127.0, 147.0, 132.0, 165.0, 125.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 76.0, 109.0, 77.0, 78.0, 75.0, 76.0, 99.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 123.0, 84.0, 85.0, 84.0, 120.0, 84.0, 85.0, 135.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 70.0, 62.0, 63.0, 62.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 67.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 79.0, 79.0, 78.0, 78.0, 84.0, 79.0, 77.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 126.0, 136.0, 128.0, 128.0, 126.0, 133.0, 127.0, 172.0, 131.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 165.0, 167.0, 166.0, 165.0, 165.0, 164.0, 167.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 65.0, 65.0, 65.0, 65.0, 68.0, 64.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1523.2, "alertThreshold": 2.0}]} 03:01:28 INFO - Return code: 0 03:01:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:01:28 INFO - # TBPL SUCCESS # 03:01:28 INFO - Running post-action listener: _resource_record_post_action 03:01:28 INFO - ##### 03:01:28 INFO - ##### Finished run-tests step (success) 03:01:28 INFO - ##### 03:01:28 INFO - Running post-run listener: _resource_record_post_run 03:01:28 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551497728; Read time: 12; Write time: 566600 03:01:28 INFO - TinderboxPrint: CPU usage
13.0% 03:01:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:01:28 INFO - TinderboxPrint: I/O write bytes / time
551,497,728 / 566,600 03:01:28 INFO - TinderboxPrint: CPU idle
8,340.4 (87.0%) 03:01:28 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 03:01:28 INFO - TinderboxPrint: Swap in / out
0 / 0 03:01:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 262979584; Read time: 0; Write time: 320156 03:01:28 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288518144; Read time: 12; Write time: 246444 03:01:28 INFO - Running post-run listener: _upload_blobber_files 03:01:28 INFO - Blob upload gear active. 03:01:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:01:28 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 03:01:28 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'] 03:01:28 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 03:01:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:01:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:01:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:01:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:30 INFO - (blobuploader) - INFO - Done attempting. 03:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:01:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:34 INFO - (blobuploader) - INFO - Done attempting. 03:01:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:01:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:01:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:35 INFO - (blobuploader) - INFO - Done attempting. 03:01:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:01:35 INFO - Return code: 0 03:01:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:01:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:01:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad5b37021d78ed1ff45626952d3cb3f0c55cc607f7e5eb8aabd1dcbf877d0270da28aafc4c1b8648f7a22bbf8954b984d3c37430b4fd6ce04175624e7352842a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78c35223d3cbbbada38fa7d62e81475cdb64286ea4373ab0835c3d81c07ffb2c8094558a83c7ce0e7b2ff13a9d61b69e3f30c964e5b353dbff895a01d29b15d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/132c4900a83124b61cd2b7798a893b0d5bf38fed39c6c5a39b0e55d7d798b3b3f837a90b96c117ded4b4568d592bb60a950e596e4487ef848bb12484ad9b922a"} 03:01:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:01:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:01:35 INFO - Contents: 03:01:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad5b37021d78ed1ff45626952d3cb3f0c55cc607f7e5eb8aabd1dcbf877d0270da28aafc4c1b8648f7a22bbf8954b984d3c37430b4fd6ce04175624e7352842a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78c35223d3cbbbada38fa7d62e81475cdb64286ea4373ab0835c3d81c07ffb2c8094558a83c7ce0e7b2ff13a9d61b69e3f30c964e5b353dbff895a01d29b15d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/132c4900a83124b61cd2b7798a893b0d5bf38fed39c6c5a39b0e55d7d798b3b3f837a90b96c117ded4b4568d592bb60a950e596e4487ef848bb12484ad9b922a"} 03:01:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:01:35 INFO - Copying logs to upload dir... 03:01:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:01:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.032992 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-17 03:01:35.059788) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 03:01:35.065641) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215 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/ad5b37021d78ed1ff45626952d3cb3f0c55cc607f7e5eb8aabd1dcbf877d0270da28aafc4c1b8648f7a22bbf8954b984d3c37430b4fd6ce04175624e7352842a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78c35223d3cbbbada38fa7d62e81475cdb64286ea4373ab0835c3d81c07ffb2c8094558a83c7ce0e7b2ff13a9d61b69e3f30c964e5b353dbff895a01d29b15d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/132c4900a83124b61cd2b7798a893b0d5bf38fed39c6c5a39b0e55d7d798b3b3f837a90b96c117ded4b4568d592bb60a950e596e4487ef848bb12484ad9b922a"} build_url:https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/DTZmb3xPR4m1TMV3WWnNBQ/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/ad5b37021d78ed1ff45626952d3cb3f0c55cc607f7e5eb8aabd1dcbf877d0270da28aafc4c1b8648f7a22bbf8954b984d3c37430b4fd6ce04175624e7352842a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78c35223d3cbbbada38fa7d62e81475cdb64286ea4373ab0835c3d81c07ffb2c8094558a83c7ce0e7b2ff13a9d61b69e3f30c964e5b353dbff895a01d29b15d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/132c4900a83124b61cd2b7798a893b0d5bf38fed39c6c5a39b0e55d7d798b3b3f837a90b96c117ded4b4568d592bb60a950e596e4487ef848bb12484ad9b922a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 03:01:35.091002) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 03:01:35.091336) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468748453.729130-981897215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 03:01:35.175129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 03:01:35.175458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 03:01:35.175767) ========= ========= Total master_lag: 0.17 =========