builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1471403199.96 results: success (0) buildid: 20160816173004 builduid: f8edb7e2e4ee483b90e75080b1c81374 revision: 4b48ad68a5945476857c08a9f67487fbdae51582 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:39.964320) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:39.966400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:39.966714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:39.992584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:39.992965) ========= 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=3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 20:06:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-16 20:06:41 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104913 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:40.115045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:40.115467) ========= 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=3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018359 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:40.166282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:40.166637) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4b48ad68a5945476857c08a9f67487fbdae51582 --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 4b48ad68a5945476857c08a9f67487fbdae51582 --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=3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 20:06:41,279 truncating revision to first 12 chars 2016-08-16 20:06:41,279 Setting DEBUG logging. 2016-08-16 20:06:41,279 attempt 1/10 2016-08-16 20:06:41,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4b48ad68a594?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 20:06:41,573 unpacking tar archive at: fx-team-4b48ad68a594/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623735 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:40.807677) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:40.808054) ========= script_repo_revision: 4b48ad68a5945476857c08a9f67487fbdae51582 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:40.808553) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:40.808846) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 20:06:40.818724) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-16 20:06:40.819121) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:42 INFO - MultiFileLogger online at 20160816 20:06:42 in /builds/slave/test 20:06:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:06:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:42 INFO - {'append_to_log': False, 20:06:42 INFO - 'base_work_dir': '/builds/slave/test', 20:06:42 INFO - 'blob_upload_branch': 'Fx-Team', 20:06:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:42 INFO - 'branch': 'Fx-Team', 20:06:42 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:42 INFO - 'config_files': ('talos/linux_config.py',), 20:06:42 INFO - 'default_actions': ('clobber', 20:06:42 INFO - 'read-buildbot-config', 20:06:42 INFO - 'download-and-extract', 20:06:42 INFO - 'populate-webroot', 20:06:42 INFO - 'create-virtualenv', 20:06:42 INFO - 'install', 20:06:42 INFO - 'run-tests'), 20:06:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:42 INFO - 'download_minidump_stackwalk': True, 20:06:42 INFO - 'download_symbols': 'ondemand', 20:06:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:42 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:42 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:42 INFO - 'installer_path': 'installer.exe', 20:06:42 INFO - 'log_level': 'info', 20:06:42 INFO - 'log_name': 'talos', 20:06:42 INFO - 'log_to_console': True, 20:06:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:42 INFO - 'opt_config_files': (), 20:06:42 INFO - 'pip_index': False, 20:06:42 INFO - 'sps_profile': False, 20:06:42 INFO - 'sps_profile_interval': 0, 20:06:42 INFO - 'suite': 'dromaeojs', 20:06:42 INFO - 'system_bits': '32', 20:06:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:42 INFO - 'title': 'talos-linux64-ix-059', 20:06:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:42 INFO - 'use_talos_json': True, 20:06:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:42 INFO - 'work_dir': 'build'} 20:06:42 INFO - [mozharness: 2016-08-17 03:06:42.024435Z] Running clobber step. 20:06:42 INFO - Running pre-action listener: _resource_record_pre_action 20:06:42 INFO - Running main action method: clobber 20:06:42 INFO - rmtree: /builds/slave/test/build 20:06:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:42 INFO - Running post-action listener: _resource_record_post_action 20:06:42 INFO - [mozharness: 2016-08-17 03:06:42.480124Z] Finished clobber step (success) 20:06:42 INFO - [mozharness: 2016-08-17 03:06:42.480225Z] Running read-buildbot-config step. 20:06:42 INFO - Running pre-action listener: _resource_record_pre_action 20:06:42 INFO - Running main action method: read_buildbot_config 20:06:42 INFO - Using buildbot properties: 20:06:42 INFO - { 20:06:42 INFO - "project": "", 20:06:42 INFO - "product": "firefox", 20:06:42 INFO - "script_repo_revision": "production", 20:06:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:06:42 INFO - "repository": "", 20:06:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:06:42 INFO - "buildid": "20160816173004", 20:06:42 INFO - "pgo_build": "True", 20:06:42 INFO - "basedir": "/builds/slave/test", 20:06:42 INFO - "buildnumber": 1468, 20:06:42 INFO - "slavename": "talos-linux64-ix-059", 20:06:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:06:42 INFO - "platform": "ubuntu64_hw", 20:06:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:06:42 INFO - "branch": "fx-team", 20:06:42 INFO - "repo_path": "integration/fx-team", 20:06:42 INFO - "revision": "4b48ad68a5945476857c08a9f67487fbdae51582", 20:06:42 INFO - "stage_platform": "linux64-pgo", 20:06:42 INFO - "builduid": "f8edb7e2e4ee483b90e75080b1c81374", 20:06:42 INFO - "slavebuilddir": "test" 20:06:42 INFO - } 20:06:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:06:42 INFO - Running post-action listener: _resource_record_post_action 20:06:42 INFO - [mozharness: 2016-08-17 03:06:42.482681Z] Finished read-buildbot-config step (success) 20:06:42 INFO - [mozharness: 2016-08-17 03:06:42.482769Z] Running download-and-extract step. 20:06:42 INFO - Running pre-action listener: _resource_record_pre_action 20:06:42 INFO - Running main action method: download_and_extract 20:06:42 INFO - mkdir: /builds/slave/test/build/tests 20:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:42 INFO - trying https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:06:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:06:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:06:43 INFO - Downloaded 1361 bytes. 20:06:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:06:43 INFO - Using the following test package requirements: 20:06:43 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:43 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:43 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:43 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:43 INFO - u'jsshell-linux-x86_64.zip'], 20:06:43 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:43 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:43 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:43 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:43 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:43 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:43 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:43 INFO - trying https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:44 INFO - Downloaded 21837564 bytes. 20:06:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:06:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:48 INFO - trying https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:49 INFO - Downloaded 21837564 bytes. 20:06:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:54 INFO - trying https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:06:55 INFO - Downloaded 14413719 bytes. 20:06:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 20:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:55 INFO - trying https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:06:58 INFO - Downloaded 59373117 bytes. 20:06:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:58 INFO - mkdir: /builds/slave/test/properties 20:06:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:58 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:58 INFO - Contents: 20:06:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:58 INFO - Running post-action listener: _resource_record_post_action 20:06:58 INFO - Running post-action listener: set_extra_try_arguments 20:06:58 INFO - [mozharness: 2016-08-17 03:06:58.772100Z] Finished download-and-extract step (success) 20:06:58 INFO - [mozharness: 2016-08-17 03:06:58.772326Z] Running populate-webroot step. 20:06:58 INFO - Running pre-action listener: _resource_record_pre_action 20:06:58 INFO - Running main action method: populate_webroot 20:06:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:58 INFO - '--tppagecycles', 20:06:58 INFO - '7'], 20:06:58 INFO - 'tests': ['tsvgm']}}, 20:06:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:58 INFO - 'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:58 INFO - 'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['damp', 'tps']}, 20:06:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:58 INFO - 'tests': ['damp', 'tps']}, 20:06:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['dromaeo_dom']}, 20:06:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['basic_compositor_video']}, 20:06:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:06:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['a11yr', 20:06:58 INFO - 'ts_paint', 20:06:58 INFO - 'tpaint', 20:06:58 INFO - 'sessionrestore', 20:06:58 INFO - 'sessionrestore_no_auto_restore', 20:06:58 INFO - 'tabpaint']}, 20:06:58 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:58 INFO - 'ts_paint', 20:06:58 INFO - 'tpaint', 20:06:58 INFO - 'sessionrestore', 20:06:58 INFO - 'sessionrestore_no_auto_restore', 20:06:58 INFO - 'tabpaint']}, 20:06:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:58 INFO - 'ts_paint', 20:06:58 INFO - 'tpaint', 20:06:58 INFO - 'sessionrestore', 20:06:58 INFO - 'sessionrestore_no_auto_restore', 20:06:58 INFO - 'tabpaint']}, 20:06:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:58 INFO - 'ts_paint', 20:06:58 INFO - 'tpaint', 20:06:58 INFO - 'sessionrestore', 20:06:58 INFO - 'sessionrestore_no_auto_restore', 20:06:58 INFO - 'tabpaint']}, 20:06:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['a11yr', 20:06:58 INFO - 'ts_paint', 20:06:58 INFO - 'tpaint', 20:06:58 INFO - 'sessionrestore', 20:06:58 INFO - 'sessionrestore_no_auto_restore', 20:06:58 INFO - 'tabpaint']}, 20:06:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['a11yr', 20:06:58 INFO - 'ts_paint', 20:06:58 INFO - 'tpaint', 20:06:58 INFO - 'sessionrestore', 20:06:58 INFO - 'sessionrestore_no_auto_restore', 20:06:58 INFO - 'tabpaint']}, 20:06:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['tsvgx', 20:06:58 INFO - 'tsvgr_opacity', 20:06:58 INFO - 'tart', 20:06:58 INFO - 'tscrollx', 20:06:58 INFO - 'cart']}, 20:06:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:58 INFO - 'tsvgr_opacity', 20:06:58 INFO - 'tart', 20:06:58 INFO - 'tscrollx', 20:06:58 INFO - 'cart']}, 20:06:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:58 INFO - 'talos_options': ['--disable-e10s'], 20:06:58 INFO - 'tests': ['tp5o']}, 20:06:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:58 INFO - 'tests': ['tp5o']}, 20:06:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:58 INFO - 'talos_options': ['--disable-e10s', 20:06:58 INFO - '--xperf_path', 20:06:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:58 INFO - 'tests': ['tp5n']}, 20:06:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:58 INFO - 'talos_options': ['--xperf_path', 20:06:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:58 INFO - 'tests': ['tp5n']}}, 20:06:58 INFO - 'talos.zip': {'path': '', 20:06:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:58 INFO - Running post-action listener: _resource_record_post_action 20:06:58 INFO - [mozharness: 2016-08-17 03:06:58.794035Z] Finished populate-webroot step (success) 20:06:58 INFO - [mozharness: 2016-08-17 03:06:58.794124Z] Running create-virtualenv step. 20:06:58 INFO - Running pre-action listener: _resource_record_pre_action 20:06:58 INFO - Running main action method: create_virtualenv 20:06:58 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:58 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 20:06:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:58 INFO - Using real prefix '/usr' 20:06:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:59 INFO - Installing distribute.............................................................................................................................................................................................done. 20:07:01 INFO - Installing pip.................done. 20:07:01 INFO - Return code: 0 20:07:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:07:01 INFO - Using env: {'DISPLAY': ':0', 20:07:01 INFO - 'HOME': '/home/cltbld', 20:07:01 INFO - 'LANG': 'en_US.UTF-8', 20:07:01 INFO - 'LANGUAGE': 'en_US:en', 20:07:01 INFO - 'LOGNAME': 'cltbld', 20:07:01 INFO - 'MAIL': '/var/mail/cltbld', 20:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:01 INFO - 'MOZ_NO_REMOTE': '1', 20:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:01 INFO - 'NO_EM_RESTART': '1', 20:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:01 INFO - 'PWD': '/builds/slave/test', 20:07:01 INFO - 'SHELL': '/bin/bash', 20:07:01 INFO - 'SHLVL': '1', 20:07:01 INFO - 'TERM': 'linux', 20:07:01 INFO - 'TMOUT': '86400', 20:07:01 INFO - 'USER': 'cltbld', 20:07:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:01 INFO - '_': '/tools/buildbot/bin/python'} 20:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:07:01 INFO - Cleaning up... 20:07:01 INFO - Return code: 0 20:07:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:07:01 INFO - Using env: {'DISPLAY': ':0', 20:07:01 INFO - 'HOME': '/home/cltbld', 20:07:01 INFO - 'LANG': 'en_US.UTF-8', 20:07:01 INFO - 'LANGUAGE': 'en_US:en', 20:07:01 INFO - 'LOGNAME': 'cltbld', 20:07:01 INFO - 'MAIL': '/var/mail/cltbld', 20:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:01 INFO - 'MOZ_NO_REMOTE': '1', 20:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:01 INFO - 'NO_EM_RESTART': '1', 20:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:01 INFO - 'PWD': '/builds/slave/test', 20:07:01 INFO - 'SHELL': '/bin/bash', 20:07:01 INFO - 'SHLVL': '1', 20:07:01 INFO - 'TERM': 'linux', 20:07:01 INFO - 'TMOUT': '86400', 20:07:01 INFO - 'USER': 'cltbld', 20:07:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:01 INFO - '_': '/tools/buildbot/bin/python'} 20:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:01 INFO - Downloading/unpacking psutil>=3.1.1 20:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:07:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:03 INFO - Installing collected packages: psutil 20:07:03 INFO - Running setup.py install for psutil 20:07:03 INFO - building 'psutil._psutil_linux' extension 20:07:03 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 20:07:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:07:04 INFO - building 'psutil._psutil_posix' extension 20:07:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:07:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:07:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:04 INFO - Successfully installed psutil 20:07:04 INFO - Cleaning up... 20:07:04 INFO - Return code: 0 20:07:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:07:04 INFO - Using env: {'DISPLAY': ':0', 20:07:04 INFO - 'HOME': '/home/cltbld', 20:07:04 INFO - 'LANG': 'en_US.UTF-8', 20:07:04 INFO - 'LANGUAGE': 'en_US:en', 20:07:04 INFO - 'LOGNAME': 'cltbld', 20:07:04 INFO - 'MAIL': '/var/mail/cltbld', 20:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:04 INFO - 'MOZ_NO_REMOTE': '1', 20:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:04 INFO - 'NO_EM_RESTART': '1', 20:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:04 INFO - 'PWD': '/builds/slave/test', 20:07:04 INFO - 'SHELL': '/bin/bash', 20:07:04 INFO - 'SHLVL': '1', 20:07:04 INFO - 'TERM': 'linux', 20:07:04 INFO - 'TMOUT': '86400', 20:07:04 INFO - 'USER': 'cltbld', 20:07:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:04 INFO - '_': '/tools/buildbot/bin/python'} 20:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:07:06 INFO - Installing collected packages: mozsystemmonitor 20:07:06 INFO - Running setup.py install for mozsystemmonitor 20:07:06 INFO - Successfully installed mozsystemmonitor 20:07:06 INFO - Cleaning up... 20:07:06 INFO - Return code: 0 20:07:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:07:06 INFO - Using env: {'DISPLAY': ':0', 20:07:06 INFO - 'HOME': '/home/cltbld', 20:07:06 INFO - 'LANG': 'en_US.UTF-8', 20:07:06 INFO - 'LANGUAGE': 'en_US:en', 20:07:06 INFO - 'LOGNAME': 'cltbld', 20:07:06 INFO - 'MAIL': '/var/mail/cltbld', 20:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:06 INFO - 'MOZ_NO_REMOTE': '1', 20:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:06 INFO - 'NO_EM_RESTART': '1', 20:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:06 INFO - 'PWD': '/builds/slave/test', 20:07:06 INFO - 'SHELL': '/bin/bash', 20:07:06 INFO - 'SHLVL': '1', 20:07:06 INFO - 'TERM': 'linux', 20:07:06 INFO - 'TMOUT': '86400', 20:07:06 INFO - 'USER': 'cltbld', 20:07:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:06 INFO - '_': '/tools/buildbot/bin/python'} 20:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:06 INFO - Downloading/unpacking jsonschema==2.5.1 20:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:07:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:09 INFO - Downloading functools32-3.2.3-2.tar.gz 20:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:07:09 INFO - warning: no files found matching '*.txt' 20:07:09 INFO - no previously-included directories found matching 'build' 20:07:09 INFO - no previously-included directories found matching 'dist' 20:07:09 INFO - no previously-included directories found matching '.git*' 20:07:09 INFO - Installing collected packages: jsonschema, functools32 20:07:09 INFO - Running setup.py install for functools32 20:07:09 INFO - warning: no files found matching '*.txt' 20:07:09 INFO - no previously-included directories found matching 'build' 20:07:09 INFO - no previously-included directories found matching 'dist' 20:07:09 INFO - no previously-included directories found matching '.git*' 20:07:09 INFO - Successfully installed jsonschema functools32 20:07:09 INFO - Cleaning up... 20:07:09 INFO - Return code: 0 20:07:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:07:09 INFO - Using env: {'DISPLAY': ':0', 20:07:09 INFO - 'HOME': '/home/cltbld', 20:07:09 INFO - 'LANG': 'en_US.UTF-8', 20:07:09 INFO - 'LANGUAGE': 'en_US:en', 20:07:09 INFO - 'LOGNAME': 'cltbld', 20:07:09 INFO - 'MAIL': '/var/mail/cltbld', 20:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:09 INFO - 'MOZ_NO_REMOTE': '1', 20:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:09 INFO - 'NO_EM_RESTART': '1', 20:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:09 INFO - 'PWD': '/builds/slave/test', 20:07:09 INFO - 'SHELL': '/bin/bash', 20:07:09 INFO - 'SHLVL': '1', 20:07:09 INFO - 'TERM': 'linux', 20:07:09 INFO - 'TMOUT': '86400', 20:07:09 INFO - 'USER': 'cltbld', 20:07:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:09 INFO - '_': '/tools/buildbot/bin/python'} 20:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:07:09 INFO - Cleaning up... 20:07:09 INFO - Return code: 0 20:07:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:07:09 INFO - Using env: {'DISPLAY': ':0', 20:07:09 INFO - 'HOME': '/home/cltbld', 20:07:09 INFO - 'LANG': 'en_US.UTF-8', 20:07:09 INFO - 'LANGUAGE': 'en_US:en', 20:07:09 INFO - 'LOGNAME': 'cltbld', 20:07:09 INFO - 'MAIL': '/var/mail/cltbld', 20:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:09 INFO - 'MOZ_NO_REMOTE': '1', 20:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:09 INFO - 'NO_EM_RESTART': '1', 20:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:09 INFO - 'PWD': '/builds/slave/test', 20:07:09 INFO - 'SHELL': '/bin/bash', 20:07:09 INFO - 'SHLVL': '1', 20:07:09 INFO - 'TERM': 'linux', 20:07:09 INFO - 'TMOUT': '86400', 20:07:09 INFO - 'USER': 'cltbld', 20:07:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:09 INFO - '_': '/tools/buildbot/bin/python'} 20:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:09 INFO - Downloading/unpacking blobuploader==1.2.4 20:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:11 INFO - Downloading blobuploader-1.2.4.tar.gz 20:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:07:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:07:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:07: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 20:07: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 20:07: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 20:07: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 20:07: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 20:07: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 20:07:12 INFO - Downloading docopt-0.6.1.tar.gz 20:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:07:12 INFO - Installing collected packages: blobuploader, requests, docopt 20:07:12 INFO - Running setup.py install for blobuploader 20:07:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:07:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:07:12 INFO - Running setup.py install for requests 20:07:12 INFO - Running setup.py install for docopt 20:07:13 INFO - Successfully installed blobuploader requests docopt 20:07:13 INFO - Cleaning up... 20:07:13 INFO - Return code: 0 20:07:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:13 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 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:13 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 20:07:13 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 20:07:13 INFO - Using env: {'DISPLAY': ':0', 20:07:13 INFO - 'HOME': '/home/cltbld', 20:07:13 INFO - 'LANG': 'en_US.UTF-8', 20:07:13 INFO - 'LANGUAGE': 'en_US:en', 20:07:13 INFO - 'LOGNAME': 'cltbld', 20:07:13 INFO - 'MAIL': '/var/mail/cltbld', 20:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:13 INFO - 'MOZ_NO_REMOTE': '1', 20:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:13 INFO - 'NO_EM_RESTART': '1', 20:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:13 INFO - 'PWD': '/builds/slave/test', 20:07:13 INFO - 'SHELL': '/bin/bash', 20:07:13 INFO - 'SHLVL': '1', 20:07:13 INFO - 'TERM': 'linux', 20:07:13 INFO - 'TMOUT': '86400', 20:07:13 INFO - 'USER': 'cltbld', 20:07:13 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:13 INFO - '_': '/tools/buildbot/bin/python'} 20:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:13 INFO - Running setup.py (path:/tmp/pip-LgXNFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:13 INFO - Running setup.py (path:/tmp/pip-9hfFde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:13 INFO - Running setup.py (path:/tmp/pip-ippZxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:13 INFO - Running setup.py (path:/tmp/pip-uChNG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:13 INFO - Running setup.py (path:/tmp/pip-0Y4yKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:13 INFO - Running setup.py (path:/tmp/pip-L4xTgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:13 INFO - Running setup.py (path:/tmp/pip-zX386X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:13 INFO - Running setup.py (path:/tmp/pip-LmzxD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:13 INFO - Running setup.py (path:/tmp/pip-yN0nRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:13 INFO - Running setup.py (path:/tmp/pip-SMySE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:14 INFO - Running setup.py (path:/tmp/pip-nC7ZVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:14 INFO - Running setup.py (path:/tmp/pip-fdA_Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:14 INFO - Running setup.py (path:/tmp/pip-jk_L1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:14 INFO - Running setup.py (path:/tmp/pip-E26LXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:14 INFO - Running setup.py (path:/tmp/pip-HbjSSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:14 INFO - Running setup.py (path:/tmp/pip-h9fYpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:14 INFO - Running setup.py (path:/tmp/pip-hGrZZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:07:14 INFO - Running setup.py install for manifestparser 20:07:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:07:14 INFO - Running setup.py install for mozcrash 20:07:14 INFO - Running setup.py install for mozdebug 20:07:14 INFO - Running setup.py install for mozdevice 20:07:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:07:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:07:14 INFO - Running setup.py install for mozfile 20:07:15 INFO - Running setup.py install for mozhttpd 20:07:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Running setup.py install for mozinfo 20:07:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Running setup.py install for mozInstall 20:07:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Running setup.py install for mozleak 20:07:15 INFO - Running setup.py install for mozlog 20:07:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Running setup.py install for moznetwork 20:07:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Running setup.py install for mozprocess 20:07:15 INFO - Running setup.py install for mozprofile 20:07:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Running setup.py install for mozrunner 20:07:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Running setup.py install for mozscreenshot 20:07:16 INFO - Running setup.py install for moztest 20:07:16 INFO - Running setup.py install for mozversion 20:07:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:07:16 INFO - Cleaning up... 20:07:16 INFO - Return code: 0 20:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:07:16 INFO - Using env: {'DISPLAY': ':0', 20:07:16 INFO - 'HOME': '/home/cltbld', 20:07:16 INFO - 'LANG': 'en_US.UTF-8', 20:07:16 INFO - 'LANGUAGE': 'en_US:en', 20:07:16 INFO - 'LOGNAME': 'cltbld', 20:07:16 INFO - 'MAIL': '/var/mail/cltbld', 20:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:16 INFO - 'MOZ_NO_REMOTE': '1', 20:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:16 INFO - 'NO_EM_RESTART': '1', 20:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:16 INFO - 'PWD': '/builds/slave/test', 20:07:16 INFO - 'SHELL': '/bin/bash', 20:07:16 INFO - 'SHLVL': '1', 20:07:16 INFO - 'TERM': 'linux', 20:07:16 INFO - 'TMOUT': '86400', 20:07:16 INFO - 'USER': 'cltbld', 20:07:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:16 INFO - '_': '/tools/buildbot/bin/python'} 20:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:16 INFO - Running setup.py (path:/tmp/pip-34akvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:16 INFO - Running setup.py (path:/tmp/pip-MF3YoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:16 INFO - Running setup.py (path:/tmp/pip-Kvr4IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:16 INFO - Running setup.py (path:/tmp/pip-6Yz5TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:16 INFO - Running setup.py (path:/tmp/pip-Lq92Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:16 INFO - Running setup.py (path:/tmp/pip-tiKso1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:16 INFO - Running setup.py (path:/tmp/pip-bcgwqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:17 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)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:17 INFO - Running setup.py (path:/tmp/pip-EABEXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:17 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)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:17 INFO - Running setup.py (path:/tmp/pip-vBURBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:17 INFO - Running setup.py (path:/tmp/pip-Q80taP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:17 INFO - Running setup.py (path:/tmp/pip-0DxCRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:17 INFO - Running setup.py (path:/tmp/pip-Zpe5of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:17 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)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:17 INFO - Running setup.py (path:/tmp/pip-CYNZo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:17 INFO - Running setup.py (path:/tmp/pip-mCmAHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:17 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)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:17 INFO - Running setup.py (path:/tmp/pip-lVmUFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:17 INFO - Running setup.py (path:/tmp/pip-btxD5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:17 INFO - Running setup.py (path:/tmp/pip-vm3Xln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:07:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:07: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 20:07: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 20:07: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 20:07: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 20:07: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 20:07: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 20:07:19 INFO - Downloading blessings-1.6.tar.gz 20:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:07:19 INFO - Installing collected packages: blessings 20:07:19 INFO - Running setup.py install for blessings 20:07:19 INFO - Successfully installed blessings 20:07:19 INFO - Cleaning up... 20:07:19 INFO - Return code: 0 20:07:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:07:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:20 INFO - Reading from file tmpfile_stdout 20:07:20 INFO - Current package versions: 20:07:20 INFO - argparse == 1.2.1 20:07:20 INFO - blessings == 1.6 20:07:20 INFO - blobuploader == 1.2.4 20:07:20 INFO - docopt == 0.6.1 20:07:20 INFO - functools32 == 3.2.3-2 20:07:20 INFO - jsonschema == 2.5.1 20:07:20 INFO - manifestparser == 1.1 20:07:20 INFO - mozInstall == 1.12 20:07:20 INFO - mozcrash == 0.17 20:07:20 INFO - mozdebug == 0.1 20:07:20 INFO - mozdevice == 0.48 20:07:20 INFO - mozfile == 1.2 20:07:20 INFO - mozhttpd == 0.7 20:07:20 INFO - mozinfo == 0.9 20:07:20 INFO - mozleak == 0.1 20:07:20 INFO - mozlog == 3.3 20:07:20 INFO - moznetwork == 0.27 20:07:20 INFO - mozprocess == 0.23 20:07:20 INFO - mozprofile == 0.28 20:07:20 INFO - mozrunner == 6.12 20:07:20 INFO - mozscreenshot == 0.1 20:07:20 INFO - mozsystemmonitor == 0.3 20:07:20 INFO - moztest == 0.7 20:07:20 INFO - mozversion == 1.4 20:07:20 INFO - psutil == 3.1.1 20:07:20 INFO - requests == 1.2.3 20:07:20 INFO - wsgiref == 0.1.2 20:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:07:20 INFO - Using env: {'DISPLAY': ':0', 20:07:20 INFO - 'HOME': '/home/cltbld', 20:07:20 INFO - 'LANG': 'en_US.UTF-8', 20:07:20 INFO - 'LANGUAGE': 'en_US:en', 20:07:20 INFO - 'LOGNAME': 'cltbld', 20:07:20 INFO - 'MAIL': '/var/mail/cltbld', 20:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:20 INFO - 'MOZ_NO_REMOTE': '1', 20:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:20 INFO - 'NO_EM_RESTART': '1', 20:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:20 INFO - 'PWD': '/builds/slave/test', 20:07:20 INFO - 'SHELL': '/bin/bash', 20:07:20 INFO - 'SHLVL': '1', 20:07:20 INFO - 'TERM': 'linux', 20:07:20 INFO - 'TMOUT': '86400', 20:07:20 INFO - 'USER': 'cltbld', 20:07:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:20 INFO - '_': '/tools/buildbot/bin/python'} 20:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:07:20 INFO - Cleaning up... 20:07:20 INFO - Return code: 0 20:07:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, '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': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', '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 20:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:07:20 INFO - Using env: {'DISPLAY': ':0', 20:07:20 INFO - 'HOME': '/home/cltbld', 20:07:20 INFO - 'LANG': 'en_US.UTF-8', 20:07:20 INFO - 'LANGUAGE': 'en_US:en', 20:07:20 INFO - 'LOGNAME': 'cltbld', 20:07:20 INFO - 'MAIL': '/var/mail/cltbld', 20:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:20 INFO - 'MOZ_NO_REMOTE': '1', 20:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:20 INFO - 'NO_EM_RESTART': '1', 20:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:20 INFO - 'PWD': '/builds/slave/test', 20:07:20 INFO - 'SHELL': '/bin/bash', 20:07:20 INFO - 'SHLVL': '1', 20:07:20 INFO - 'TERM': 'linux', 20:07:20 INFO - 'TMOUT': '86400', 20:07:20 INFO - 'USER': 'cltbld', 20:07:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:20 INFO - '_': '/tools/buildbot/bin/python'} 20:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:07:20 INFO - Cleaning up... 20:07:20 INFO - Return code: 0 20:07:20 INFO - Running post-action listener: _resource_record_post_action 20:07:20 INFO - Running post-action listener: _start_resource_monitoring 20:07:20 INFO - Starting resource monitoring. 20:07:20 INFO - [mozharness: 2016-08-17 03:07:20.556654Z] Finished create-virtualenv step (success) 20:07:20 INFO - [mozharness: 2016-08-17 03:07:20.557109Z] Running install step. 20:07:20 INFO - Running pre-action listener: _resource_record_pre_action 20:07:20 INFO - Running main action method: install 20:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:20 INFO - Reading from file tmpfile_stdout 20:07:20 INFO - Detecting whether we're running mozinstall >=1.0... 20:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:07:20 INFO - Reading from file tmpfile_stdout 20:07:20 INFO - Output received: 20:07:20 INFO - Usage: mozinstall [options] installer 20:07:20 INFO - Options: 20:07:20 INFO - -h, --help show this help message and exit 20:07:20 INFO - -d DEST, --destination=DEST 20:07:20 INFO - Directory to install application into. [default: 20:07:20 INFO - "/builds/slave/test"] 20:07:20 INFO - --app=APP Application being installed. [default: firefox] 20:07:20 INFO - mkdir: /builds/slave/test/build/application 20:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:07:37 INFO - Reading from file tmpfile_stdout 20:07:37 INFO - Output received: 20:07:37 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:37 INFO - Running post-action listener: _resource_record_post_action 20:07:37 INFO - [mozharness: 2016-08-17 03:07:37.765347Z] Finished install step (success) 20:07:37 INFO - [mozharness: 2016-08-17 03:07:37.765637Z] Running run-tests step. 20:07:37 INFO - Running pre-action listener: _resource_record_pre_action 20:07:37 INFO - Running main action method: run_tests 20:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:37 INFO - Python 2.7.3 20:07:37 INFO - Return code: 0 20:07:37 INFO - grabbing minidump binary from tooltool 20:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:37 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 0x16ed370>, '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 0x16f08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:37 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 20:07:37 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 20:07:37 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 20:07:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:37 INFO - Return code: 0 20:07:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 20:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 20:07:37 INFO - Using env: {'DISPLAY': ':0', 20:07:37 INFO - 'HOME': '/home/cltbld', 20:07:37 INFO - 'LANG': 'en_US.UTF-8', 20:07:37 INFO - 'LANGUAGE': 'en_US:en', 20:07:37 INFO - 'LOGNAME': 'cltbld', 20:07:37 INFO - 'MAIL': '/var/mail/cltbld', 20:07:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:37 INFO - 'MOZ_NO_REMOTE': '1', 20:07:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:37 INFO - 'NO_EM_RESTART': '1', 20:07:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:37 INFO - 'PWD': '/builds/slave/test', 20:07:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:37 INFO - 'SHELL': '/bin/bash', 20:07:37 INFO - 'SHLVL': '1', 20:07:37 INFO - 'TERM': 'linux', 20:07:37 INFO - 'TMOUT': '86400', 20:07:37 INFO - 'USER': 'cltbld', 20:07:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077', 20:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:37 INFO - '_': '/tools/buildbot/bin/python'} 20:07:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 20:07:38 INFO - mozversion application_buildid: 20160816173004 20:07:38 INFO - mozversion application_changeset: 4b48ad68a5945476857c08a9f67487fbdae51582 20:07:38 INFO - mozversion application_display_name: Nightly 20:07:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:38 INFO - mozversion application_name: Firefox 20:07:38 INFO - mozversion application_remotingname: firefox 20:07:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:07:38 INFO - mozversion application_vendor: Mozilla 20:07:38 INFO - mozversion application_version: 51.0a1 20:07:38 INFO - mozversion platform_buildid: 20160816173004 20:07:38 INFO - mozversion platform_changeset: 4b48ad68a5945476857c08a9f67487fbdae51582 20:07:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:07:38 INFO - mozversion platform_version: 51.0a1 20:07:38 INFO - using testdate: 1471403258 20:07:38 INFO - actual date: 1471403258 20:07:38 INFO - starting webserver on 'localhost:55800' 20:07:38 INFO - SUITE-START | Running 2 tests 20:07:38 INFO - TEST-START | dromaeo_css 20:07:38 INFO - operating with platform_type : linux_ 20:07:38 INFO - Initialising browser for dromaeo_css test... 20:07:38 INFO - TEST-INFO | started process 8939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDd3lv4/profile http://localhost:55800/getInfo.html) 20:07:41 INFO - PROCESS | 8939 | __metrics Screen width/height:1600/1200 20:07:41 INFO - PROCESS | 8939 | colorDepth:24 20:07:41 INFO - PROCESS | 8939 | Browser inner width/height: 1024/697 20:07:41 INFO - PROCESS | 8939 | __metrics 20:07:42 INFO - PROCESS | 8939 | 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" 20:07:42 INFO - PROCESS | 8939 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:42 INFO - PROCESS | 8939 | console.error: PushService: 20:07:42 INFO - PROCESS | 8939 | stateChangeProcessEnqueue: Error transitioning state 20:07:42 INFO - PROCESS | 8939 | UnknownError 20:07:43 INFO - TEST-INFO | 8939: exit 0 20:07:43 INFO - Browser initialized. 20:07:43 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:43 INFO - TEST-INFO | started process 9020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDd3lv4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:55 INFO - PROCESS | 9020 | RSS: Main: 155062272 20:07:55 INFO - PROCESS | 9020 | 20:08:46 INFO - PROCESS | 9020 | 1471403326866 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] 20:10:56 INFO - PROCESS | 9020 | Cycle 1(1): loaded http://localhost:55800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55800/tests/dromaeo/cssquery-ext.html) 20:10:57 INFO - PROCESS | 9020 | RSS: Main: 251404288 20:10:57 INFO - PROCESS | 9020 | 20:13:59 INFO - PROCESS | 9020 | Cycle 1(1): loaded http://localhost:55800/tests/dromaeo/cssquery-ext.html (next: http://localhost:55800/tests/dromaeo/cssquery-jquery.html) 20:14:00 INFO - PROCESS | 9020 | RSS: Main: 250179584 20:14:00 INFO - PROCESS | 9020 | 20:17:02 INFO - PROCESS | 9020 | Cycle 1(1): loaded http://localhost:55800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55800/tests/dromaeo/cssquery-mootools.html) 20:17:02 INFO - PROCESS | 9020 | RSS: Main: 184516608 20:17:02 INFO - PROCESS | 9020 | 20:20:04 INFO - PROCESS | 9020 | Cycle 1(1): loaded http://localhost:55800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55800/tests/dromaeo/cssquery-prototype.html) 20:20:05 INFO - PROCESS | 9020 | RSS: Main: 226086912 20:20:05 INFO - PROCESS | 9020 | 20:23:08 INFO - PROCESS | 9020 | Cycle 1(1): loaded http://localhost:55800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55800/tests/dromaeo/cssquery-yui.html) 20:23:08 INFO - PROCESS | 9020 | RSS: Main: 184225792 20:23:08 INFO - PROCESS | 9020 | 20:26:11 INFO - PROCESS | 9020 | Cycle 1(1): loaded http://localhost:55800/tests/dromaeo/cssquery-yui.html (next: http://localhost:55800/tests/dromaeo/cssquery-dojo.html) 20:26:11 INFO - PROCESS | 9020 | RSS: Main: 277118976 20:26:11 INFO - PROCESS | 9020 | 20:26:11 INFO - PROCESS | 9020 | __start_tp_report 20:26:11 INFO - PROCESS | 9020 | _x_x_mozilla_page_load 20:26:11 INFO - PROCESS | 9020 | _x_x_mozilla_page_load_details 20:26:11 INFO - PROCESS | 9020 | |i|pagename|runs| 20:26:11 INFO - PROCESS | 9020 | |0;dojo.html;3078.107348868828;3103.3017571046516;3104.394643044606;3117.454445472043;3153.731932785714;5213.86965325867;5241.79032838686;5367.168088946215;5431.131019036955;5467.5899307551945;5357.571394288458;5378.704171270579;5421.83734487966;5478.753456094475;5522.585806064541;4873.585745211662;4911.607071434277;4911.729854857981;4929.383827021622;4945;5022.070916880389;5053.696778193302;5061.949380506185;5098.949010509885;5100.081985242655;4997.950020499785;5012.649114561982;5040.067587496306;5047.924281135786;5099.847004589868;4720.268358404453;4853.4418541867435;4894.363732714724;4907.950920490785;4924.384451943507;4820.662553621248;4838.274258861164;4843.515648435164;4922.187839006559;4961.5286547777905;5413.296271484721;5438.53772429344;5481.040817856899;5486.588505862076;5511.834644960658;5516.862078448031;5738.081906894919;5815.73829177688;5817.214676018768;5904.321003084658;5918.615290006136;5920.437558431985;5920.911186332209;5938.317093534256;5943.881122377571;5142.794288228504;5513.889722205574;5518.834434966958;5522.475364840334;5525.944740552623;5818.127280907813;5888.705564721747;5896.174535565025;5994.640321580632;5995.640261584319;5675.886482270332;5736.569757268222;5737.053386191232;5739.655620662774;5741.45456181662;5476.972615136899;5764.682942438206;5842.328132264759;5845.152452894392;5847.06446968483;5671.489565939085;5718.599698021098;5721.141828725725;5816.069428891357;5818.94181058184;5744.569157313218;5786.739596718074;5795.130730390475;5796.333421656564;5809.796657116981;4424.380586717862;4446.710963787344;4458.375827384169;4461.219286624892;4498.3927169832305;3816.3512202925567;3925.0972276376024;3962.643362097425;3982.721209515364;4061.6953728470485;5498.45015498455;5505.476979686923;5509.559235261169;5512.062949298549;5553.722313884289;5882.088276317092;5887.882242355129;5894.734736936848;5895.882082358329;5897.49871260939;5264.341957255343;5369.140937449989;5416.14783085127;5429.619926605179;5529.889402212014;5031.874203144877;5060.291559181717;5063.1898896176435;5072.6195535335;5077.568406685473;6078.939210607926;6078.996965500643;6085.939140608626;6091.811228689837;6135.049067394561;5590.273264475755;5750.30366042027;5778.971105144447;5807.738651760596;5908.3500814911185;6056.6971651418135;6057.909131362945;6059.878802424015;6060.303065147388;6061.060535616986;5679.9148012779015;5725.713714314351;5725.914111288251;5729.140628905698;5740.90922724681;5583.804566840141;5635.464630860061;5702.572307076903;5728.914066289092;5834.27071616048;5590.720463976866;5637.267155269788;5638.182463542846;5638.323401191883;5639.041362968223;5616.438356164351;5624;5625.353084395347;5632.873425314871;5634.816688495462;5436.700981446058;5580;5609.719514024201;5632.957902787997;5728.312602487728;5749.597528173155;5753.712314384347;5781.335146458211;5799.246098007232;5801.593888427769;5618.915716264341;5633.295838020247;5634.577406694432;5637.154426836008;5638.182463542846 20:26:11 INFO - PROCESS | 9020 | |1;ext.html;572.2189211725994;580.6975342765933;605.3129697793009;609.3449541742625;614.410166240409;43777.56222437775;45222.547774522245;45459.31811022837;45481.545184548144;49081.75459122708;46221.76889115558;46478.76760616192;46634.53365466353;46653.30020049693;46663.30005049927;8048.798780030487;8867.157620026102;9013.36906416551;9015;10602.310849794738;10340.121089707347;10786.838197427045;10792;10793.460326983659;10794.514246858871;10844.62043828466;10883.292585981886;10900.836487452654;10909.890901091007;10916.290441121302;10793.784124317508;10834.566617335297;10845.349279043283;10846.511906964166;10850.348979061202;10493.632722854663;10499.317544359592;10505.4222017789;10508.369497830156;10552.208584356127;43220.56779432197;43508;43678.344824827655;43695.78152109251;43770.12459750787;3542;3697.9815100924593;4060.756354618703;4162.438070860456;4249.405083288342;33232.6676733232;33372.83313583417;33395.16512087193;33648.32703345944;35096.298074038634;3941.8817435476694;3945.3687410014545;4028.194361127786;4052.6555242804397;4118.588141185887;352733;353682;354269;354480;355146;36040.4593931086;37099;59744.70127649334;60215.698921505114;60234.698826506465;38136.8093159538;38407.231855362734;38445.23109537794;38478;38509.2298154041;15750.68498630021;15866.60333491672;15892.046477211405;15899.364025438854;15901.204939752966;12058.276503409823;12868.613941581767;13122.409491572902;13123.212607243597;13359.465621375037;8631;8639;8724.040355560883;8748.081451447633;8780.78048048791;3327.434336162858;3339.7662163648797;3403.149212696826;3417.8803741868915;3428.879989200366;1054.646225004493;1062.8990245926625;1079.3254216114929;1096.7258185453636;1156.8380426740264;33029.3394132116;33337.49993750096;33615.66384336125;33635.495467568006;33699.49450758241;1123.9943800280946;1167.1888037813637;1182.408795602199;1185.2177562808506;1189.7679952409371;17236.759221301403;17328.133593320537;17348.392806251974;17608.471745847644;17800.91099544494;571918;573561;580653;580940;581441;58141.70929145327;58937.41062589319;58989;59027.40972590305;59078.40921590729;1255.221762507233;1343.8253027106414;1357.429879450633;1373.4986729843536;1386.4384924105552;31674;33200.833995830835;34212.09197218264;34525.65474345224;34682.512801099554;51724.224136637225;52023;52085.21872171996;52110.21834672407;52123;323904;324049;325275;326456;326632;28703;28969.841206352354;29120.7087929118;29142.774297727134;31078.844605776827;48273.76985587418;48566.75716621536;48871.26693099535;49194.75402623107;49599.752001239765;40574.79712601418;41046.79476602598;41203.7939810299;41889.58110418979;43476;41162.79418602888;41616.583834162484;42263.57736422597;42733.57266427296;44246.557534424246;42780.35829462498;43364;43586.564134358254;43921.560784391746;44012;36344.45483317699;37701.4344784823;38346.616533834305;39017.219655607296;39226.411603826535;28833.711662883103;29093.597929594518;29186.56220156657;29402.264943376587;29636.85181574078 20:26:11 INFO - PROCESS | 9020 | |2;jquery.html;359.50388463919785;381.1842656714629;396.4964495091235;404.0847480456765;409.0897752500686;14470.276486175688;16515.752263716055;19192.424227273168;19628.803711962875;19631.901840490813;18292.908535457304;18455.35406260781;18519.2592296308;18630.53423664409;18653.720194197063;4305.138972205556;5726.541876649869;5861;5903.557233207526;5908.911366329508;6284.465820405248;6550.672466376686;6603.009548567706;6636.2036555613395;6772.08576842125;6571.44142747867;6604.570702904296;7266.128064632251;7548.660310286023;7570.848583028336;7458.142313633947;7593;7656.540607563564;7658.157602663702;7663.731769388045;7445.776626701154;7446.5532068075545;7462.067241594801;7463.4029277657655;7467.925320746777;27012.729872701217;28171.154865354074;28209.858950705115;28210.435791284264;28446.573301400495;2418.8427752196053;2491.1530079772965;2509.8117641176987;2528.4184637533285;3254.3653987472217;15283.388664453409;16144.59638509035;16589.004659720456;16777.832221677872;16801;2056.516718571135;2188.518525924294;2219.7447293561286;2259.6836442898007;2310.2145270608075;93108;100473.49763251137;102640;102966;106447;16358.918205409134;17139.22873470697;17509.474715758548;17914.999999999738;18430.35493757712;32844.34311313808;33013.339733205205;33083;33090;33106.83446582752;10506.317089389318;10632;10713.785724285626;10774.299670521392;10825.404602746925;8449.704260350858;8792.736217913473;8835.602397892111;8921.910780892238;9121.407108537924;9137.269018478506;9181;9195;9551.808963820824;9561.952190239004;3336.645677391028;3486.89539313821;3527.6732134477124;3713.4986776785327;3765.2657731742597;892.4823602310644;964.7636329099275;990.9504524773732;1036.512838965685;1039.4335087377397;19678.508037298896;20290.79709202889;20507.69238461424;20682.689759653316;20733.792662073185;1007.7178390050798;1009.4448053570653;1013.7516308504464;1019.8062368150028;1079.3523885668692;10464.633737819293;11184.384858832842;11294;11337.829932550854;11364.943175284236;548992;550451;563032;582425.669561391;588953;99787.50106249568;100268.49865750625;100692.49653751684;104711.4764426173;105845.47077264564;1007.5163921317809;1020.6172685243034;1061.0291583201285;1065.073386154051;1066.4561073852235;17496.91251543734;17922.5519362017;18434.90782546079;18582.933815920762;18888.300052995295;43210.56789432191;44084.86048208994;44528;44636;45069.54930450785;59751.701241493516;61840.38159618346;63070.68464657831;64272;64721.35278647341;8427;8433.704820331259;8586.957065214634;8689.435186712843;8794.560271986247;12479.31363775001;13351.933240333736;13469.259190744604;13535.72928541404;13602.659933501742;11565.884341156818;11622.825657614974;11660.708482288012;11978.341191234565;12411.193272437262;10951.50718217698;11583.305001699924;11706.122040847142;11936.940315298369;12459.875401245872;11691.532338706356;12078.456469459072;12386.504539818307;12406.875931240573;12416.634170241086;8367.748967530984;8393;8483.703070392754;8526.488410695378;8609.182127697859;10407.94796026015;11675.124365672438;11714.648560543197;11802.232854864405;12110.152289339661 20:26:11 INFO - PROCESS | 9020 | |3;mootools.html;1334.6529902225418;1470.6323419145217;1513.2660659580101;1619.9757003644947;1757.7890653121626;7819.843603127934;8680.869786953193;8944.8658270126;8948.328875334344;9219.58511866966;9019.458832470056;9087.591058402371;9093.090690930903;9105.226055785266;9109.271258299337;2433.7444568320293;2454.7177074636465;2463.310273123528;2463.618139188429;2467.5188338274043;2407.422218667516;2482.056818409002;2489.9004039838383;2492.5513407586627;2496.400863792686;2354.7409784923643;2373.41851246444;2398.8920498577604;2402.3873912152376;2403.182917807945;2318.8956496957676;2329.790318871301;2333.0784340185533;2334.708161479815;2371.1819422299277;2347.542229265294;2348.6477028445697;2355.623100303943;2361.445060410802;2361.858288502678;8758.2993360531;8904.421212621159;8985.05656906022;9012.233960113399;9026.23277021454;5428.158635411518;5522.972385138089;5555.972220138914;5561.277033985556;5567.081431563787;3410.7100896423835;3470.9652903470896;3532.311199316134;3538.4515400113023;3541.645835416438;1111.283222321598;1120.1430905357408;1124.1512657943201;1124.4602590756483;1130.3307061587093;12672.366381680971;12763.808542871864;12779.61661150167;12813.743725125445;12834.743305133938;4447.421835161408;4656.67403281767;4731.95268047322;4741.359916411309;4749.097671442415;10021.849672254923;10026.398416095057;10029.197664186848;10035.197184225244;10040.497975101362;5416.8104116355735;5421.132618781055;5424.538914192259;5426.240326354314;5429.592780541475;4465.307877279027;4917.188663870421;5058.4435712071645;5076.720780357042;5082.186850103965;3791.4123310886857;3825.2923209206388;3875.8837234883;3937.684985201177;3962.405639154092;1122.7417693930443;1157.5543415784985;1170.2568868768394;1174.8061569840881;1183.7514122034297;964.7491652170486;977.3549457358109;981.4651015196735;991.3605724307781;1004.467632154959;5901.793437229677;5961.799332627055;6010.158577799111;6020.8795824084145;6086.452219300196;484.760043778332;486.4989061266901;486.7128394247411;490.70312460961316;501.6989806116374;4047.170330082326;4121.505419349697;4162.209180255742;4252.149570085995;4277.636400905895;10565.366078035342;10992.560297588167;10994.670159895057;11310.94344528272;11340.773184536263;11213.66359009231;11252.49363778632;11255.549778008788;11291.49188286529;11304.943475282735;8223.136570660114;8409.747707568782;8414.747557573404;8415.368847336475;8421.873671894926;6337.4613157882095;6487.22153341602;6526.543141980205;6549.443297319781;6614.834629134118;10268.332558383681;10600.257981941499;10619.203559733205;10621.628243011766;10632.25574209798;10418.583256669648;10644.414557199429;10655.467226638482;10745.623903163665;10815;7323.890141647986;7535.208803075818;7540.396768258416;8134.959325203336;8282.378821588285;8122.67509299645;8700.390972631854;8765.737027889174;8998.64005439775;9000.199960007894;7773.300402963534;7824.9608751955875;7992.5204487730925;8041;8325.209105135002;7731.884021739791;7753.340966017951;7790.298873101448;7902.4863383879865;7934.1272460030505;7181.281871812777;7274.709011639475;7274.745383911538;7300;7384.076990376203;4791.353167322367;4803.183458811941;4840.394950631171;4952.331435256338;5079.822206222764;5155.175171972466;5172.637915345889;5206.323177986989;5279;5310.468953104813 20:26:11 INFO - PROCESS | 9020 | |4;prototype.html;321.5482247442343;335.54533606962565;341.45878782130336;341.6378638643039;344.2770182616504;5299.735013249337;5339.5461385782155;5353.491418315259;5368.8389348319615;5375.462453754622;4985.180409150661;5052.650517509357;5219.321488206538;5250.317458730369;5265.921011184826;4177.248095342837;4188.371744238373;4220.388043733665;4222;4224.134052519226;4177.540470548237;4210.431591735107;4213.810378532973;4219.620234178923;4224.239636865363;3931.9803400982955;4054.6756259499316;4165.125323682015;4168.520620128678;4174.874753757392;4133.3386658134705;4142.514491305223;4150.232207041692;4157.792110394468;4188.769617671027;3717.3494638438165;3719.6838268747188;3726.4596633488263;3730.552333719971;3731.589525152231;4970.751462426864;5093.694378337312;5094.694318340874;5147.382314122329;5175.249588809602;4742.1227072991605;4750.809967601292;4761.357331720551;4767.308740232646;4777.450593181794;5450.727463626803;5468.9726551367385;5499.587530935196;5505.752241149118;5524.458748975476;3984.143409167043;4036.535798383165;4088.9591104088877;4098.7950602470055;4098.856540021085;5696.544276457915;5703.572232082611;5704.657720536739;5708.857278568027;5771.307443106812;4155.605217504332;4160.43834082395;4165.166966606691;4168.7290326128705;4206.8737937861915;4099.795010249476;4209.431726716915;4256.936145957813;4257.276263035292;4271.359296105609;4728.338032675429;4728.40894888139;4738.739369334719;4746.762661866893;4788.138135135709;5514.779408823602;5521.2270282160525;5537.307836520435;5543.556515478752;5550.500454959073;1399.5941177058742;1451.5355086372472;1462.1300326305832;1472.8011718417877;1477.869429886138;935.4247138010074;957.5690939077303;957.8515330123703;968.9176420004237;969.3941286695815;4502.298620827542;4691.592522243382;4698.130845793471;4781.282807578891;4812.278158276286;5014.592995362246;5018.5232402921665;5024.422191447957;5098.566621837185;5100.5409513143995;4715.882102947454;4786.282057691375;4805.438232574427;4818.445878723992;4819.3252744726315;2609.3998380372623;2614.4879267277493;2640.392709676785;2645;2705.418335057972;5176.430592634807;5193.350831146106;5193.870153246199;5217.321748172789;5237.266782650432;5098.388193416814;5110.335656364723;5123.028643386901;5124.410692770304;5146.228065790161;5196.506331898464;5197;5208.713520756319;5501.807436739775;5981.773736383944;5680.857978550569;5694.402087780723;5695.943040569541;5705.486506214461;5715.199872018004;5642.266505354278;5648.661080335193;5732.7706891723865;5737.770489180386;5753.331533855135;5817.848769779866;5920.526357891272;5930.614510056833;5987.820365389045;6008.789692360747;4075.266452038543;4092.2020206060724;4116.773577453149;4118.464599602033;4128.731632444002;5537.640053396516;5632.831015069554;5657.179708942098;5762.855928601818;5778.659642844655;5570.470805273492;5582.358028826737;5602.85992850182;5628.85927851807;5646.181303711021;5328;5641.915371269352;5643.037405362218;5661.745221464962;5702.914456283242;5498.3127109111365;5534.169874518854;5544.532682956045;5547.472990065938;5549.7780088796;5564.19319198722;5597.608167428241;5677.31872175325;5683.516901063456;5714.457126572969;5255.973720131527;5485.314335708036;5536.640118392292;5553.333599968029;5565.693886836263 20:26:11 INFO - PROCESS | 9020 | |5;yui.html;738.8263758016865;743.8066102813268;761.9847603047939;782.9582073643894;816.2939057715079;15498.38006479741;17039.318427262893;17054.914725426388;17080.402185923496;17138.143092845356;15297.235138243099;15429.151396673207;15442.227888605554;15463.922680386582;15474.922625386856;666.203886355805;786.1588100732218;801.1787917384669;807.3742849291787;813.6826637611337;807.3460496997421;818.7420962396826;822.3503432288514;823.6499487717726;823.8434697407504;866.1208872993916;867.3538214030556;867.3841572483512;867.995660021699;868.6264906090379;690.6753825701912;855.0508935082054;862.5299211929513;862.5730263519536;863.5207459859776;617.2315467243311;626.4455956478549;633;633.6704913445029;635.5963962883555;14337.35481903317;14394.352254148589;14408.567742967727;14410.855891441057;14430.855691443161;13819.447222111103;14332.57002289933;14664.120152790867;14817.407303707838;14820.40718371264;13187.60437186886;13318.600441986757;13365.86634133656;13509.527166549124;13758.587242382744;4438.822447102112;4455.264881294583;4488.708233964782;4533.9319910201375;4539.818407263706;80144;84447;84595.57702211512;85103;85792;11473.655790326136;11496.252743571642;11532.135089868294;11559.711007224887;11805.822912656316;21795.34613961584;21806.23678171288;22271.220507282167;22275.108995639992;22571.322860314216;8639.913600864036;8681.609327580149;8835.249003834617;8858;8993.595288212045;4678.719276843332;4751.3348131261655;4785.832495862628;4829.66192366531;4837.564619184291;3520.982395088008;3633.418653015505;3634.945475817865;3634.9818250909107;3635.1457407509215;648.3613640564041;648.5395369287764;652.5236577298599;662.7415308029872;676.4757313082303;558.9329280486286;611.0467670434138;648.7178077536287;672.5729161982078;680.9931900681029;9225.354225204306;9675.322727409013;9682.273829462678;9808;9963.900360996442;572.2758627529715;652.9281779004306;672.5897202706345;677.3869647968596;688.6728803818146;4780.928286075712;4825;4879.829205977774;4896.5103489651465;4905.190643543775;72998.27001730021;103826.48086759518;127249;129649.35175324252;133115;110257.44871275593;110899;111226;113061;116390;90592.6411103834;91069.54465227631;91852;93816.53091734635;94705.52647236857;9115.817683646157;9336.579853906725;9339.299552533723;9340.859887101835;9378.577963991773;55375.44624553703;55691;55816.720916395156;56658;57306;76090.23909761052;79076;81314.59342703248;82264.12830460383;84625;11861.703457413634;12098.75802483963;12245.265284082983;12327.876721232673;12668.113232073667;12751.48994040228;12937.417816198105;13345.132566383154;13372.264525451194;13396.196228226338;11846.289222646668;12332.321722305;12807.551735689207;13802.37889294964;14650.92674536663;14407.85592144107;14415.567532974028;14454.205018724071;15616.375344986074;15787.447439340027;12903.677408064874;13619.523316683868;13875.583732488041;14161.362738676578;14198.787018194942;11580;11758.235714678518;11896.464659090188;12345.444454999368;12483.93758031204;11863.940680296544;11864.40677966081;11884.643460696192;12200.572979945659;12379.195352302071 20:26:11 INFO - PROCESS | 9020 | __end_tp_report 20:26:11 INFO - PROCESS | 9020 | __start_cc_report 20:26:11 INFO - PROCESS | 9020 | _x_x_mozilla_cycle_collect,914 20:26:11 INFO - PROCESS | 9020 | __end_cc_report 20:26:11 INFO - PROCESS | 9020 | __startTimestamp1471404371711__endTimestamp 20:26:11 INFO - PROCESS | 9020 | 20:26:11 INFO - PROCESS | 9020 | ------- Summary: start ------- 20:26:11 INFO - PROCESS | 9020 | Number of tests: 6 20:26:11 INFO - PROCESS | 9020 | 20:26:11 INFO - PROCESS | 9020 | [#0] dojo.html Cycles:165 Average:5395.70 Median:5609.72 stddev:618.61 (11.0%) stddev-sans-first:593.19 20:26:11 INFO - PROCESS | 9020 | Values: 3078.1 3103.3 3104.4 3117.5 3153.7 5213.9 5241.8 5367.2 5431.1 5467.6 5357.6 5378.7 5421.8 5478.8 5522.6 4873.6 4911.6 4911.7 4929.4 4945.0 5022.1 5053.7 5061.9 5098.9 5100.1 4998.0 5012.6 5040.1 5047.9 5099.8 4720.3 4853.4 4894.4 4908.0 4924.4 4820.7 4838.3 4843.5 4922.2 4961.5 5413.3 5438.5 5481.0 5486.6 5511.8 5516.9 5738.1 5815.7 5817.2 5904.3 5918.6 5920.4 5920.9 5938.3 5943.9 5142.8 5513.9 5518.8 5522.5 5525.9 5818.1 5888.7 5896.2 5994.6 5995.6 5675.9 5736.6 5737.1 5739.7 5741.5 5477.0 5764.7 5842.3 5845.2 5847.1 5671.5 5718.6 5721.1 5816.1 5818.9 5744.6 5786.7 5795.1 5796.3 5809.8 4424.4 4446.7 4458.4 4461.2 4498.4 3816.4 3925.1 3962.6 3982.7 4061.7 5498.5 5505.5 5509.6 5512.1 5553.7 5882.1 5887.9 5894.7 5895.9 5897.5 5264.3 5369.1 5416.1 5429.6 5529.9 5031.9 5060.3 5063.2 5072.6 5077.6 6078.9 6079.0 6085.9 6091.8 6135.0 5590.3 5750.3 5779.0 5807.7 5908.4 6056.7 6057.9 6059.9 6060.3 6061.1 5679.9 5725.7 5725.9 5729.1 5740.9 5583.8 5635.5 5702.6 5728.9 5834.3 5590.7 5637.3 5638.2 5638.3 5639.0 5616.4 5624.0 5625.4 5632.9 5634.8 5436.7 5580.0 5609.7 5633.0 5728.3 5749.6 5753.7 5781.3 5799.2 5801.6 5618.9 5633.3 5634.6 5637.2 5638.2 20:26:11 INFO - PROCESS | 9020 | 20:26:11 INFO - PROCESS | 9020 | [#1] ext.html Cycles:180 Average:58041.24 Median:354813.00 stddev:115299.67 (32.5%) stddev-sans-first:115542.37 20:26:11 INFO - PROCESS | 9020 | Values: 572.2 580.7 605.3 609.3 614.4 43777.6 45222.5 45459.3 45481.5 49081.8 46221.8 46478.8 46634.5 46653.3 46663.3 8048.8 8867.2 9013.4 9015.0 10602.3 10340.1 10786.8 10792.0 10793.5 10794.5 10844.6 10883.3 10900.8 10909.9 10916.3 10793.8 10834.6 10845.3 10846.5 10850.3 10493.6 10499.3 10505.4 10508.4 10552.2 43220.6 43508.0 43678.3 43695.8 43770.1 3542.0 3698.0 4060.8 4162.4 4249.4 33232.7 33372.8 33395.2 33648.3 35096.3 3941.9 3945.4 4028.2 4052.7 4118.6 352733.0 353682.0 354269.0 354480.0 355146.0 36040.5 37099.0 59744.7 60215.7 60234.7 38136.8 38407.2 38445.2 38478.0 38509.2 15750.7 15866.6 15892.0 15899.4 15901.2 12058.3 12868.6 13122.4 13123.2 13359.5 8631.0 8639.0 8724.0 8748.1 8780.8 3327.4 3339.8 3403.1 3417.9 3428.9 1054.6 1062.9 1079.3 1096.7 1156.8 33029.3 33337.5 33615.7 33635.5 33699.5 1124.0 1167.2 1182.4 1185.2 1189.8 17236.8 17328.1 17348.4 17608.5 17800.9 571918.0 573561.0 580653.0 580940.0 581441.0 58141.7 58937.4 58989.0 59027.4 59078.4 1255.2 1343.8 1357.4 1373.5 1386.4 31674.0 33200.8 34212.1 34525.7 34682.5 51724.2 52023.0 52085.2 52110.2 52123.0 323904.0 324049.0 325275.0 326456.0 326632.0 28703.0 28969.8 29120.7 29142.8 31078.8 48273.8 48566.8 48871.3 49194.8 49599.8 40574.8 41046.8 41203.8 41889.6 43476.0 41162.8 41616.6 42263.6 42733.6 44246.6 42780.4 43364.0 43586.6 43921.6 44012.0 36344.5 37701.4 38346.6 39017.2 39226.4 28833.7 29093.6 29186.6 29402.3 29636.9 20:26:11 INFO - PROCESS | 9020 | 20:26:11 INFO - PROCESS | 9020 | [#2] jquery.html Cycles:180 Average:33634.50 Median:2455.00 stddev:93473.98 (3807.5%) stddev-sans-first:93702.80 20:26:11 INFO - PROCESS | 9020 | Values: 359.5 381.2 396.5 404.1 409.1 14470.3 16515.8 19192.4 19628.8 19631.9 18292.9 18455.4 18519.3 18630.5 18653.7 4305.1 5726.5 5861.0 5903.6 5908.9 6284.5 6550.7 6603.0 6636.2 6772.1 6571.4 6604.6 7266.1 7548.7 7570.8 7458.1 7593.0 7656.5 7658.2 7663.7 7445.8 7446.6 7462.1 7463.4 7467.9 27012.7 28171.2 28209.9 28210.4 28446.6 2418.8 2491.2 2509.8 2528.4 3254.4 15283.4 16144.6 16589.0 16777.8 16801.0 2056.5 2188.5 2219.7 2259.7 2310.2 93108.0 100473.5 102640.0 102966.0 106447.0 16358.9 17139.2 17509.5 17915.0 18430.4 32844.3 33013.3 33083.0 33090.0 33106.8 10506.3 10632.0 10713.8 10774.3 10825.4 8449.7 8792.7 8835.6 8921.9 9121.4 9137.3 9181.0 9195.0 9551.8 9562.0 3336.6 3486.9 3527.7 3713.5 3765.3 892.5 964.8 991.0 1036.5 1039.4 19678.5 20290.8 20507.7 20682.7 20733.8 1007.7 1009.4 1013.8 1019.8 1079.4 10464.6 11184.4 11294.0 11337.8 11364.9 548992.0 550451.0 563032.0 582425.7 588953.0 99787.5 100268.5 100692.5 104711.5 105845.5 1007.5 1020.6 1061.0 1065.1 1066.5 17496.9 17922.6 18434.9 18582.9 18888.3 43210.6 44084.9 44528.0 44636.0 45069.5 59751.7 61840.4 63070.7 64272.0 64721.4 8427.0 8433.7 8587.0 8689.4 8794.6 12479.3 13351.9 13469.3 13535.7 13602.7 11565.9 11622.8 11660.7 11978.3 12411.2 10951.5 11583.3 11706.1 11936.9 12459.9 11691.5 12078.5 12386.5 12406.9 12416.6 8367.7 8393.0 8483.7 8526.5 8609.2 10407.9 11675.1 11714.6 11802.2 12110.2 20:26:11 INFO - PROCESS | 9020 | 20:26:11 INFO - PROCESS | 9020 | [#3] mootools.html Cycles:180 Average:5917.20 Median:4745.23 stddev:3408.09 (71.8%) stddev-sans-first:3400.25 20:26:11 INFO - PROCESS | 9020 | Values: 1334.7 1470.6 1513.3 1620.0 1757.8 7819.8 8680.9 8944.9 8948.3 9219.6 9019.5 9087.6 9093.1 9105.2 9109.3 2433.7 2454.7 2463.3 2463.6 2467.5 2407.4 2482.1 2489.9 2492.6 2496.4 2354.7 2373.4 2398.9 2402.4 2403.2 2318.9 2329.8 2333.1 2334.7 2371.2 2347.5 2348.6 2355.6 2361.4 2361.9 8758.3 8904.4 8985.1 9012.2 9026.2 5428.2 5523.0 5556.0 5561.3 5567.1 3410.7 3471.0 3532.3 3538.5 3541.6 1111.3 1120.1 1124.2 1124.5 1130.3 12672.4 12763.8 12779.6 12813.7 12834.7 4447.4 4656.7 4732.0 4741.4 4749.1 10021.8 10026.4 10029.2 10035.2 10040.5 5416.8 5421.1 5424.5 5426.2 5429.6 4465.3 4917.2 5058.4 5076.7 5082.2 3791.4 3825.3 3875.9 3937.7 3962.4 1122.7 1157.6 1170.3 1174.8 1183.8 964.7 977.4 981.5 991.4 1004.5 5901.8 5961.8 6010.2 6020.9 6086.5 484.8 486.5 486.7 490.7 501.7 4047.2 4121.5 4162.2 4252.1 4277.6 10565.4 10992.6 10994.7 11310.9 11340.8 11213.7 11252.5 11255.5 11291.5 11304.9 8223.1 8409.7 8414.7 8415.4 8421.9 6337.5 6487.2 6526.5 6549.4 6614.8 10268.3 10600.3 10619.2 10621.6 10632.3 10418.6 10644.4 10655.5 10745.6 10815.0 7323.9 7535.2 7540.4 8135.0 8282.4 8122.7 8700.4 8765.7 8998.6 9000.2 7773.3 7825.0 7992.5 8041.0 8325.2 7731.9 7753.3 7790.3 7902.5 7934.1 7181.3 7274.7 7274.7 7300.0 7384.1 4791.4 4803.2 4840.4 4952.3 5079.8 5155.2 5172.6 5206.3 5279.0 5310.5 20:26:11 INFO - PROCESS | 9020 | 20:26:11 INFO - PROCESS | 9020 | [#4] prototype.html Cycles:180 Average:4592.72 Median:5105.44 stddev:1331.61 (26.1%) stddev-sans-first:1296.19 20:26:11 INFO - PROCESS | 9020 | Values: 321.5 335.5 341.5 341.6 344.3 5299.7 5339.5 5353.5 5368.8 5375.5 4985.2 5052.7 5219.3 5250.3 5265.9 4177.2 4188.4 4220.4 4222.0 4224.1 4177.5 4210.4 4213.8 4219.6 4224.2 3932.0 4054.7 4165.1 4168.5 4174.9 4133.3 4142.5 4150.2 4157.8 4188.8 3717.3 3719.7 3726.5 3730.6 3731.6 4970.8 5093.7 5094.7 5147.4 5175.2 4742.1 4750.8 4761.4 4767.3 4777.5 5450.7 5469.0 5499.6 5505.8 5524.5 3984.1 4036.5 4089.0 4098.8 4098.9 5696.5 5703.6 5704.7 5708.9 5771.3 4155.6 4160.4 4165.2 4168.7 4206.9 4099.8 4209.4 4256.9 4257.3 4271.4 4728.3 4728.4 4738.7 4746.8 4788.1 5514.8 5521.2 5537.3 5543.6 5550.5 1399.6 1451.5 1462.1 1472.8 1477.9 935.4 957.6 957.9 968.9 969.4 4502.3 4691.6 4698.1 4781.3 4812.3 5014.6 5018.5 5024.4 5098.6 5100.5 4715.9 4786.3 4805.4 4818.4 4819.3 2609.4 2614.5 2640.4 2645.0 2705.4 5176.4 5193.4 5193.9 5217.3 5237.3 5098.4 5110.3 5123.0 5124.4 5146.2 5196.5 5197.0 5208.7 5501.8 5981.8 5680.9 5694.4 5695.9 5705.5 5715.2 5642.3 5648.7 5732.8 5737.8 5753.3 5817.8 5920.5 5930.6 5987.8 6008.8 4075.3 4092.2 4116.8 4118.5 4128.7 5537.6 5632.8 5657.2 5762.9 5778.7 5570.5 5582.4 5602.9 5628.9 5646.2 5328.0 5641.9 5643.0 5661.7 5702.9 5498.3 5534.2 5544.5 5547.5 5549.8 5564.2 5597.6 5677.3 5683.5 5714.5 5256.0 5485.3 5536.6 5553.3 5565.7 20:26:11 INFO - PROCESS | 9020 | 20:26:11 INFO - PROCESS | 9020 | [#5] yui.html Cycles:180 Average:21960.82 Median:4766.13 stddev:32232.11 (676.3%) stddev-sans-first:32283.14 20:26:11 INFO - PROCESS | 9020 | Values: 738.8 743.8 762.0 783.0 816.3 15498.4 17039.3 17054.9 17080.4 17138.1 15297.2 15429.2 15442.2 15463.9 15474.9 666.2 786.2 801.2 807.4 813.7 807.3 818.7 822.4 823.6 823.8 866.1 867.4 867.4 868.0 868.6 690.7 855.1 862.5 862.6 863.5 617.2 626.4 633.0 633.7 635.6 14337.4 14394.4 14408.6 14410.9 14430.9 13819.4 14332.6 14664.1 14817.4 14820.4 13187.6 13318.6 13365.9 13509.5 13758.6 4438.8 4455.3 4488.7 4533.9 4539.8 80144.0 84447.0 84595.6 85103.0 85792.0 11473.7 11496.3 11532.1 11559.7 11805.8 21795.3 21806.2 22271.2 22275.1 22571.3 8639.9 8681.6 8835.2 8858.0 8993.6 4678.7 4751.3 4785.8 4829.7 4837.6 3521.0 3633.4 3634.9 3635.0 3635.1 648.4 648.5 652.5 662.7 676.5 558.9 611.0 648.7 672.6 681.0 9225.4 9675.3 9682.3 9808.0 9963.9 572.3 652.9 672.6 677.4 688.7 4780.9 4825.0 4879.8 4896.5 4905.2 72998.3 103826.5 127249.0 129649.4 133115.0 110257.4 110899.0 111226.0 113061.0 116390.0 90592.6 91069.5 91852.0 93816.5 94705.5 9115.8 9336.6 9339.3 9340.9 9378.6 55375.4 55691.0 55816.7 56658.0 57306.0 76090.2 79076.0 81314.6 82264.1 84625.0 11861.7 12098.8 12245.3 12327.9 12668.1 12751.5 12937.4 13345.1 13372.3 13396.2 11846.3 12332.3 12807.6 13802.4 14650.9 14407.9 14415.6 14454.2 15616.4 15787.4 12903.7 13619.5 13875.6 14161.4 14198.8 11580.0 11758.2 11896.5 12345.4 12483.9 11863.9 11864.4 11884.6 12200.6 12379.2 20:26:11 INFO - PROCESS | 9020 | -------- Summary: end -------- 20:26:11 INFO - PROCESS | 9020 | 20:26:12 INFO - TEST-INFO | 9020: exit 0 20:26:12 INFO - TEST-OK | dromaeo_css | took 1114461ms 20:26:12 INFO - TEST-START | kraken 20:26:12 INFO - operating with platform_type : linux_ 20:26:12 INFO - Initialising browser for kraken test... 20:26:12 INFO - TEST-INFO | started process 9334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplPmYDg/profile http://localhost:55800/getInfo.html) 20:26:16 INFO - PROCESS | 9334 | __metrics Screen width/height:1600/1200 20:26:16 INFO - PROCESS | 9334 | colorDepth:24 20:26:16 INFO - PROCESS | 9334 | Browser inner width/height: 1024/697 20:26:16 INFO - PROCESS | 9334 | __metrics 20:26:16 INFO - PROCESS | 9334 | 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" 20:26:16 INFO - PROCESS | 9334 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:26:17 INFO - PROCESS | 9334 | console.error: PushService: 20:26:17 INFO - PROCESS | 9334 | stateChangeProcessEnqueue: Error transitioning state 20:26:17 INFO - PROCESS | 9334 | UnknownError 20:26:17 INFO - TEST-INFO | 9334: exit 0 20:26:17 INFO - Browser initialized. 20:26:17 INFO - Running cycle 1/1 for kraken test... 20:26:17 INFO - TEST-INFO | started process 9418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplPmYDg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:29 INFO - PROCESS | 9418 | RSS: Main: 154296320 20:26:29 INFO - PROCESS | 9418 | 20:26:32 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55800/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:32 INFO - PROCESS | 9418 | RSS: Main: 202637312 20:26:32 INFO - PROCESS | 9418 | 20:26:35 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55800/tests/kraken/driver.html?testName=audio-dft) 20:26:36 INFO - PROCESS | 9418 | RSS: Main: 190689280 20:26:36 INFO - PROCESS | 9418 | 20:26:39 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55800/tests/kraken/driver.html?testName=audio-fft) 20:26:39 INFO - PROCESS | 9418 | RSS: Main: 274575360 20:26:39 INFO - PROCESS | 9418 | 20:26:42 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55800/tests/kraken/driver.html?testName=audio-oscillator) 20:26:42 INFO - PROCESS | 9418 | RSS: Main: 185139200 20:26:42 INFO - PROCESS | 9418 | 20:26:44 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:45 INFO - PROCESS | 9418 | RSS: Main: 190222336 20:26:45 INFO - PROCESS | 9418 | 20:26:48 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55800/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:49 INFO - PROCESS | 9418 | RSS: Main: 224419840 20:26:49 INFO - PROCESS | 9418 | 20:26:52 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55800/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:52 INFO - PROCESS | 9418 | RSS: Main: 224509952 20:26:52 INFO - PROCESS | 9418 | 20:26:55 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55800/tests/kraken/driver.html?testName=json-parse-financial) 20:26:56 INFO - PROCESS | 9418 | RSS: Main: 224952320 20:26:56 INFO - PROCESS | 9418 | 20:26:57 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:58 INFO - PROCESS | 9418 | RSS: Main: 186900480 20:26:58 INFO - PROCESS | 9418 | 20:27:00 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55800/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:27:00 INFO - PROCESS | 9418 | RSS: Main: 195538944 20:27:00 INFO - PROCESS | 9418 | 20:27:02 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:27:03 INFO - PROCESS | 9418 | RSS: Main: 192356352 20:27:03 INFO - PROCESS | 9418 | 20:27:06 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:27:06 INFO - PROCESS | 9418 | RSS: Main: 184893440 20:27:06 INFO - PROCESS | 9418 | 20:27:09 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:27:10 INFO - PROCESS | 9418 | RSS: Main: 191205376 20:27:10 INFO - PROCESS | 9418 | 20:27:11 INFO - PROCESS | 9418 | Cycle 1(1): loaded http://localhost:55800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55800/tests/kraken/driver.html?testName=ai-astar) 20:27:11 INFO - PROCESS | 9418 | RSS: Main: 241393664 20:27:11 INFO - PROCESS | 9418 | 20:27:11 INFO - PROCESS | 9418 | __start_tp_report 20:27:11 INFO - PROCESS | 9418 | _x_x_mozilla_page_load 20:27:11 INFO - PROCESS | 9418 | _x_x_mozilla_page_load_details 20:27:11 INFO - PROCESS | 9418 | |i|pagename|runs| 20:27:11 INFO - PROCESS | 9418 | |0;ai-astar;104;111;111;110;108;112;113;113;112;110 20:27:11 INFO - PROCESS | 9418 | |1;audio-beat-detection;151;119;129;191;120;122;142;123;150;117 20:27:11 INFO - PROCESS | 9418 | |2;audio-dft;161;162;161;160;159;161;161;162;160;160 20:27:11 INFO - PROCESS | 9418 | |3;audio-fft;76;75;75;120;75;77;76;74;108;74 20:27:11 INFO - PROCESS | 9418 | |4;audio-oscillator;84;84;122;86;85;85;120;85;84;134 20:27:11 INFO - PROCESS | 9418 | |5;imaging-gaussian-blur;117;118;116;117;117;116;117;116;118;118 20:27:11 INFO - PROCESS | 9418 | |6;imaging-darkroom;145;147;145;145;146;145;146;145;146;145 20:27:11 INFO - PROCESS | 9418 | |7;imaging-desaturate;95;95;96;96;95;96;95;95;95;95 20:27:11 INFO - PROCESS | 9418 | |8;json-parse-financial;52;48;52;49;50;51;51;50;51;50 20:27:11 INFO - PROCESS | 9418 | |9;json-stringify-tinderbox;62;63;62;63;64;63;63;62;64;63 20:27:11 INFO - PROCESS | 9418 | |10;stanford-crypto-aes;80;78;78;80;84;80;77;78;79;78 20:27:12 INFO - PROCESS | 9418 | |11;stanford-crypto-ccm;126;128;135;125;123;121;122;123;141;133 20:27:12 INFO - PROCESS | 9418 | |12;stanford-crypto-pbkdf2;165;164;163;162;162;165;168;162;168;167 20:27:12 INFO - PROCESS | 9418 | |13;stanford-crypto-sha256-iterative;64;64;63;70;63;63;62;63;62;62 20:27:12 INFO - PROCESS | 9418 | __end_tp_report 20:27:12 INFO - PROCESS | 9418 | __start_cc_report 20:27:12 INFO - PROCESS | 9418 | _x_x_mozilla_cycle_collect,1650 20:27:12 INFO - PROCESS | 9418 | __end_cc_report 20:27:12 INFO - PROCESS | 9418 | __startTimestamp1471404431995__endTimestamp 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | ------- Summary: start ------- 20:27:12 INFO - PROCESS | 9418 | Number of tests: 14 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:2.72 (2.4%) stddev-sans-first:1.62 20:27:12 INFO - PROCESS | 9418 | Values: 104.0 111.0 111.0 110.0 108.0 112.0 113.0 113.0 112.0 110.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:135.50 stddev:23.09 (17.0%) stddev-sans-first:23.88 20:27:12 INFO - PROCESS | 9418 | Values: 151.0 119.0 129.0 191.0 120.0 122.0 142.0 123.0 150.0 117.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 20:27:12 INFO - PROCESS | 9418 | Values: 161.0 162.0 161.0 160.0 159.0 161.0 161.0 162.0 160.0 160.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:16.61 (22.1%) stddev-sans-first:17.42 20:27:12 INFO - PROCESS | 9418 | Values: 76.0 75.0 75.0 120.0 75.0 77.0 76.0 74.0 108.0 74.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:84.50 stddev:19.95 (23.6%) stddev-sans-first:20.61 20:27:12 INFO - PROCESS | 9418 | Values: 84.0 84.0 122.0 86.0 85.0 85.0 120.0 85.0 84.0 134.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 20:27:12 INFO - PROCESS | 9418 | Values: 117.0 118.0 116.0 117.0 117.0 116.0 117.0 116.0 118.0 118.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 20:27:12 INFO - PROCESS | 9418 | Values: 145.0 147.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:27:12 INFO - PROCESS | 9418 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:51.00 stddev:1.26 (2.5%) stddev-sans-first:1.20 20:27:12 INFO - PROCESS | 9418 | Values: 52.0 48.0 52.0 49.0 50.0 51.0 51.0 50.0 51.0 50.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 20:27:12 INFO - PROCESS | 9418 | Values: 62.0 63.0 62.0 63.0 64.0 63.0 63.0 62.0 64.0 63.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.50 stddev:1.99 (2.5%) stddev-sans-first:2.09 20:27:12 INFO - PROCESS | 9418 | Values: 80.0 78.0 78.0 80.0 84.0 80.0 77.0 78.0 79.0 78.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.00 stddev:6.58 (5.2%) stddev-sans-first:6.95 20:27:12 INFO - PROCESS | 9418 | Values: 126.0 128.0 135.0 125.0 123.0 121.0 122.0 123.0 141.0 133.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:2.41 (1.5%) stddev-sans-first:2.55 20:27:12 INFO - PROCESS | 9418 | Values: 165.0 164.0 163.0 162.0 162.0 165.0 168.0 162.0 168.0 167.0 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - PROCESS | 9418 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:2.37 (3.8%) stddev-sans-first:2.51 20:27:12 INFO - PROCESS | 9418 | Values: 64.0 64.0 63.0 70.0 63.0 63.0 62.0 63.0 62.0 62.0 20:27:12 INFO - PROCESS | 9418 | -------- Summary: end -------- 20:27:12 INFO - PROCESS | 9418 | 20:27:12 INFO - TEST-INFO | 9418: exit 0 20:27:12 INFO - TEST-OK | kraken | took 60481ms 20:27:12 INFO - SUITE-END | took 1174s 20:27:13 INFO - Completed test suite (00:19:35) 20:27:13 INFO - javascript benchmark 20:27:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.107348868828, 3103.3017571046516, 3104.394643044606, 3117.454445472043, 3153.731932785714, 5213.86965325867, 5241.79032838686, 5367.168088946215, 5431.131019036955, 5467.5899307551945, 5357.571394288458, 5378.704171270579, 5421.83734487966, 5478.753456094475, 5522.585806064541, 4873.585745211662, 4911.607071434277, 4911.729854857981, 4929.383827021622, 4945.0, 5022.070916880389, 5053.696778193302, 5061.949380506185, 5098.949010509885, 5100.081985242655, 4997.950020499785, 5012.649114561982, 5040.067587496306, 5047.924281135786, 5099.847004589868, 4720.268358404453, 4853.4418541867435, 4894.363732714724, 4907.950920490785, 4924.384451943507, 4820.662553621248, 4838.274258861164, 4843.515648435164, 4922.187839006559, 4961.5286547777905, 5413.296271484721, 5438.53772429344, 5481.040817856899, 5486.588505862076, 5511.834644960658, 5516.862078448031, 5738.081906894919, 5815.73829177688, 5817.214676018768, 5904.321003084658, 5918.615290006136, 5920.437558431985, 5920.911186332209, 5938.317093534256, 5943.881122377571, 5142.794288228504, 5513.889722205574, 5518.834434966958, 5522.475364840334, 5525.944740552623, 5818.127280907813, 5888.705564721747, 5896.174535565025, 5994.640321580632, 5995.640261584319, 5675.886482270332, 5736.569757268222, 5737.053386191232, 5739.655620662774, 5741.45456181662, 5476.972615136899, 5764.682942438206, 5842.328132264759, 5845.152452894392, 5847.06446968483, 5671.489565939085, 5718.599698021098, 5721.141828725725, 5816.069428891357, 5818.94181058184, 5744.569157313218, 5786.739596718074, 5795.130730390475, 5796.333421656564, 5809.796657116981, 4424.380586717862, 4446.710963787344, 4458.375827384169, 4461.219286624892, 4498.3927169832305, 3816.3512202925567, 3925.0972276376024, 3962.643362097425, 3982.721209515364, 4061.6953728470485, 5498.45015498455, 5505.476979686923, 5509.559235261169, 5512.062949298549, 5553.722313884289, 5882.088276317092, 5887.882242355129, 5894.734736936848, 5895.882082358329, 5897.49871260939, 5264.341957255343, 5369.140937449989, 5416.14783085127, 5429.619926605179, 5529.889402212014, 5031.874203144877, 5060.291559181717, 5063.1898896176435, 5072.6195535335, 5077.568406685473, 6078.939210607926, 6078.996965500643, 6085.939140608626, 6091.811228689837, 6135.049067394561, 5590.273264475755, 5750.30366042027, 5778.971105144447, 5807.738651760596, 5908.3500814911185, 6056.6971651418135, 6057.909131362945, 6059.878802424015, 6060.303065147388, 6061.060535616986, 5679.9148012779015, 5725.713714314351, 5725.914111288251, 5729.140628905698, 5740.90922724681, 5583.804566840141, 5635.464630860061, 5702.572307076903, 5728.914066289092, 5834.27071616048, 5590.720463976866, 5637.267155269788, 5638.182463542846, 5638.323401191883, 5639.041362968223, 5616.438356164351, 5624.0, 5625.353084395347, 5632.873425314871, 5634.816688495462, 5436.700981446058, 5580.0, 5609.719514024201, 5632.957902787997, 5728.312602487728, 5749.597528173155, 5753.712314384347, 5781.335146458211, 5799.246098007232, 5801.593888427769, 5618.915716264341, 5633.295838020247, 5634.577406694432, 5637.154426836008, 5638.182463542846], "value": 5353.5243476616015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.2189211725994, 580.6975342765933, 605.3129697793009, 609.3449541742625, 614.410166240409, 43777.56222437775, 45222.547774522245, 45459.31811022837, 45481.545184548144, 49081.75459122708, 46221.76889115558, 46478.76760616192, 46634.53365466353, 46653.30020049693, 46663.30005049927, 8048.798780030487, 8867.157620026102, 9013.36906416551, 9015.0, 10602.310849794738, 10340.121089707347, 10786.838197427045, 10792.0, 10793.460326983659, 10794.514246858871, 10844.62043828466, 10883.292585981886, 10900.836487452654, 10909.890901091007, 10916.290441121302, 10793.784124317508, 10834.566617335297, 10845.349279043283, 10846.511906964166, 10850.348979061202, 10493.632722854663, 10499.317544359592, 10505.4222017789, 10508.369497830156, 10552.208584356127, 43220.56779432197, 43508.0, 43678.344824827655, 43695.78152109251, 43770.12459750787, 3542.0, 3697.9815100924593, 4060.756354618703, 4162.438070860456, 4249.405083288342, 33232.6676733232, 33372.83313583417, 33395.16512087193, 33648.32703345944, 35096.298074038634, 3941.8817435476694, 3945.3687410014545, 4028.194361127786, 4052.6555242804397, 4118.588141185887, 352733.0, 353682.0, 354269.0, 354480.0, 355146.0, 36040.4593931086, 37099.0, 59744.70127649334, 60215.698921505114, 60234.698826506465, 38136.8093159538, 38407.231855362734, 38445.23109537794, 38478.0, 38509.2298154041, 15750.68498630021, 15866.60333491672, 15892.046477211405, 15899.364025438854, 15901.204939752966, 12058.276503409823, 12868.613941581767, 13122.409491572902, 13123.212607243597, 13359.465621375037, 8631.0, 8639.0, 8724.040355560883, 8748.081451447633, 8780.78048048791, 3327.434336162858, 3339.7662163648797, 3403.149212696826, 3417.8803741868915, 3428.879989200366, 1054.646225004493, 1062.8990245926625, 1079.3254216114929, 1096.7258185453636, 1156.8380426740264, 33029.3394132116, 33337.49993750096, 33615.66384336125, 33635.495467568006, 33699.49450758241, 1123.9943800280946, 1167.1888037813637, 1182.408795602199, 1185.2177562808506, 1189.7679952409371, 17236.759221301403, 17328.133593320537, 17348.392806251974, 17608.471745847644, 17800.91099544494, 571918.0, 573561.0, 580653.0, 580940.0, 581441.0, 58141.70929145327, 58937.41062589319, 58989.0, 59027.40972590305, 59078.40921590729, 1255.221762507233, 1343.8253027106414, 1357.429879450633, 1373.4986729843536, 1386.4384924105552, 31674.0, 33200.833995830835, 34212.09197218264, 34525.65474345224, 34682.512801099554, 51724.224136637225, 52023.0, 52085.21872171996, 52110.21834672407, 52123.0, 323904.0, 324049.0, 325275.0, 326456.0, 326632.0, 28703.0, 28969.841206352354, 29120.7087929118, 29142.774297727134, 31078.844605776827, 48273.76985587418, 48566.75716621536, 48871.26693099535, 49194.75402623107, 49599.752001239765, 40574.79712601418, 41046.79476602598, 41203.7939810299, 41889.58110418979, 43476.0, 41162.79418602888, 41616.583834162484, 42263.57736422597, 42733.57266427296, 44246.557534424246, 42780.35829462498, 43364.0, 43586.564134358254, 43921.560784391746, 44012.0, 36344.45483317699, 37701.4344784823, 38346.616533834305, 39017.219655607296, 39226.411603826535, 28833.711662883103, 29093.597929594518, 29186.56220156657, 29402.264943376587, 29636.85181574078], "value": 19638.418232033444, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.50388463919785, 381.1842656714629, 396.4964495091235, 404.0847480456765, 409.0897752500686, 14470.276486175688, 16515.752263716055, 19192.424227273168, 19628.803711962875, 19631.901840490813, 18292.908535457304, 18455.35406260781, 18519.2592296308, 18630.53423664409, 18653.720194197063, 4305.138972205556, 5726.541876649869, 5861.0, 5903.557233207526, 5908.911366329508, 6284.465820405248, 6550.672466376686, 6603.009548567706, 6636.2036555613395, 6772.08576842125, 6571.44142747867, 6604.570702904296, 7266.128064632251, 7548.660310286023, 7570.848583028336, 7458.142313633947, 7593.0, 7656.540607563564, 7658.157602663702, 7663.731769388045, 7445.776626701154, 7446.5532068075545, 7462.067241594801, 7463.4029277657655, 7467.925320746777, 27012.729872701217, 28171.154865354074, 28209.858950705115, 28210.435791284264, 28446.573301400495, 2418.8427752196053, 2491.1530079772965, 2509.8117641176987, 2528.4184637533285, 3254.3653987472217, 15283.388664453409, 16144.59638509035, 16589.004659720456, 16777.832221677872, 16801.0, 2056.516718571135, 2188.518525924294, 2219.7447293561286, 2259.6836442898007, 2310.2145270608075, 93108.0, 100473.49763251137, 102640.0, 102966.0, 106447.0, 16358.918205409134, 17139.22873470697, 17509.474715758548, 17914.999999999738, 18430.35493757712, 32844.34311313808, 33013.339733205205, 33083.0, 33090.0, 33106.83446582752, 10506.317089389318, 10632.0, 10713.785724285626, 10774.299670521392, 10825.404602746925, 8449.704260350858, 8792.736217913473, 8835.602397892111, 8921.910780892238, 9121.407108537924, 9137.269018478506, 9181.0, 9195.0, 9551.808963820824, 9561.952190239004, 3336.645677391028, 3486.89539313821, 3527.6732134477124, 3713.4986776785327, 3765.2657731742597, 892.4823602310644, 964.7636329099275, 990.9504524773732, 1036.512838965685, 1039.4335087377397, 19678.508037298896, 20290.79709202889, 20507.69238461424, 20682.689759653316, 20733.792662073185, 1007.7178390050798, 1009.4448053570653, 1013.7516308504464, 1019.8062368150028, 1079.3523885668692, 10464.633737819293, 11184.384858832842, 11294.0, 11337.829932550854, 11364.943175284236, 548992.0, 550451.0, 563032.0, 582425.669561391, 588953.0, 99787.50106249568, 100268.49865750625, 100692.49653751684, 104711.4764426173, 105845.47077264564, 1007.5163921317809, 1020.6172685243034, 1061.0291583201285, 1065.073386154051, 1066.4561073852235, 17496.91251543734, 17922.5519362017, 18434.90782546079, 18582.933815920762, 18888.300052995295, 43210.56789432191, 44084.86048208994, 44528.0, 44636.0, 45069.54930450785, 59751.701241493516, 61840.38159618346, 63070.68464657831, 64272.0, 64721.35278647341, 8427.0, 8433.704820331259, 8586.957065214634, 8689.435186712843, 8794.560271986247, 12479.31363775001, 13351.933240333736, 13469.259190744604, 13535.72928541404, 13602.659933501742, 11565.884341156818, 11622.825657614974, 11660.708482288012, 11978.341191234565, 12411.193272437262, 10951.50718217698, 11583.305001699924, 11706.122040847142, 11936.940315298369, 12459.875401245872, 11691.532338706356, 12078.456469459072, 12386.504539818307, 12406.875931240573, 12416.634170241086, 8367.748967530984, 8393.0, 8483.703070392754, 8526.488410695378, 8609.182127697859, 10407.94796026015, 11675.124365672438, 11714.648560543197, 11802.232854864405, 12110.152289339661], "value": 10723.975391322565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.6529902225418, 1470.6323419145217, 1513.2660659580101, 1619.9757003644947, 1757.7890653121626, 7819.843603127934, 8680.869786953193, 8944.8658270126, 8948.328875334344, 9219.58511866966, 9019.458832470056, 9087.591058402371, 9093.090690930903, 9105.226055785266, 9109.271258299337, 2433.7444568320293, 2454.7177074636465, 2463.310273123528, 2463.618139188429, 2467.5188338274043, 2407.422218667516, 2482.056818409002, 2489.9004039838383, 2492.5513407586627, 2496.400863792686, 2354.7409784923643, 2373.41851246444, 2398.8920498577604, 2402.3873912152376, 2403.182917807945, 2318.8956496957676, 2329.790318871301, 2333.0784340185533, 2334.708161479815, 2371.1819422299277, 2347.542229265294, 2348.6477028445697, 2355.623100303943, 2361.445060410802, 2361.858288502678, 8758.2993360531, 8904.421212621159, 8985.05656906022, 9012.233960113399, 9026.23277021454, 5428.158635411518, 5522.972385138089, 5555.972220138914, 5561.277033985556, 5567.081431563787, 3410.7100896423835, 3470.9652903470896, 3532.311199316134, 3538.4515400113023, 3541.645835416438, 1111.283222321598, 1120.1430905357408, 1124.1512657943201, 1124.4602590756483, 1130.3307061587093, 12672.366381680971, 12763.808542871864, 12779.61661150167, 12813.743725125445, 12834.743305133938, 4447.421835161408, 4656.67403281767, 4731.95268047322, 4741.359916411309, 4749.097671442415, 10021.849672254923, 10026.398416095057, 10029.197664186848, 10035.197184225244, 10040.497975101362, 5416.8104116355735, 5421.132618781055, 5424.538914192259, 5426.240326354314, 5429.592780541475, 4465.307877279027, 4917.188663870421, 5058.4435712071645, 5076.720780357042, 5082.186850103965, 3791.4123310886857, 3825.2923209206388, 3875.8837234883, 3937.684985201177, 3962.405639154092, 1122.7417693930443, 1157.5543415784985, 1170.2568868768394, 1174.8061569840881, 1183.7514122034297, 964.7491652170486, 977.3549457358109, 981.4651015196735, 991.3605724307781, 1004.467632154959, 5901.793437229677, 5961.799332627055, 6010.158577799111, 6020.8795824084145, 6086.452219300196, 484.760043778332, 486.4989061266901, 486.7128394247411, 490.70312460961316, 501.6989806116374, 4047.170330082326, 4121.505419349697, 4162.209180255742, 4252.149570085995, 4277.636400905895, 10565.366078035342, 10992.560297588167, 10994.670159895057, 11310.94344528272, 11340.773184536263, 11213.66359009231, 11252.49363778632, 11255.549778008788, 11291.49188286529, 11304.943475282735, 8223.136570660114, 8409.747707568782, 8414.747557573404, 8415.368847336475, 8421.873671894926, 6337.4613157882095, 6487.22153341602, 6526.543141980205, 6549.443297319781, 6614.834629134118, 10268.332558383681, 10600.257981941499, 10619.203559733205, 10621.628243011766, 10632.25574209798, 10418.583256669648, 10644.414557199429, 10655.467226638482, 10745.623903163665, 10815.0, 7323.890141647986, 7535.208803075818, 7540.396768258416, 8134.959325203336, 8282.378821588285, 8122.67509299645, 8700.390972631854, 8765.737027889174, 8998.64005439775, 9000.199960007894, 7773.300402963534, 7824.9608751955875, 7992.5204487730925, 8041.0, 8325.209105135002, 7731.884021739791, 7753.340966017951, 7790.298873101448, 7902.4863383879865, 7934.1272460030505, 7181.281871812777, 7274.709011639475, 7274.745383911538, 7300.0, 7384.076990376203, 4791.353167322367, 4803.183458811941, 4840.394950631171, 4952.331435256338, 5079.822206222764, 5155.175171972466, 5172.637915345889, 5206.323177986989, 5279.0, 5310.468953104813], "value": 4639.712441514075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.5482247442343, 335.54533606962565, 341.45878782130336, 341.6378638643039, 344.2770182616504, 5299.735013249337, 5339.5461385782155, 5353.491418315259, 5368.8389348319615, 5375.462453754622, 4985.180409150661, 5052.650517509357, 5219.321488206538, 5250.317458730369, 5265.921011184826, 4177.248095342837, 4188.371744238373, 4220.388043733665, 4222.0, 4224.134052519226, 4177.540470548237, 4210.431591735107, 4213.810378532973, 4219.620234178923, 4224.239636865363, 3931.9803400982955, 4054.6756259499316, 4165.125323682015, 4168.520620128678, 4174.874753757392, 4133.3386658134705, 4142.514491305223, 4150.232207041692, 4157.792110394468, 4188.769617671027, 3717.3494638438165, 3719.6838268747188, 3726.4596633488263, 3730.552333719971, 3731.589525152231, 4970.751462426864, 5093.694378337312, 5094.694318340874, 5147.382314122329, 5175.249588809602, 4742.1227072991605, 4750.809967601292, 4761.357331720551, 4767.308740232646, 4777.450593181794, 5450.727463626803, 5468.9726551367385, 5499.587530935196, 5505.752241149118, 5524.458748975476, 3984.143409167043, 4036.535798383165, 4088.9591104088877, 4098.7950602470055, 4098.856540021085, 5696.544276457915, 5703.572232082611, 5704.657720536739, 5708.857278568027, 5771.307443106812, 4155.605217504332, 4160.43834082395, 4165.166966606691, 4168.7290326128705, 4206.8737937861915, 4099.795010249476, 4209.431726716915, 4256.936145957813, 4257.276263035292, 4271.359296105609, 4728.338032675429, 4728.40894888139, 4738.739369334719, 4746.762661866893, 4788.138135135709, 5514.779408823602, 5521.2270282160525, 5537.307836520435, 5543.556515478752, 5550.500454959073, 1399.5941177058742, 1451.5355086372472, 1462.1300326305832, 1472.8011718417877, 1477.869429886138, 935.4247138010074, 957.5690939077303, 957.8515330123703, 968.9176420004237, 969.3941286695815, 4502.298620827542, 4691.592522243382, 4698.130845793471, 4781.282807578891, 4812.278158276286, 5014.592995362246, 5018.5232402921665, 5024.422191447957, 5098.566621837185, 5100.5409513143995, 4715.882102947454, 4786.282057691375, 4805.438232574427, 4818.445878723992, 4819.3252744726315, 2609.3998380372623, 2614.4879267277493, 2640.392709676785, 2645.0, 2705.418335057972, 5176.430592634807, 5193.350831146106, 5193.870153246199, 5217.321748172789, 5237.266782650432, 5098.388193416814, 5110.335656364723, 5123.028643386901, 5124.410692770304, 5146.228065790161, 5196.506331898464, 5197.0, 5208.713520756319, 5501.807436739775, 5981.773736383944, 5680.857978550569, 5694.402087780723, 5695.943040569541, 5705.486506214461, 5715.199872018004, 5642.266505354278, 5648.661080335193, 5732.7706891723865, 5737.770489180386, 5753.331533855135, 5817.848769779866, 5920.526357891272, 5930.614510056833, 5987.820365389045, 6008.789692360747, 4075.266452038543, 4092.2020206060724, 4116.773577453149, 4118.464599602033, 4128.731632444002, 5537.640053396516, 5632.831015069554, 5657.179708942098, 5762.855928601818, 5778.659642844655, 5570.470805273492, 5582.358028826737, 5602.85992850182, 5628.85927851807, 5646.181303711021, 5328.0, 5641.915371269352, 5643.037405362218, 5661.745221464962, 5702.914456283242, 5498.3127109111365, 5534.169874518854, 5544.532682956045, 5547.472990065938, 5549.7780088796, 5564.19319198722, 5597.608167428241, 5677.31872175325, 5683.516901063456, 5714.457126572969, 5255.973720131527, 5485.314335708036, 5536.640118392292, 5553.333599968029, 5565.693886836263], "value": 4173.4332711467105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.8263758016865, 743.8066102813268, 761.9847603047939, 782.9582073643894, 816.2939057715079, 15498.38006479741, 17039.318427262893, 17054.914725426388, 17080.402185923496, 17138.143092845356, 15297.235138243099, 15429.151396673207, 15442.227888605554, 15463.922680386582, 15474.922625386856, 666.203886355805, 786.1588100732218, 801.1787917384669, 807.3742849291787, 813.6826637611337, 807.3460496997421, 818.7420962396826, 822.3503432288514, 823.6499487717726, 823.8434697407504, 866.1208872993916, 867.3538214030556, 867.3841572483512, 867.995660021699, 868.6264906090379, 690.6753825701912, 855.0508935082054, 862.5299211929513, 862.5730263519536, 863.5207459859776, 617.2315467243311, 626.4455956478549, 633.0, 633.6704913445029, 635.5963962883555, 14337.35481903317, 14394.352254148589, 14408.567742967727, 14410.855891441057, 14430.855691443161, 13819.447222111103, 14332.57002289933, 14664.120152790867, 14817.407303707838, 14820.40718371264, 13187.60437186886, 13318.600441986757, 13365.86634133656, 13509.527166549124, 13758.587242382744, 4438.822447102112, 4455.264881294583, 4488.708233964782, 4533.9319910201375, 4539.818407263706, 80144.0, 84447.0, 84595.57702211512, 85103.0, 85792.0, 11473.655790326136, 11496.252743571642, 11532.135089868294, 11559.711007224887, 11805.822912656316, 21795.34613961584, 21806.23678171288, 22271.220507282167, 22275.108995639992, 22571.322860314216, 8639.913600864036, 8681.609327580149, 8835.249003834617, 8858.0, 8993.595288212045, 4678.719276843332, 4751.3348131261655, 4785.832495862628, 4829.66192366531, 4837.564619184291, 3520.982395088008, 3633.418653015505, 3634.945475817865, 3634.9818250909107, 3635.1457407509215, 648.3613640564041, 648.5395369287764, 652.5236577298599, 662.7415308029872, 676.4757313082303, 558.9329280486286, 611.0467670434138, 648.7178077536287, 672.5729161982078, 680.9931900681029, 9225.354225204306, 9675.322727409013, 9682.273829462678, 9808.0, 9963.900360996442, 572.2758627529715, 652.9281779004306, 672.5897202706345, 677.3869647968596, 688.6728803818146, 4780.928286075712, 4825.0, 4879.829205977774, 4896.5103489651465, 4905.190643543775, 72998.27001730021, 103826.48086759518, 127249.0, 129649.35175324252, 133115.0, 110257.44871275593, 110899.0, 111226.0, 113061.0, 116390.0, 90592.6411103834, 91069.54465227631, 91852.0, 93816.53091734635, 94705.52647236857, 9115.817683646157, 9336.579853906725, 9339.299552533723, 9340.859887101835, 9378.577963991773, 55375.44624553703, 55691.0, 55816.720916395156, 56658.0, 57306.0, 76090.23909761052, 79076.0, 81314.59342703248, 82264.12830460383, 84625.0, 11861.703457413634, 12098.75802483963, 12245.265284082983, 12327.876721232673, 12668.113232073667, 12751.48994040228, 12937.417816198105, 13345.132566383154, 13372.264525451194, 13396.196228226338, 11846.289222646668, 12332.321722305, 12807.551735689207, 13802.37889294964, 14650.92674536663, 14407.85592144107, 14415.567532974028, 14454.205018724071, 15616.375344986074, 15787.447439340027, 12903.677408064874, 13619.523316683868, 13875.583732488041, 14161.362738676578, 14198.787018194942, 11580.0, 11758.235714678518, 11896.464659090188, 12345.444454999368, 12483.93758031204, 11863.940680296544, 11864.40677966081, 11884.643460696192, 12200.572979945659, 12379.195352302071], "value": 7729.513493774491, "unit": "score"}], "name": "dromaeo_css", "value": 7433.858786314203, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 110.0, 108.0, 112.0, 113.0, 113.0, 112.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 129.0, 191.0, 120.0, 122.0, 142.0, 123.0, 150.0, 117.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 159.0, 161.0, 161.0, 162.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 120.0, 75.0, 77.0, 76.0, 74.0, 108.0, 74.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 122.0, 86.0, 85.0, 85.0, 120.0, 85.0, 84.0, 134.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 48.0, 52.0, 49.0, 50.0, 51.0, 51.0, 50.0, 51.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 64.0, 63.0, 63.0, 62.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 80.0, 84.0, 80.0, 77.0, 78.0, 79.0, 78.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 135.0, 125.0, 123.0, 121.0, 122.0, 123.0, 141.0, 133.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 162.0, 162.0, 165.0, 168.0, 162.0, 168.0, 167.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 70.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1493.6, "alertThreshold": 2.0}]} 20:27:13 INFO - Return code: 0 20:27:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:27:13 INFO - # TBPL SUCCESS # 20:27:13 INFO - Running post-action listener: _resource_record_post_action 20:27:13 INFO - [mozharness: 2016-08-17 03:27:13.307093Z] Finished run-tests step (success) 20:27:13 INFO - Running post-run listener: _resource_record_post_run 20:27:13 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 419901440; Read time: 12; Write time: 270792 20:27:13 INFO - TinderboxPrint: CPU usage
13.0% 20:27:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:27:13 INFO - TinderboxPrint: I/O write bytes / time
419,901,440 / 270,792 20:27:13 INFO - TinderboxPrint: CPU idle
8,277.0 (87.0%) 20:27:13 INFO - TinderboxPrint: CPU user
1,192.9 (12.5%) 20:27:13 INFO - TinderboxPrint: Swap in / out
0 / 0 20:27:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117993472; Read time: 0; Write time: 94032 20:27:13 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290336768; Read time: 0; Write time: 172564 20:27:13 INFO - Running post-run listener: _upload_blobber_files 20:27:13 INFO - Blob upload gear active. 20:27:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:27:13 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 20:27:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:27:14 INFO - (blobuploader) - INFO - Open directory for files ... 20:27:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:27:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:27:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:19 INFO - (blobuploader) - INFO - Done attempting. 20:27:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:27:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:27:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:20 INFO - (blobuploader) - INFO - Done attempting. 20:27:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:27:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:27:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:21 INFO - (blobuploader) - INFO - Done attempting. 20:27:21 INFO - (blobuploader) - INFO - Iteration through files over. 20:27:21 INFO - Return code: 0 20:27:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:27:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:27:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dde44dc45b9fc10c91f238ca89624b5dce565f4fdfd116c6336ad9ebd010905e8882d95e198a9b5d45dec981c2bece9cce0e8107a4e71b74f229c9f069b009a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe63b4222a97dead8c60b1a4f182e086d9add3543f0ce2811f3a74c526f19ae673ed1f967c7225d907dc25c498cf9857a8960436959097b1ef8d7656a50777e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7d56aef506ec9cd427b1f2a7e9eed310f639c628b2591d2e3323b0c7ea94201f788db81b766643faec2a64b46e26c01956b5a93925e68808823fdd7bca83218"} 20:27:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:27:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:27:21 INFO - Contents: 20:27:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dde44dc45b9fc10c91f238ca89624b5dce565f4fdfd116c6336ad9ebd010905e8882d95e198a9b5d45dec981c2bece9cce0e8107a4e71b74f229c9f069b009a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe63b4222a97dead8c60b1a4f182e086d9add3543f0ce2811f3a74c526f19ae673ed1f967c7225d907dc25c498cf9857a8960436959097b1ef8d7656a50777e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7d56aef506ec9cd427b1f2a7e9eed310f639c628b2591d2e3323b0c7ea94201f788db81b766643faec2a64b46e26c01956b5a93925e68808823fdd7bca83218"} 20:27:21 INFO - Running post-run listener: copy_logs_to_upload_dir 20:27:21 INFO - Copying logs to upload dir... 20:27:21 INFO - mkdir: /builds/slave/test/build/upload/logs 20:27:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.298650 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-16 20:27:20.262678) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 20:27:20.265763) ========= 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=3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dde44dc45b9fc10c91f238ca89624b5dce565f4fdfd116c6336ad9ebd010905e8882d95e198a9b5d45dec981c2bece9cce0e8107a4e71b74f229c9f069b009a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe63b4222a97dead8c60b1a4f182e086d9add3543f0ce2811f3a74c526f19ae673ed1f967c7225d907dc25c498cf9857a8960436959097b1ef8d7656a50777e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7d56aef506ec9cd427b1f2a7e9eed310f639c628b2591d2e3323b0c7ea94201f788db81b766643faec2a64b46e26c01956b5a93925e68808823fdd7bca83218"} build_url:https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009772 build_url: 'https://queue.taskcluster.net/v1/task/Bti8bqC1TeWbTJO-tA_brQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dde44dc45b9fc10c91f238ca89624b5dce565f4fdfd116c6336ad9ebd010905e8882d95e198a9b5d45dec981c2bece9cce0e8107a4e71b74f229c9f069b009a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe63b4222a97dead8c60b1a4f182e086d9add3543f0ce2811f3a74c526f19ae673ed1f967c7225d907dc25c498cf9857a8960436959097b1ef8d7656a50777e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7d56aef506ec9cd427b1f2a7e9eed310f639c628b2591d2e3323b0c7ea94201f788db81b766643faec2a64b46e26c01956b5a93925e68808823fdd7bca83218"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 20:27:20.374837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 20:27:20.375212) ========= 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=3a3620fb28aea1604ab609ef000001d2-1471402324.868820-2074612077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 20:27:20.552758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 20:27:20.553110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 20:27:20.554355) ========= ========= Total master_lag: 0.48 =========