builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1470419294.75 results: success (0) buildid: 20160805093133 builduid: f78521c0ffac4041b9a7022684358587 revision: 204a7ba2fba4bd74e715065492262cc6ffa8f8cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.752532) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.753133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.753409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.825855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.826140) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 10:48:15-- 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% 31.9M=0s 2016-08-05 10:48:15 (31.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091698 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.935790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.936511) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018893 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.994077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.994441) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 204a7ba2fba4bd74e715065492262cc6ffa8f8cf --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 204a7ba2fba4bd74e715065492262cc6ffa8f8cf --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=8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 10:48:15,265 truncating revision to first 12 chars 2016-08-05 10:48:15,265 Setting DEBUG logging. 2016-08-05 10:48:15,265 attempt 1/10 2016-08-05 10:48:15,265 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/204a7ba2fba4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 10:48:15,588 unpacking tar archive at: fx-team-204a7ba2fba4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650882 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.663579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.663878) ========= script_repo_revision: 204a7ba2fba4bd74e715065492262cc6ffa8f8cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.664284) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.664543) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.680132) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-05 10:48:15.680546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:48:16 INFO - MultiFileLogger online at 20160805 10:48:16 in /builds/slave/test 10:48:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:48:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:48:16 INFO - {'append_to_log': False, 10:48:16 INFO - 'base_work_dir': '/builds/slave/test', 10:48:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:48:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:48:16 INFO - 'branch': 'Fx-Team-Non-PGO', 10:48:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:48:16 INFO - 'config_files': ('talos/linux_config.py',), 10:48:16 INFO - 'default_actions': ('clobber', 10:48:16 INFO - 'read-buildbot-config', 10:48:16 INFO - 'download-and-extract', 10:48:16 INFO - 'populate-webroot', 10:48:16 INFO - 'create-virtualenv', 10:48:16 INFO - 'install', 10:48:16 INFO - 'run-tests'), 10:48:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:48:16 INFO - 'download_minidump_stackwalk': True, 10:48:16 INFO - 'download_symbols': 'ondemand', 10:48:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:48:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:48:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:48:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:48:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:48:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:48:16 INFO - 'installer_path': 'installer.exe', 10:48:16 INFO - 'log_level': 'info', 10:48:16 INFO - 'log_name': 'talos', 10:48:16 INFO - 'log_to_console': True, 10:48:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:48:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:48:16 INFO - 'opt_config_files': (), 10:48:16 INFO - 'pip_index': False, 10:48:16 INFO - 'sps_profile': False, 10:48:16 INFO - 'sps_profile_interval': 0, 10:48:16 INFO - 'suite': 'dromaeojs-e10s', 10:48:16 INFO - 'system_bits': '32', 10:48:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:48:16 INFO - 'title': 'talos-linux64-ix-001', 10:48:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:48:16 INFO - 'use_talos_json': True, 10:48:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:48:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:48:16 INFO - 'work_dir': 'build'} 10:48:16 INFO - [mozharness: 2016-08-05 17:48:16.037214Z] Running clobber step. 10:48:16 INFO - Running pre-action listener: _resource_record_pre_action 10:48:16 INFO - Running main action method: clobber 10:48:16 INFO - rmtree: /builds/slave/test/build 10:48:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:48:16 INFO - Running post-action listener: _resource_record_post_action 10:48:16 INFO - [mozharness: 2016-08-05 17:48:16.509772Z] Finished clobber step (success) 10:48:16 INFO - [mozharness: 2016-08-05 17:48:16.509872Z] Running read-buildbot-config step. 10:48:16 INFO - Running pre-action listener: _resource_record_pre_action 10:48:16 INFO - Running main action method: read_buildbot_config 10:48:16 INFO - Using buildbot properties: 10:48:16 INFO - { 10:48:16 INFO - "project": "", 10:48:16 INFO - "product": "firefox", 10:48:16 INFO - "script_repo_revision": "production", 10:48:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:48:16 INFO - "repository": "", 10:48:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:48:16 INFO - "buildid": "20160805093133", 10:48:16 INFO - "pgo_build": "False", 10:48:16 INFO - "basedir": "/builds/slave/test", 10:48:16 INFO - "buildnumber": 1541, 10:48:16 INFO - "slavename": "talos-linux64-ix-001", 10:48:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:48:16 INFO - "platform": "ubuntu64_hw", 10:48:16 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 10:48:16 INFO - "branch": "fx-team", 10:48:16 INFO - "repo_path": "integration/fx-team", 10:48:16 INFO - "revision": "204a7ba2fba4bd74e715065492262cc6ffa8f8cf", 10:48:16 INFO - "stage_platform": "linux64", 10:48:16 INFO - "builduid": "f78521c0ffac4041b9a7022684358587", 10:48:16 INFO - "slavebuilddir": "test" 10:48:16 INFO - } 10:48:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:48:16 INFO - Running post-action listener: _resource_record_post_action 10:48:16 INFO - [mozharness: 2016-08-05 17:48:16.512317Z] Finished read-buildbot-config step (success) 10:48:16 INFO - [mozharness: 2016-08-05 17:48:16.512405Z] Running download-and-extract step. 10:48:16 INFO - Running pre-action listener: _resource_record_pre_action 10:48:16 INFO - Running main action method: download_and_extract 10:48:16 INFO - mkdir: /builds/slave/test/build/tests 10:48: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')]} 10:48:16 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:48:16 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:17 INFO - Downloaded 1361 bytes. 10:48:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:48:17 INFO - Using the following test package requirements: 10:48:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:48:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:48:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:17 INFO - u'jsshell-linux-x86_64.zip'], 10:48:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:48:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:48:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:48:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:48:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:48:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:48:17 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')]} 10:48:17 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:48:17 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:18 INFO - Downloaded 20254056 bytes. 10:48:18 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 10:48:22 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 10:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:22 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:48:22 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:23 INFO - Downloaded 20254056 bytes. 10:48:23 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 10:48:27 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')]} 10:48:27 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:48:27 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:28 INFO - Downloaded 14413723 bytes. 10:48:28 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 10:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:29 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:48:29 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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 10:48:30 INFO - Downloaded 56134508 bytes. 10:48:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:48:30 INFO - mkdir: /builds/slave/test/properties 10:48:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:48:30 INFO - Writing to file /builds/slave/test/properties/build_url 10:48:30 INFO - Contents: 10:48:30 INFO - build_url:https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:48:31 INFO - Running post-action listener: _resource_record_post_action 10:48:31 INFO - Running post-action listener: set_extra_try_arguments 10:48:31 INFO - [mozharness: 2016-08-05 17:48:31.040314Z] Finished download-and-extract step (success) 10:48:31 INFO - [mozharness: 2016-08-05 17:48:31.040539Z] Running populate-webroot step. 10:48:31 INFO - Running pre-action listener: _resource_record_pre_action 10:48:31 INFO - Running main action method: populate_webroot 10:48:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:48:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:48:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:48:31 INFO - '--tppagecycles', 10:48:31 INFO - '7'], 10:48:31 INFO - 'tests': ['tsvgm']}}, 10:48:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:48:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:48:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:48:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:48:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:31 INFO - 'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:31 INFO - 'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['damp', 'tps']}, 10:48:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:31 INFO - 'tests': ['damp', 'tps']}, 10:48:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['dromaeo_dom']}, 10:48:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:48:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['basic_compositor_video']}, 10:48:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:48:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['a11yr', 10:48:31 INFO - 'ts_paint', 10:48:31 INFO - 'tpaint', 10:48:31 INFO - 'sessionrestore', 10:48:31 INFO - 'sessionrestore_no_auto_restore', 10:48:31 INFO - 'tabpaint']}, 10:48:31 INFO - 'other-e10s': {'tests': ['a11yr', 10:48:31 INFO - 'ts_paint', 10:48:31 INFO - 'tpaint', 10:48:31 INFO - 'sessionrestore', 10:48:31 INFO - 'sessionrestore_no_auto_restore', 10:48:31 INFO - 'tabpaint']}, 10:48:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:48:31 INFO - 'ts_paint', 10:48:31 INFO - 'tpaint', 10:48:31 INFO - 'sessionrestore', 10:48:31 INFO - 'sessionrestore_no_auto_restore', 10:48:31 INFO - 'tabpaint']}, 10:48:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:48:31 INFO - 'ts_paint', 10:48:31 INFO - 'tpaint', 10:48:31 INFO - 'sessionrestore', 10:48:31 INFO - 'sessionrestore_no_auto_restore', 10:48:31 INFO - 'tabpaint']}, 10:48:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['a11yr', 10:48:31 INFO - 'ts_paint', 10:48:31 INFO - 'tpaint', 10:48:31 INFO - 'sessionrestore', 10:48:31 INFO - 'sessionrestore_no_auto_restore', 10:48:31 INFO - 'tabpaint']}, 10:48:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['a11yr', 10:48:31 INFO - 'ts_paint', 10:48:31 INFO - 'tpaint', 10:48:31 INFO - 'sessionrestore', 10:48:31 INFO - 'sessionrestore_no_auto_restore', 10:48:31 INFO - 'tabpaint']}, 10:48:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['tsvgx', 10:48:31 INFO - 'tsvgr_opacity', 10:48:31 INFO - 'tart', 10:48:31 INFO - 'tscrollx', 10:48:31 INFO - 'cart']}, 10:48:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:48:31 INFO - 'tsvgr_opacity', 10:48:31 INFO - 'tart', 10:48:31 INFO - 'tscrollx', 10:48:31 INFO - 'cart']}, 10:48:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:31 INFO - 'talos_options': ['--disable-e10s'], 10:48:31 INFO - 'tests': ['tp5o']}, 10:48:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:31 INFO - 'tests': ['tp5o']}, 10:48:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:31 INFO - 'talos_options': ['--disable-e10s', 10:48:31 INFO - '--xperf_path', 10:48:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:31 INFO - 'tests': ['tp5n']}, 10:48:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:31 INFO - 'talos_options': ['--xperf_path', 10:48:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:31 INFO - 'tests': ['tp5n']}}, 10:48:31 INFO - 'talos.zip': {'path': '', 10:48:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:48:31 INFO - Running post-action listener: _resource_record_post_action 10:48:31 INFO - [mozharness: 2016-08-05 17:48:31.057790Z] Finished populate-webroot step (success) 10:48:31 INFO - [mozharness: 2016-08-05 17:48:31.057879Z] Running create-virtualenv step. 10:48:31 INFO - Running pre-action listener: _resource_record_pre_action 10:48:31 INFO - Running main action method: create_virtualenv 10:48:31 INFO - Creating virtualenv /builds/slave/test/build/venv 10:48:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:48:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:48:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:48:31 INFO - Using real prefix '/usr' 10:48:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:48:31 INFO - Installing distribute.............................................................................................................................................................................................done. 10:48:33 INFO - Installing pip.................done. 10:48:33 INFO - Return code: 0 10:48:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:48:33 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')]} 10:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:33 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')]} 10:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:33 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 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:33 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 10:48:33 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 10:48:33 INFO - Using env: {'DISPLAY': ':0', 10:48:33 INFO - 'HOME': '/home/cltbld', 10:48:33 INFO - 'LANG': 'en_US.UTF-8', 10:48:33 INFO - 'LANGUAGE': 'en_US:en', 10:48:33 INFO - 'LOGNAME': 'cltbld', 10:48:33 INFO - 'MAIL': '/var/mail/cltbld', 10:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:33 INFO - 'MOZ_NO_REMOTE': '1', 10:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:33 INFO - 'NO_EM_RESTART': '1', 10:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:33 INFO - 'PWD': '/builds/slave/test', 10:48:33 INFO - 'SHELL': '/bin/bash', 10:48:33 INFO - 'SHLVL': '1', 10:48:33 INFO - 'TERM': 'linux', 10:48:33 INFO - 'TMOUT': '86400', 10:48:33 INFO - 'USER': 'cltbld', 10:48:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:33 INFO - '_': '/tools/buildbot/bin/python'} 10:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:33 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 10:48:33 INFO - Cleaning up... 10:48:33 INFO - Return code: 0 10:48:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:48:33 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')]} 10:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:33 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')]} 10:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:33 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 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:33 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 10:48:33 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 10:48:33 INFO - Using env: {'DISPLAY': ':0', 10:48:33 INFO - 'HOME': '/home/cltbld', 10:48:33 INFO - 'LANG': 'en_US.UTF-8', 10:48:33 INFO - 'LANGUAGE': 'en_US:en', 10:48:33 INFO - 'LOGNAME': 'cltbld', 10:48:33 INFO - 'MAIL': '/var/mail/cltbld', 10:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:33 INFO - 'MOZ_NO_REMOTE': '1', 10:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:33 INFO - 'NO_EM_RESTART': '1', 10:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:33 INFO - 'PWD': '/builds/slave/test', 10:48:33 INFO - 'SHELL': '/bin/bash', 10:48:33 INFO - 'SHLVL': '1', 10:48:33 INFO - 'TERM': 'linux', 10:48:33 INFO - 'TMOUT': '86400', 10:48:33 INFO - 'USER': 'cltbld', 10:48:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:33 INFO - '_': '/tools/buildbot/bin/python'} 10:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:34 INFO - Downloading/unpacking psutil>=3.1.1 10:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:48:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:36 INFO - Installing collected packages: psutil 10:48:36 INFO - Running setup.py install for psutil 10:48:36 INFO - building 'psutil._psutil_linux' extension 10:48:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:48:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:48:36 INFO - building 'psutil._psutil_posix' extension 10:48:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:48:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:48:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:36 INFO - Successfully installed psutil 10:48:36 INFO - Cleaning up... 10:48:36 INFO - Return code: 0 10:48:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:48:36 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')]} 10:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:36 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')]} 10:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:36 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 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:36 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 10:48:36 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 10:48:36 INFO - Using env: {'DISPLAY': ':0', 10:48:36 INFO - 'HOME': '/home/cltbld', 10:48:36 INFO - 'LANG': 'en_US.UTF-8', 10:48:36 INFO - 'LANGUAGE': 'en_US:en', 10:48:36 INFO - 'LOGNAME': 'cltbld', 10:48:36 INFO - 'MAIL': '/var/mail/cltbld', 10:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:36 INFO - 'MOZ_NO_REMOTE': '1', 10:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:36 INFO - 'NO_EM_RESTART': '1', 10:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:36 INFO - 'PWD': '/builds/slave/test', 10:48:36 INFO - 'SHELL': '/bin/bash', 10:48:36 INFO - 'SHLVL': '1', 10:48:36 INFO - 'TERM': 'linux', 10:48:36 INFO - 'TMOUT': '86400', 10:48:36 INFO - 'USER': 'cltbld', 10:48:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:36 INFO - '_': '/tools/buildbot/bin/python'} 10:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:48:36 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 10:48:36 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 10:48:36 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 10:48:36 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 10:48:36 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 10:48:36 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 10:48:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:48:38 INFO - Installing collected packages: mozsystemmonitor 10:48:38 INFO - Running setup.py install for mozsystemmonitor 10:48:38 INFO - Successfully installed mozsystemmonitor 10:48:38 INFO - Cleaning up... 10:48:38 INFO - Return code: 0 10:48:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:48:38 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')]} 10:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:38 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')]} 10:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:38 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 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:38 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 10:48:38 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 10:48:38 INFO - Using env: {'DISPLAY': ':0', 10:48:38 INFO - 'HOME': '/home/cltbld', 10:48:38 INFO - 'LANG': 'en_US.UTF-8', 10:48:38 INFO - 'LANGUAGE': 'en_US:en', 10:48:38 INFO - 'LOGNAME': 'cltbld', 10:48:38 INFO - 'MAIL': '/var/mail/cltbld', 10:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:38 INFO - 'MOZ_NO_REMOTE': '1', 10:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:38 INFO - 'NO_EM_RESTART': '1', 10:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:38 INFO - 'PWD': '/builds/slave/test', 10:48:38 INFO - 'SHELL': '/bin/bash', 10:48:38 INFO - 'SHLVL': '1', 10:48:38 INFO - 'TERM': 'linux', 10:48:38 INFO - 'TMOUT': '86400', 10:48:38 INFO - 'USER': 'cltbld', 10:48:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:38 INFO - '_': '/tools/buildbot/bin/python'} 10:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:39 INFO - Downloading/unpacking jsonschema==2.5.1 10:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:48:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:48:40 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 10:48:40 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 10:48:40 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 10:48:40 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 10:48:40 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 10:48:40 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 10:48:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:48:41 INFO - warning: no files found matching '*.txt' 10:48:41 INFO - no previously-included directories found matching 'build' 10:48:41 INFO - no previously-included directories found matching 'dist' 10:48:41 INFO - no previously-included directories found matching '.git*' 10:48:41 INFO - Installing collected packages: jsonschema, functools32 10:48:41 INFO - Running setup.py install for functools32 10:48:41 INFO - warning: no files found matching '*.txt' 10:48:41 INFO - no previously-included directories found matching 'build' 10:48:41 INFO - no previously-included directories found matching 'dist' 10:48:41 INFO - no previously-included directories found matching '.git*' 10:48:41 INFO - Successfully installed jsonschema functools32 10:48:41 INFO - Cleaning up... 10:48:41 INFO - Return code: 0 10:48:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:48:41 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')]} 10:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:41 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')]} 10:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:41 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 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:41 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 10:48:41 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 10:48:41 INFO - Using env: {'DISPLAY': ':0', 10:48:41 INFO - 'HOME': '/home/cltbld', 10:48:41 INFO - 'LANG': 'en_US.UTF-8', 10:48:41 INFO - 'LANGUAGE': 'en_US:en', 10:48:41 INFO - 'LOGNAME': 'cltbld', 10:48:41 INFO - 'MAIL': '/var/mail/cltbld', 10:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:41 INFO - 'MOZ_NO_REMOTE': '1', 10:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:41 INFO - 'NO_EM_RESTART': '1', 10:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:41 INFO - 'PWD': '/builds/slave/test', 10:48:41 INFO - 'SHELL': '/bin/bash', 10:48:41 INFO - 'SHLVL': '1', 10:48:41 INFO - 'TERM': 'linux', 10:48:41 INFO - 'TMOUT': '86400', 10:48:41 INFO - 'USER': 'cltbld', 10:48:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:41 INFO - '_': '/tools/buildbot/bin/python'} 10:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:48:41 INFO - Cleaning up... 10:48:41 INFO - Return code: 0 10:48:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:48:41 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')]} 10:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:41 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')]} 10:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:41 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 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:41 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 10:48:41 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 10:48:41 INFO - Using env: {'DISPLAY': ':0', 10:48:41 INFO - 'HOME': '/home/cltbld', 10:48:41 INFO - 'LANG': 'en_US.UTF-8', 10:48:41 INFO - 'LANGUAGE': 'en_US:en', 10:48:41 INFO - 'LOGNAME': 'cltbld', 10:48:41 INFO - 'MAIL': '/var/mail/cltbld', 10:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:41 INFO - 'MOZ_NO_REMOTE': '1', 10:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:41 INFO - 'NO_EM_RESTART': '1', 10:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:41 INFO - 'PWD': '/builds/slave/test', 10:48:41 INFO - 'SHELL': '/bin/bash', 10:48:41 INFO - 'SHLVL': '1', 10:48:41 INFO - 'TERM': 'linux', 10:48:41 INFO - 'TMOUT': '86400', 10:48:41 INFO - 'USER': 'cltbld', 10:48:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:41 INFO - '_': '/tools/buildbot/bin/python'} 10:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:48:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:48:43 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 10:48:43 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 10:48:43 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 10:48:43 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 10:48:43 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 10:48:43 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 10:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:48:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:44 INFO - Downloading docopt-0.6.1.tar.gz 10:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:48:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:48:44 INFO - Running setup.py install for blobuploader 10:48:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:48:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:48:44 INFO - Running setup.py install for requests 10:48:44 INFO - Running setup.py install for docopt 10:48:45 INFO - Successfully installed blobuploader requests docopt 10:48:45 INFO - Cleaning up... 10:48:45 INFO - Return code: 0 10:48:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:48:45 INFO - Using env: {'DISPLAY': ':0', 10:48:45 INFO - 'HOME': '/home/cltbld', 10:48:45 INFO - 'LANG': 'en_US.UTF-8', 10:48:45 INFO - 'LANGUAGE': 'en_US:en', 10:48:45 INFO - 'LOGNAME': 'cltbld', 10:48:45 INFO - 'MAIL': '/var/mail/cltbld', 10:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:45 INFO - 'MOZ_NO_REMOTE': '1', 10:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:45 INFO - 'NO_EM_RESTART': '1', 10:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:45 INFO - 'PWD': '/builds/slave/test', 10:48:45 INFO - 'SHELL': '/bin/bash', 10:48:45 INFO - 'SHLVL': '1', 10:48:45 INFO - 'TERM': 'linux', 10:48:45 INFO - 'TMOUT': '86400', 10:48:45 INFO - 'USER': 'cltbld', 10:48:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:45 INFO - '_': '/tools/buildbot/bin/python'} 10:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:48:45 INFO - Running setup.py (path:/tmp/pip-L5yMbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:48:45 INFO - Running setup.py (path:/tmp/pip-_rRf32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:48:45 INFO - Running setup.py (path:/tmp/pip-BfBLwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:48:45 INFO - Running setup.py (path:/tmp/pip-abf_l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:48:45 INFO - Running setup.py (path:/tmp/pip-vPHN6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:48:45 INFO - Running setup.py (path:/tmp/pip-glOywM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:48:45 INFO - Running setup.py (path:/tmp/pip-Ktt4ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:48:45 INFO - Running setup.py (path:/tmp/pip-lj2Xwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:48:45 INFO - Running setup.py (path:/tmp/pip-eTzl5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:48:46 INFO - Running setup.py (path:/tmp/pip-2quRiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:48:46 INFO - Running setup.py (path:/tmp/pip-JAGhzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:48:46 INFO - Running setup.py (path:/tmp/pip-nF0ynl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:48:46 INFO - Running setup.py (path:/tmp/pip-wKD4zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:48:46 INFO - Running setup.py (path:/tmp/pip-aMdtBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:46 INFO - Running setup.py (path:/tmp/pip-Fudxgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:48:46 INFO - Running setup.py (path:/tmp/pip-edHeV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:48:46 INFO - Running setup.py (path:/tmp/pip-kapIRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:48:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:48:46 INFO - Running setup.py install for manifestparser 10:48:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:48:46 INFO - Running setup.py install for mozcrash 10:48:46 INFO - Running setup.py install for mozdebug 10:48:46 INFO - Running setup.py install for mozdevice 10:48:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:48:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:48:46 INFO - Running setup.py install for mozfile 10:48:47 INFO - Running setup.py install for mozhttpd 10:48:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Running setup.py install for mozinfo 10:48:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Running setup.py install for mozInstall 10:48:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Running setup.py install for mozleak 10:48:47 INFO - Running setup.py install for mozlog 10:48:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Running setup.py install for moznetwork 10:48:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Running setup.py install for mozprocess 10:48:47 INFO - Running setup.py install for mozprofile 10:48:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:48:47 INFO - Running setup.py install for mozrunner 10:48:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Running setup.py install for mozscreenshot 10:48:48 INFO - Running setup.py install for moztest 10:48:48 INFO - Running setup.py install for mozversion 10:48:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:48:48 INFO - Cleaning up... 10:48:48 INFO - Return code: 0 10:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:48: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')]} 10:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:48:48 INFO - Using env: {'DISPLAY': ':0', 10:48:48 INFO - 'HOME': '/home/cltbld', 10:48:48 INFO - 'LANG': 'en_US.UTF-8', 10:48:48 INFO - 'LANGUAGE': 'en_US:en', 10:48:48 INFO - 'LOGNAME': 'cltbld', 10:48:48 INFO - 'MAIL': '/var/mail/cltbld', 10:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:48 INFO - 'MOZ_NO_REMOTE': '1', 10:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:48 INFO - 'NO_EM_RESTART': '1', 10:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:48 INFO - 'PWD': '/builds/slave/test', 10:48:48 INFO - 'SHELL': '/bin/bash', 10:48:48 INFO - 'SHLVL': '1', 10:48:48 INFO - 'TERM': 'linux', 10:48:48 INFO - 'TMOUT': '86400', 10:48:48 INFO - 'USER': 'cltbld', 10:48:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:48 INFO - '_': '/tools/buildbot/bin/python'} 10:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:48:48 INFO - Running setup.py (path:/tmp/pip-A_3hdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:48:48 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)) 10:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:48:48 INFO - Running setup.py (path:/tmp/pip-5WYNcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:48:48 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)) 10:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:48:48 INFO - Running setup.py (path:/tmp/pip-gsjKEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:48:48 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)) 10:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:48:48 INFO - Running setup.py (path:/tmp/pip-Zfg736-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:48:48 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)) 10:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:48:48 INFO - Running setup.py (path:/tmp/pip-sjjFiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:48:48 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)) 10:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:48:48 INFO - Running setup.py (path:/tmp/pip-KOL89l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:48:49 INFO - Running setup.py (path:/tmp/pip-DtKeCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:48:49 INFO - Running setup.py (path:/tmp/pip-lhsByW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:48:49 INFO - Running setup.py (path:/tmp/pip-gEBm6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:48:49 INFO - Running setup.py (path:/tmp/pip-iZEcD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:48:49 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)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:48:49 INFO - Running setup.py (path:/tmp/pip-hA53yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:48:49 INFO - Running setup.py (path:/tmp/pip-fvHsHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:48:49 INFO - Running setup.py (path:/tmp/pip-V5hMCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:48:49 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)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:48:49 INFO - Running setup.py (path:/tmp/pip-D75OiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:48:49 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)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:49 INFO - Running setup.py (path:/tmp/pip-fmW8hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:49 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)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:48:49 INFO - Running setup.py (path:/tmp/pip-nuguta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:48:49 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)) 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:48:49 INFO - Running setup.py (path:/tmp/pip-FiKUzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:48:49 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)) 10:48:49 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)) 10:48:49 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)) 10:48:49 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)) 10:48:49 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)) 10:48:49 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)) 10:48:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:48:49 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 10:48:49 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 10:48:49 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 10:48:49 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 10:48:49 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 10:48:49 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 10:48:51 INFO - Downloading blessings-1.6.tar.gz 10:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:48:51 INFO - Installing collected packages: blessings 10:48:51 INFO - Running setup.py install for blessings 10:48:51 INFO - Successfully installed blessings 10:48:51 INFO - Cleaning up... 10:48:51 INFO - Return code: 0 10:48:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:48:52 INFO - Reading from file tmpfile_stdout 10:48:52 INFO - Current package versions: 10:48:52 INFO - argparse == 1.2.1 10:48:52 INFO - blessings == 1.6 10:48:52 INFO - blobuploader == 1.2.4 10:48:52 INFO - docopt == 0.6.1 10:48:52 INFO - functools32 == 3.2.3-2 10:48:52 INFO - jsonschema == 2.5.1 10:48:52 INFO - manifestparser == 1.1 10:48:52 INFO - mozInstall == 1.12 10:48:52 INFO - mozcrash == 0.17 10:48:52 INFO - mozdebug == 0.1 10:48:52 INFO - mozdevice == 0.48 10:48:52 INFO - mozfile == 1.2 10:48:52 INFO - mozhttpd == 0.7 10:48:52 INFO - mozinfo == 0.9 10:48:52 INFO - mozleak == 0.1 10:48:52 INFO - mozlog == 3.3 10:48:52 INFO - moznetwork == 0.27 10:48:52 INFO - mozprocess == 0.23 10:48:52 INFO - mozprofile == 0.28 10:48:52 INFO - mozrunner == 6.12 10:48:52 INFO - mozscreenshot == 0.1 10:48:52 INFO - mozsystemmonitor == 0.3 10:48:52 INFO - moztest == 0.7 10:48:52 INFO - mozversion == 1.4 10:48:52 INFO - psutil == 3.1.1 10:48:52 INFO - requests == 1.2.3 10:48:52 INFO - wsgiref == 0.1.2 10:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:48:52 INFO - Using env: {'DISPLAY': ':0', 10:48:52 INFO - 'HOME': '/home/cltbld', 10:48:52 INFO - 'LANG': 'en_US.UTF-8', 10:48:52 INFO - 'LANGUAGE': 'en_US:en', 10:48:52 INFO - 'LOGNAME': 'cltbld', 10:48:52 INFO - 'MAIL': '/var/mail/cltbld', 10:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:52 INFO - 'MOZ_NO_REMOTE': '1', 10:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:52 INFO - 'NO_EM_RESTART': '1', 10:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:52 INFO - 'PWD': '/builds/slave/test', 10:48:52 INFO - 'SHELL': '/bin/bash', 10:48:52 INFO - 'SHLVL': '1', 10:48:52 INFO - 'TERM': 'linux', 10:48:52 INFO - 'TMOUT': '86400', 10:48:52 INFO - 'USER': 'cltbld', 10:48:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:52 INFO - '_': '/tools/buildbot/bin/python'} 10:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:48:52 INFO - Cleaning up... 10:48:52 INFO - Return code: 0 10:48:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c72030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', '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 10:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:48:52 INFO - Using env: {'DISPLAY': ':0', 10:48:52 INFO - 'HOME': '/home/cltbld', 10:48:52 INFO - 'LANG': 'en_US.UTF-8', 10:48:52 INFO - 'LANGUAGE': 'en_US:en', 10:48:52 INFO - 'LOGNAME': 'cltbld', 10:48:52 INFO - 'MAIL': '/var/mail/cltbld', 10:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:52 INFO - 'MOZ_NO_REMOTE': '1', 10:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:52 INFO - 'NO_EM_RESTART': '1', 10:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:52 INFO - 'PWD': '/builds/slave/test', 10:48:52 INFO - 'SHELL': '/bin/bash', 10:48:52 INFO - 'SHLVL': '1', 10:48:52 INFO - 'TERM': 'linux', 10:48:52 INFO - 'TMOUT': '86400', 10:48:52 INFO - 'USER': 'cltbld', 10:48:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:52 INFO - '_': '/tools/buildbot/bin/python'} 10:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:48:52 INFO - Cleaning up... 10:48:52 INFO - Return code: 0 10:48:52 INFO - Running post-action listener: _resource_record_post_action 10:48:52 INFO - Running post-action listener: _start_resource_monitoring 10:48:52 INFO - Starting resource monitoring. 10:48:52 INFO - [mozharness: 2016-08-05 17:48:52.653368Z] Finished create-virtualenv step (success) 10:48:52 INFO - [mozharness: 2016-08-05 17:48:52.653813Z] Running install step. 10:48:52 INFO - Running pre-action listener: _resource_record_pre_action 10:48:52 INFO - Running main action method: install 10:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:48:52 INFO - Reading from file tmpfile_stdout 10:48:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:48:52 INFO - Reading from file tmpfile_stdout 10:48:52 INFO - Output received: 10:48:52 INFO - Usage: mozinstall [options] installer 10:48:52 INFO - Options: 10:48:52 INFO - -h, --help show this help message and exit 10:48:52 INFO - -d DEST, --destination=DEST 10:48:52 INFO - Directory to install application into. [default: 10:48:52 INFO - "/builds/slave/test"] 10:48:52 INFO - --app=APP Application being installed. [default: firefox] 10:48:52 INFO - mkdir: /builds/slave/test/build/application 10:48:52 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'] 10:48:52 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 10:49:09 INFO - Reading from file tmpfile_stdout 10:49:09 INFO - Output received: 10:49:09 INFO - /builds/slave/test/build/application/firefox/firefox 10:49:09 INFO - Running post-action listener: _resource_record_post_action 10:49:09 INFO - [mozharness: 2016-08-05 17:49:09.107767Z] Finished install step (success) 10:49:09 INFO - [mozharness: 2016-08-05 17:49:09.108014Z] Running run-tests step. 10:49:09 INFO - Running pre-action listener: _resource_record_pre_action 10:49:09 INFO - Running main action method: run_tests 10:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:49:09 INFO - Python 2.7.3 10:49:09 INFO - Return code: 0 10:49:09 INFO - grabbing minidump binary from tooltool 10:49: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')]} 10:49:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30570>, '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 0x1f31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f31900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:49:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:49:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:49:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:49:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:49:09 INFO - Return code: 0 10:49:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:49:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:49:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:49:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:49:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:49:09 INFO - Using env: {'DISPLAY': ':0', 10:49:09 INFO - 'HOME': '/home/cltbld', 10:49:09 INFO - 'LANG': 'en_US.UTF-8', 10:49:09 INFO - 'LANGUAGE': 'en_US:en', 10:49:09 INFO - 'LOGNAME': 'cltbld', 10:49:09 INFO - 'MAIL': '/var/mail/cltbld', 10:49:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:49:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:09 INFO - 'MOZ_NO_REMOTE': '1', 10:49:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:09 INFO - 'NO_EM_RESTART': '1', 10:49:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:09 INFO - 'PWD': '/builds/slave/test', 10:49:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:49:09 INFO - 'SHELL': '/bin/bash', 10:49:09 INFO - 'SHLVL': '1', 10:49:09 INFO - 'TERM': 'linux', 10:49:09 INFO - 'TMOUT': '86400', 10:49:09 INFO - 'USER': 'cltbld', 10:49:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853', 10:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:09 INFO - '_': '/tools/buildbot/bin/python'} 10:49:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:49:09 INFO - mozversion application_buildid: 20160805093133 10:49:09 INFO - mozversion application_changeset: 204a7ba2fba4bd74e715065492262cc6ffa8f8cf 10:49:09 INFO - mozversion application_display_name: Nightly 10:49:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:49:09 INFO - mozversion application_name: Firefox 10:49:09 INFO - mozversion application_remotingname: firefox 10:49:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:49:09 INFO - mozversion application_vendor: Mozilla 10:49:09 INFO - mozversion application_version: 51.0a1 10:49:09 INFO - mozversion platform_buildid: 20160805093133 10:49:09 INFO - mozversion platform_changeset: 204a7ba2fba4bd74e715065492262cc6ffa8f8cf 10:49:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:49:09 INFO - mozversion platform_version: 51.0a1 10:49:09 INFO - using testdate: 1470419349 10:49:09 INFO - actual date: 1470419349 10:49:09 INFO - starting webserver on 'localhost:57304' 10:49:09 INFO - SUITE-START | Running 2 tests 10:49:09 INFO - TEST-START | dromaeo_css 10:49:09 INFO - operating with platform_type : linux_ 10:49:09 INFO - Initialising browser for dromaeo_css test... 10:49:09 INFO - TEST-INFO | started process 3912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg95bmy/profile http://localhost:57304/getInfo.html) 10:49:14 INFO - PROCESS | 3912 | __metrics Screen width/height:1600/1200 10:49:14 INFO - PROCESS | 3912 | colorDepth:24 10:49:14 INFO - PROCESS | 3912 | Browser inner width/height: 1024/697 10:49:14 INFO - PROCESS | 3912 | __metrics 10:49:14 ERROR - PROCESS | 3912 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:49:15 INFO - TEST-INFO | 3912: exit 0 10:49:15 INFO - Browser initialized. 10:49:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:49:15 INFO - TEST-INFO | started process 4032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg95bmy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:49:27 INFO - PROCESS | 4032 | RSS: Main: 164782080 10:49:27 INFO - PROCESS | 4032 | 10:50:17 INFO - PROCESS | 4032 | 1470419417534 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] 10:52:30 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:57304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57304/tests/dromaeo/cssquery-ext.html) 10:52:31 INFO - PROCESS | 4032 | RSS: Main: 167247872 10:52:31 INFO - PROCESS | 4032 | 10:55:33 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:57304/tests/dromaeo/cssquery-ext.html (next: http://localhost:57304/tests/dromaeo/cssquery-jquery.html) 10:55:34 INFO - PROCESS | 4032 | RSS: Main: 167370752 10:55:34 INFO - PROCESS | 4032 | 10:58:36 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:57304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57304/tests/dromaeo/cssquery-mootools.html) 10:58:37 INFO - PROCESS | 4032 | RSS: Main: 170536960 10:58:37 INFO - PROCESS | 4032 | 11:01:39 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:57304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57304/tests/dromaeo/cssquery-prototype.html) 11:01:39 INFO - PROCESS | 4032 | RSS: Main: 165343232 11:01:39 INFO - PROCESS | 4032 | 11:04:42 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:57304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57304/tests/dromaeo/cssquery-yui.html) 11:04:43 INFO - PROCESS | 4032 | RSS: Main: 166789120 11:04:43 INFO - PROCESS | 4032 | 11:07:45 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:57304/tests/dromaeo/cssquery-yui.html (next: http://localhost:57304/tests/dromaeo/cssquery-dojo.html) 11:07:46 INFO - PROCESS | 4032 | RSS: Main: 170905600 11:07:46 INFO - PROCESS | 4032 | 11:07:46 INFO - PROCESS | 4032 | __start_tp_report 11:07:46 INFO - PROCESS | 4032 | _x_x_mozilla_page_load 11:07:46 INFO - PROCESS | 4032 | _x_x_mozilla_page_load_details 11:07:46 INFO - PROCESS | 4032 | |i|pagename|runs| 11:07:46 INFO - PROCESS | 4032 | |0;dojo.html;2632.0656167060692;2642.656454660894;2666.9999999999995;2674.2913128021078;2686.973130268697;4782.378290822188;4877.146499362615;4898.632602554805;4902.1911384621535;4954.207326827708;4752.691075080117;4836.685615434994;4838.34682317887;4888.340074089997;4922.852314430564;4356.5425630308755;4408.074304396065;4422.093470838487;4455.398521199629;4522.2312206924735;4480.103979204156;4506.571875671806;4522.29904364824;4534.8866278342975;4568.177728008957;4357.237483440385;4375.584319489675;4446.288593825005;4483.193025255453;4512.661550383701;4480.350349199381;4505.549445055501;4512.187806194884;4537.342085397632;4538.818447262105;4431.423914891076;4443.644508439317;4449.977750111261;4473.4855491618555;4486.416765820422;4713.410823647044;4782.641301902337;4836.347093142416;4848.0788650156355;4871.196252618313;5248.422673505911;5252.553532949704;5254.369475662945;5257.553107985826;5286.735663216824;5275.261463395128;5276.261323414725;5291.206319052135;5293.523582877559;5367.624266301361;4777.856664300077;4888.291197776302;4928.654994150375;4934.3338649282605;4938.308636790852;5418.729063546807;5424.376196737347;5426.131818908955;5483.396826349099;5491.450854914477;5172.8965420691375;5180.766865491062;5195.2986346843445;5196.882670225919;5261.894762104736;5030.949690503048;5231.947680523146;5278.788848446096;5295.629305948623;5301.522862942354;5267.051930652443;5271;5293.602979776455;5296.682199067991;5314.229436731653;5270.815521456807;5277.261183434322;5279.894402111936;5292.655977361459;5308.681479111188;4373.059792144704;4498.122866041091;4522.706024108423;4569.017661202857;4569.748663823455;3922.86269980555;3933.1347103637154;3960.821763020671;3964.8810535683974;3987.5813039631003;4475.060237350128;4487.28203487447;4498.190325741332;4502.774861256924;4527.864164075083;5076.238564215323;5192.714400707997;5258.50044245796;5305.973470132624;5325.573954083664;4448.310511870665;4470;4491.214037543482;4497.280435130363;4508.301213311942;4745.217039188564;4752.097101550694;4755.262934245197;4773.76131193439;4789.066132104206;4694.64790140734;4760.9047819042735;4809.44691360498;4864.80540778372;4881.707097574157;5260.763265652979;5284.339457567804;5286.656367336111;5313.123334649739;5333.306670132858;4813.181759101031;4834.540718631724;4844.079624871263;4850.296706977398;4899.363082799213;5042.974785126051;5171.63798534099;5187.559057480156;5212.895742085213;5238.476152384731;5338.54622357104;5357.491038351351;5360.517553420211;5368.7047212403695;5382.67703937765;5162.354705661793;5171.3535808024;5178.0679477694375;5212.895742085213;5260.105782017143;4989.850304490871;5127.53852153308;5133.127368347465;5182.922256166085;5208.791648334176;5034.345535080416;5057.8735531612;5067.594592432671;5088.872778180576;5110.948890511196;5228.189630607262;5228.398734145622;5244.003639308519;5256.78972841082;5277.20841873722;4759.524047595212;4891;4892;5091.745412729423;5126.128558145198 11:07:46 INFO - PROCESS | 4032 | |1;ext.html;532.8321578702709;548.0846985534155;553.1094937151186;563.9566801417378;580.2398857496677;35138.29723405534;39121.413178802344;39184.99999999996;39380.40929386061;39381.40927886084;38613.80693096537;39283;39329.60670393295;39406;39439.211215775664;7611.162772095079;7732.652030658605;7760;7771.455998080137;7781.610919454005;7733.922660773376;7755.612219389036;7780.221977802203;7781.3774898008305;7796.064472263308;7821;7826.256505631955;7834.451588388815;7846.254605812467;7871.252231038042;7812.765617031499;7813.804654883616;7849.8037549061155;7865.6067196640515;7874.251946065143;7695.076590809139;7718;7734.690612375498;7814.023247094114;7814.492058016211;36436.27127457436;36631.63368366309;36712.265754684755;36833.631663683285;36835.447468287995;2509.397744541315;2938.1038783171125;2977.865996030184;3152.1016510294457;3169.0492852144494;27633.585496217373;27878.442431151467;27983.440331193466;28104;28690.856545717346;2766.1286694691307;3202.343519578481;3267.1995361136437;3277.885274015422;3319.850606722703;214359;262941;263157;263471;263722;55312.72343638256;55362.72318638381;55881;56363;56429.71785141048;32925.50611740826;33450;34157.316853662785;35347.82326088353;35385;15174.24128793556;15264.16047117397;15368;15407.768883466757;15408.537743867702;11570.42147892602;11639.127065470124;11657.941710291394;11696.47365868538;11714.23857449263;18015.72976405355;18090.638187236444;18122.90938545299;18162.545936351697;18213.817861821477;6689.755468597727;6719.563228390139;7053.8236544085785;7131.286871312827;7199;820.7906983719114;898.514802006922;906.4334790755778;926.4024704065974;986.7730422002979;27836.721632783818;28045.57931631027;28353.574696379572;29075.273118172216;29095.56356654652;957.2485598804905;990.7473594233569;995.746084748399;1019.4393083803878;1083.4311986207304;14862.182579958206;15081;15208.391664333303;15217.61955951088;15304.846951530564;390770;396413;397347;398100;398310;48814.26778598324;49210;49267.507324927006;49325;49486.257706134435;1152.792497350485;1159.4550561236206;1165.1145129701488;1176.952921883115;1199.892009719147;26546.86726566432;27647.333538687402;27826.304342391602;28093.57859632066;28166.2958426041;41318.793406032775;42248.57751422447;42254;42307.36538951856;42414.36378454387;337094;339007;339677;339918;339949;25028.749712502642;25146.62280065764;25177.87411062933;25454.981800727764;25516.106936257143;41332.58667413408;41657.79171104246;41747.37378939258;42683.786581066895;42887.14225715406;35362.646373535936;35641.1089722759;35910.8204458976;35983.64016359908;36284.63715362812;35379.82310088433;35978.10054748652;36275.45586816147;36386.8180659095;36470.08824779402;35089;35300.646993529735;35472.82263588665;35538.46692299669;35620;30749;32763.34473310568;32885.50671739974;33222.83388583042;33248.335033299685;25212.24363269105;25422.74577254204;25476;25635.102771403657;25837.870810645825 11:07:46 INFO - PROCESS | 4032 | |2;jquery.html;366.91927775889314;374.2421596267558;378.33224359006357;380.8114983083371;391.59274354671146;16281.104539250337;16728.41450549231;17684.64630707385;17835.554111147227;17840.910795446038;16758.32966681331;17253.568660783454;17383.13084345784;17684.557886052822;18109.818901810977;4559.589636932676;4762.309465127554;4764.356811830393;4770.260609605517;4775.450823155329;4535.138323718483;4639.373684552593;4692.06158768246;4708.670393072486;4710.670253082286;4736.928946065812;4740.07568524138;4740.336352910595;4743.92884106737;4749.978754567767;4725.574698277154;4740.454847692525;4743.430788305408;4757.1437141314545;5829.183914252008;5392.703401312926;5481.260029895953;5485.451454854522;5498.615096943216;5498.697571633558;11698.707532311675;11791.587294444738;18731.906340468347;21699.240526581492;21757.564848703096;1909.284018493065;1913.2050906163486;1989.0651393844869;2101.53766171442;2268.943276418086;8784;8987.32595055367;9261.861072083924;9400.24798016157;12885.742285154338;1677.8406051425095;1692.3653629888793;1708.4874537638782;1714.6827836850223;1714.68826347844;70092;70135.99999999949;70448.2955170452;71673;72894.63552682256;9799.951000244953;9991.601175835389;10150.847737283946;10439.582416703399;10591.563940293776;13985.090969086978;14100.85899141016;14138.43446262138;14146.504872329419;14199.14805111676;7287.672054757549;7290.088738907637;7475.43934204926;7475.439342049368;7492.100947886289;6943.61342834121;7019.824504387431;7072.681729322193;7079.92920070803;7368.115826100902;4384.934225986613;4434.423524941737;4435.2903535434825;4437.755923424178;4581.358609794632;1839.4849442156217;1845.4094689699436;1845.6401001804788;1857.2385322017908;1865.097600447536;830.5099991005336;854.4531499840107;867.2065060469599;871.407442938795;893.5978809535735;16869.83130168707;17745;17868.731969020475;17931.193096310435;18192.272309107488;854.9102344253888;876.9956150219335;879.5997820991562;901.9774505637412;916.8716379706847;8627.741167764852;9502.04979502058;10058.849117263248;10070.899291007143;10118.595256189818;408566;409115;425543;427064;434336;81583;84347.20437580324;85380.77596222368;86486;86669.1333086661;919.5172534419349;925.842606756853;949.9525023748785;964.2093483343731;970.1947383671536;16448.75326870074;16722.749158762384;16948.32206711767;16980.23588938476;17180.39868604593;29076;38804.22391552097;39021;40924.1815163701;41986.37020444757;55754.16368754391;56297;57047.71476142593;57268;57577.71211144085;7494.400447964259;7552.773416797505;7646.8088297793;7753.612319383896;7787.844243114992;8656.39405241627;11992.880071199177;12262.877371226174;12291.262524248574;12300.87699123033;10356.741081473023;10419.94790026045;10477.214208934209;10691.786164276826;10711.64343844353;7242.565446073252;10252.692419227435;10320.793584128125;10473.68578942633;10636.84044739345;9570.282228832726;10548.736281593021;10586.206034547593;10807.729806754895;10865.130789536975;6416.711247993758;6726.7981960541265;6769.28922463154;7556.131044929683;7804.102528209101;9778.315517913677;10232.59069637236;10447.895521044997;10792.946035270088;11066.059384952046 11:07:46 INFO - PROCESS | 4032 | |3;mootools.html;1357.558793392148;1392.3873495661908;1445.7614493608555;1639.6802623488425;1640.8605268552164;6714.6978385972625;7373.262673732631;7446.888296675541;7963.522188668677;7966.84066318674;7581.962090189541;7851.685932562691;7856.528608283507;7868.685252589889;7873;2087.958240835186;2124.4476436126643;2127.106615221611;2133.1680644548637;2136.1882484655807;2051.8563700540967;2101.8213451856536;2124.4370241885913;2134.1356750516065;2142.1431427428997;2096.2348742708955;2097.64340062189;2109.7468303803566;2118.1315660579166;2126.64910289802;2069.0689189864547;2071.420002399323;2081.490034941434;2084.1871670048695;2090.1325949730845;2046.9385918422472;2082.7604825445114;2088.060372832216;2091.44576687178;2094.465911192651;7629.923700763033;7675.923240767633;7676.232376762335;7725.652345644459;7726;4322.265214913472;4434.756088415136;4436.0462500562535;4484.910301793979;4486.0355023669745;2740.5341092014405;2788.219298596396;2855.271905664063;2856.614357061791;2858.8427636479987;845.4612605058795;891.3448615267773;893.2496702769705;905.8233644439271;907.8411278026385;10497.055265026109;10512.106470950055;10518.474076296154;10575.947120264349;10628.94685526575;3835.520559930009;3972.682185425159;4039.9192016159514;4051.797410129541;4094.61101195386;9073.45559266446;9080.909190908007;9083.727488175366;9083.772905677411;9084.954575227082;4569.565891240327;4580.404547408815;4584.404027476474;4593.701409408378;4600.171969045604;3517.2437925846066;3999.5400528938962;4116.217918595457;4137.648299894543;4155.896102597399;3581.767185132958;3649.6897763690386;3690.963090369062;3701.4632878232505;3780.9621903781162;1123.3203911633507;1128.2835399521364;1183.1244878789805;1183.9940800295944;1188.1564089496383;761.8666733321646;763.7441457111819;767.6277005652254;780.8867714181412;825.3644693585906;4883.902321953541;4891.437484689306;4915.533024362751;4921;5128.615353848476;374.5636333671242;374.9850005999784;376.38461116074865;380.62698555415847;389.3614472265487;3186.433247312288;3270.133414645121;3277.3281477297096;3307.6361600223954;3353.832308384571;9146.2225710814;9443.244540436748;9541.570629321697;9571.856422153673;9574.95212523933;9477.952610236905;9541.570629321697;9549.474778887228;9560.665376711782;9583.712488625353;7345.55926644403;7357.675618388741;7377.77866664001;7422.331990120915;7445.516041457288;4909.337239472626;4973.52751488608;4977.178765503796;4982.701037937735;4983.103041452573;8948.105189481;8975.147361000694;8977.326700497619;8989.685361012333;9118.088191180828;8895.06601806801;9124.041975592467;9134.040925702706;9179.632814687604;9180.311476639145;5736.483716465538;6258.217722784652;6479.773207937699;6607.141071660653;6681.732730690718;7437.367823735043;7437.888431673421;7500.399968002437;7518.774436766906;7523.360514356341;6642.136522252076;6767.154105736783;6770.1537307836525;6813.727450901908;6874.243833178446;6615;6654.700538475683;6749.392554670103;6772.627505487246;6801.761938332333;5990.430909063632;6047.153398524122;6050.667213303311;6060.515158787198;6062.939370606237;4372.103718737588;4379.562043795595;4449.710768800018;4460.576245256695;4485.663575231805;4470.105978804318;4518.728876267434;4572.81708731647;4578.5650363215445;4695.976520117378 11:07:46 INFO - PROCESS | 4032 | |4;prototype.html;297.90318146602345;300.69028900232763;304.9965613132793;306.44992238931115;307.50645214430835;5067.315912351832;5130.8460746177625;5147.7426128693505;5150.562202212807;5166.483351664831;5004.324416203812;5031.496850314967;5034.798608055673;5039.168537191368;5052.393712754465;3762.75542089764;3852.4413959975786;3899.532056153266;3920.764754114748;3967.960320396788;3911.550171730245;3921.8823435296986;3926.4110383442426;3932.233214523169;3978.9801050994706;3901.1222474943193;3902.921941561167;3963.286608410485;3975.1254723960683;3978.562358140602;3856.1709232514863;3939.1727737174942;3968.0476685595536;3972.582878797728;3980.144268982183;3451.32699123671;3456.5333679953137;3460.0138960396416;3462.8441720122655;3503.597086335053;4869.8782530436665;4891.4863939286215;4893.437254715717;4911.533404326583;4931.408231012266;4412.8085416937565;4516.435445569304;4539.319102134673;4557.134144512565;4575.382323386367;5233.665415319069;5258.474152584749;5267.315249017642;5282.9132492665185;5292.68243905363;3828.846846126152;3829.8276577554075;3838.5777564467885;3849.8460061597502;3864.8260828262514;5456.699881506476;5586.804461843816;5598.44015598441;5613.101903695389;5625.634333768292;3871.7483363581277;3879.282332768447;3897;3899;3911.882643520699;3945.1320709443876;3946.1121247719607;3953.881383558498;3975.1453437510495;3988.484375937125;4500.887477813016;4501.279795232747;4507.278835386388;4540.79566419512;4562.634989200856;5079.6698214615935;5283.498067683564;5302.70835104073;5321.467853214647;5396.64921780083;1359.4901911783081;1383.481194552043;1384.2732565403041;1391.1305434103685;1392.1786146173806;837.8114924142142;873.4366333714845;880.8898887639045;893.9418937769025;906.6871929184421;4349.412829268072;4477;4589.242774942097;4608.861734147981;4618.722876627346;5510.586705997066;5516.159178023321;5531.3915469298345;5533.391326954032;5542.445755424425;4607.792649330788;4609.400777898852;4612.630989520897;4613.169629466728;4613.95386046142;2787.5261205595098;2913.6649285332032;2919.737223649882;2932.372533244027;2956.137633291013;5052.317937078521;5066.088104141216;5137.691738495628;5140.485951404829;5154.175331946871;5346.251524786533;5664.801731939445;5670.5180059695385;5687.772489100473;5701.144828275709;5052.418971818214;5053.69677819332;5054.508919868647;5084.41529224144;5105.570440276729;5544.002079625706;5548.361938377138;5562.527185189304;5590.413006634245;5608.635438696471;5223.634345595924;5416.350037995466;5420.349558053059;5432.701201433801;5453.590980676386;5043.562584663353;5069.746512674278;5090.516400941905;5092.592592592658;5109.824740309824;3959.891230455477;3992.9618299241824;3995.860144894915;4012.0371110933747;4014.979925100356;5285;5494.09347457665;5501.697406642673;5517.5585953124455;5562.9443705564045;5263.868403289795;5270.472952704698;5292.126799078109;5298.794229491103;5299.178627312773;5260.342457192851;5280.4455532170105;5291.1798671206025;5312.707801070978;5317.760700768552;4915;5172.818951336685;5174.456682048331;5176.611754118381;5192.428832828461;5111.080005599028;5223.197996691136;5330.706811125426;5331.760070796746;5333.7866485340155;5222.764975576184;5230.189320655304;5238.476152384884;5239.764210610456;5243.161094224905 11:07:46 INFO - PROCESS | 4032 | |5;yui.html;598.9730462129204;599.9070144127662;641.5701480008394;646.3665607704448;694.2640800751201;13276;14295.714085718279;14422.783658245135;14426.783598246022;14446.494372696945;13444.731105377887;13549.729005419886;13719.451221951134;14293.213873236968;14454.060486068425;779.4699604269109;800.8438354520871;801.1547817053007;802.2458888644655;802.4142376065475;626.786892456567;767.5202998126172;788.1960400391597;789.2975252025702;794.5788731972063;820.306840719591;820.3847114664002;821.1829229916242;823.390690888744;829.4732844643635;816.3183741575791;819.4018366592392;823.0164952881279;823.1192623892438;825.9463134896273;598.6408155106944;599.8470390050553;601.4316470934968;602.256213576233;603.6438501284264;13496.527621533298;13526;13558.661033474144;13567.1859688419;13575.117617354841;12850.421731022127;13163.53927612529;13218.272994985273;13256.86743132566;13422.597322080353;10766.962389104086;10955;11028.558857645685;11179.490768746278;11349.375784331942;3246.788958717699;3261.528071586769;3275.8034517928763;3283.4910588858766;3335.2162241873384;51609.48390516084;52542.47457525414;54124;60624.696876515336;71299;10004.149647279917;10408.739781505523;10446.947765261126;10949.890501095046;10950.233483656068;19424.417267481997;19425.51436214106;19451.513712157026;19467.707984380246;19900.303489378093;6905.654717264117;7014.824629384306;7183.209846916835;7202.315780000891;7229.963850180716;3720.720945929066;3726.142987112979;3740.382836831947;3746.456763769238;3754;2722.632444619951;2823.661160660734;3186.745060395163;3378.44255697812;3379.036974462316;537.4625374625375;547.5428017605265;549.3929208224934;565.203063680209;569.6354333226739;541.886203897186;563.1637019026742;571.4770137583293;593.7684303121786;620.4571000374672;7972.521648701097;8147.75556733299;8280.917190828135;8295;8305.709300174465;494.9951598255547;520.1599416941611;549.3407910507327;558.1404636859272;561.9768832204032;3895.7857317847793;3927.7250592458254;4067.2272268268935;4072.7759973201164;4155.833766649361;68897;104139;104819.47590262152;107134;107459;53674.73162634162;55842;93307.53346233226;93616.53191733998;96166.51916740372;82800;83643;83984.58007709922;84467;84992;7606.657700403606;7787.961060194662;7913.723019694283;7930.920690793018;8072.959635201786;46714;47053;47292.7635361821;47817.76091119522;48275.51724482851;54167.72916135394;56054;56158;58760;58860;10771.461426928465;11695.941520292345;11812.291262523931;12080.736417594057;12193.756124877631;12380.876191237972;13192.472301107848;13243.271620060988;13862.168269903837;14315.427382904983;11970.461329240032;12018.459169337226;12268.141230113806;12511.499540018662;12682.239065656091;12028.75942481163;12183.878161218274;12632.747345052863;12742.49030038788;12841.614751557468;12392.442340094538;12435;12655.87344126547;12663.366831658564;13309.334533273104;10197.847032294374;10252.282340236112;10715.946420267848;11079.889201108208;11276.887231127585;10316.638917637847;10319.174466042849;10620.375527090571;10699.465026748787;10761.946190268998 11:07:46 INFO - PROCESS | 4032 | __end_tp_report 11:07:46 INFO - PROCESS | 4032 | __start_cc_report 11:07:46 INFO - PROCESS | 4032 | _x_x_mozilla_cycle_collect,391 11:07:46 INFO - PROCESS | 4032 | __end_cc_report 11:07:46 INFO - PROCESS | 4032 | __startTimestamp1470420466093__endTimestamp 11:07:46 INFO - PROCESS | 4032 | 11:07:46 INFO - PROCESS | 4032 | ------- Summary: start ------- 11:07:46 INFO - PROCESS | 4032 | Number of tests: 6 11:07:46 INFO - PROCESS | 4032 | 11:07:46 INFO - PROCESS | 4032 | [#0] dojo.html Cycles:165 Average:4847.93 Median:4902.19 stddev:532.45 (10.9%) stddev-sans-first:504.91 11:07:46 INFO - PROCESS | 4032 | Values: 2632.1 2642.7 2667.0 2674.3 2687.0 4782.4 4877.1 4898.6 4902.2 4954.2 4752.7 4836.7 4838.3 4888.3 4922.9 4356.5 4408.1 4422.1 4455.4 4522.2 4480.1 4506.6 4522.3 4534.9 4568.2 4357.2 4375.6 4446.3 4483.2 4512.7 4480.4 4505.5 4512.2 4537.3 4538.8 4431.4 4443.6 4450.0 4473.5 4486.4 4713.4 4782.6 4836.3 4848.1 4871.2 5248.4 5252.6 5254.4 5257.6 5286.7 5275.3 5276.3 5291.2 5293.5 5367.6 4777.9 4888.3 4928.7 4934.3 4938.3 5418.7 5424.4 5426.1 5483.4 5491.5 5172.9 5180.8 5195.3 5196.9 5261.9 5030.9 5231.9 5278.8 5295.6 5301.5 5267.1 5271.0 5293.6 5296.7 5314.2 5270.8 5277.3 5279.9 5292.7 5308.7 4373.1 4498.1 4522.7 4569.0 4569.7 3922.9 3933.1 3960.8 3964.9 3987.6 4475.1 4487.3 4498.2 4502.8 4527.9 5076.2 5192.7 5258.5 5306.0 5325.6 4448.3 4470.0 4491.2 4497.3 4508.3 4745.2 4752.1 4755.3 4773.8 4789.1 4694.6 4760.9 4809.4 4864.8 4881.7 5260.8 5284.3 5286.7 5313.1 5333.3 4813.2 4834.5 4844.1 4850.3 4899.4 5043.0 5171.6 5187.6 5212.9 5238.5 5338.5 5357.5 5360.5 5368.7 5382.7 5162.4 5171.4 5178.1 5212.9 5260.1 4989.9 5127.5 5133.1 5182.9 5208.8 5034.3 5057.9 5067.6 5088.9 5110.9 5228.2 5228.4 5244.0 5256.8 5277.2 4759.5 4891.0 4892.0 5091.7 5126.1 11:07:46 INFO - PROCESS | 4032 | 11:07:46 INFO - PROCESS | 4032 | [#1] ext.html Cycles:180 Average:47708.05 Median:35775.96 stddev:88309.73 (246.8%) stddev-sans-first:88486.43 11:07:46 INFO - PROCESS | 4032 | Values: 532.8 548.1 553.1 564.0 580.2 35138.3 39121.4 39185.0 39380.4 39381.4 38613.8 39283.0 39329.6 39406.0 39439.2 7611.2 7732.7 7760.0 7771.5 7781.6 7733.9 7755.6 7780.2 7781.4 7796.1 7821.0 7826.3 7834.5 7846.3 7871.3 7812.8 7813.8 7849.8 7865.6 7874.3 7695.1 7718.0 7734.7 7814.0 7814.5 36436.3 36631.6 36712.3 36833.6 36835.4 2509.4 2938.1 2977.9 3152.1 3169.0 27633.6 27878.4 27983.4 28104.0 28690.9 2766.1 3202.3 3267.2 3277.9 3319.9 214359.0 262941.0 263157.0 263471.0 263722.0 55312.7 55362.7 55881.0 56363.0 56429.7 32925.5 33450.0 34157.3 35347.8 35385.0 15174.2 15264.2 15368.0 15407.8 15408.5 11570.4 11639.1 11657.9 11696.5 11714.2 18015.7 18090.6 18122.9 18162.5 18213.8 6689.8 6719.6 7053.8 7131.3 7199.0 820.8 898.5 906.4 926.4 986.8 27836.7 28045.6 28353.6 29075.3 29095.6 957.2 990.7 995.7 1019.4 1083.4 14862.2 15081.0 15208.4 15217.6 15304.8 390770.0 396413.0 397347.0 398100.0 398310.0 48814.3 49210.0 49267.5 49325.0 49486.3 1152.8 1159.5 1165.1 1177.0 1199.9 26546.9 27647.3 27826.3 28093.6 28166.3 41318.8 42248.6 42254.0 42307.4 42414.4 337094.0 339007.0 339677.0 339918.0 339949.0 25028.7 25146.6 25177.9 25455.0 25516.1 41332.6 41657.8 41747.4 42683.8 42887.1 35362.6 35641.1 35910.8 35983.6 36284.6 35379.8 35978.1 36275.5 36386.8 36470.1 35089.0 35300.6 35472.8 35538.5 35620.0 30749.0 32763.3 32885.5 33222.8 33248.3 25212.2 25422.7 25476.0 25635.1 25837.9 11:07:46 INFO - PROCESS | 4032 | 11:07:46 INFO - PROCESS | 4032 | [#2] jquery.html Cycles:180 Average:25597.90 Median:4436.52 stddev:69632.85 (1569.5%) stddev-sans-first:69802.41 11:07:46 INFO - PROCESS | 4032 | Values: 366.9 374.2 378.3 380.8 391.6 16281.1 16728.4 17684.6 17835.6 17840.9 16758.3 17253.6 17383.1 17684.6 18109.8 4559.6 4762.3 4764.4 4770.3 4775.5 4535.1 4639.4 4692.1 4708.7 4710.7 4736.9 4740.1 4740.3 4743.9 4750.0 4725.6 4740.5 4743.4 4757.1 5829.2 5392.7 5481.3 5485.5 5498.6 5498.7 11698.7 11791.6 18731.9 21699.2 21757.6 1909.3 1913.2 1989.1 2101.5 2268.9 8784.0 8987.3 9261.9 9400.2 12885.7 1677.8 1692.4 1708.5 1714.7 1714.7 70092.0 70136.0 70448.3 71673.0 72894.6 9800.0 9991.6 10150.8 10439.6 10591.6 13985.1 14100.9 14138.4 14146.5 14199.1 7287.7 7290.1 7475.4 7475.4 7492.1 6943.6 7019.8 7072.7 7079.9 7368.1 4384.9 4434.4 4435.3 4437.8 4581.4 1839.5 1845.4 1845.6 1857.2 1865.1 830.5 854.5 867.2 871.4 893.6 16869.8 17745.0 17868.7 17931.2 18192.3 854.9 877.0 879.6 902.0 916.9 8627.7 9502.0 10058.8 10070.9 10118.6 408566.0 409115.0 425543.0 427064.0 434336.0 81583.0 84347.2 85380.8 86486.0 86669.1 919.5 925.8 950.0 964.2 970.2 16448.8 16722.7 16948.3 16980.2 17180.4 29076.0 38804.2 39021.0 40924.2 41986.4 55754.2 56297.0 57047.7 57268.0 57577.7 7494.4 7552.8 7646.8 7753.6 7787.8 8656.4 11992.9 12262.9 12291.3 12300.9 10356.7 10419.9 10477.2 10691.8 10711.6 7242.6 10252.7 10320.8 10473.7 10636.8 9570.3 10548.7 10586.2 10807.7 10865.1 6416.7 6726.8 6769.3 7556.1 7804.1 9778.3 10232.6 10447.9 10792.9 11066.1 11:07:46 INFO - PROCESS | 4032 | 11:07:46 INFO - PROCESS | 4032 | [#3] mootools.html Cycles:180 Average:5038.24 Median:4887.67 stddev:2899.81 (59.3%) stddev-sans-first:2894.76 11:07:46 INFO - PROCESS | 4032 | Values: 1357.6 1392.4 1445.8 1639.7 1640.9 6714.7 7373.3 7446.9 7963.5 7966.8 7582.0 7851.7 7856.5 7868.7 7873.0 2088.0 2124.4 2127.1 2133.2 2136.2 2051.9 2101.8 2124.4 2134.1 2142.1 2096.2 2097.6 2109.7 2118.1 2126.6 2069.1 2071.4 2081.5 2084.2 2090.1 2046.9 2082.8 2088.1 2091.4 2094.5 7629.9 7675.9 7676.2 7725.7 7726.0 4322.3 4434.8 4436.0 4484.9 4486.0 2740.5 2788.2 2855.3 2856.6 2858.8 845.5 891.3 893.2 905.8 907.8 10497.1 10512.1 10518.5 10575.9 10628.9 3835.5 3972.7 4039.9 4051.8 4094.6 9073.5 9080.9 9083.7 9083.8 9085.0 4569.6 4580.4 4584.4 4593.7 4600.2 3517.2 3999.5 4116.2 4137.6 4155.9 3581.8 3649.7 3691.0 3701.5 3781.0 1123.3 1128.3 1183.1 1184.0 1188.2 761.9 763.7 767.6 780.9 825.4 4883.9 4891.4 4915.5 4921.0 5128.6 374.6 375.0 376.4 380.6 389.4 3186.4 3270.1 3277.3 3307.6 3353.8 9146.2 9443.2 9541.6 9571.9 9575.0 9478.0 9541.6 9549.5 9560.7 9583.7 7345.6 7357.7 7377.8 7422.3 7445.5 4909.3 4973.5 4977.2 4982.7 4983.1 8948.1 8975.1 8977.3 8989.7 9118.1 8895.1 9124.0 9134.0 9179.6 9180.3 5736.5 6258.2 6479.8 6607.1 6681.7 7437.4 7437.9 7500.4 7518.8 7523.4 6642.1 6767.2 6770.2 6813.7 6874.2 6615.0 6654.7 6749.4 6772.6 6801.8 5990.4 6047.2 6050.7 6060.5 6062.9 4372.1 4379.6 4449.7 4460.6 4485.7 4470.1 4518.7 4572.8 4578.6 4696.0 11:07:46 INFO - PROCESS | 4032 | 11:07:46 INFO - PROCESS | 4032 | [#4] prototype.html Cycles:180 Average:4409.25 Median:5047.94 stddev:1280.81 (25.4%) stddev-sans-first:1246.67 11:07:46 INFO - PROCESS | 4032 | Values: 297.9 300.7 305.0 306.4 307.5 5067.3 5130.8 5147.7 5150.6 5166.5 5004.3 5031.5 5034.8 5039.2 5052.4 3762.8 3852.4 3899.5 3920.8 3968.0 3911.6 3921.9 3926.4 3932.2 3979.0 3901.1 3902.9 3963.3 3975.1 3978.6 3856.2 3939.2 3968.0 3972.6 3980.1 3451.3 3456.5 3460.0 3462.8 3503.6 4869.9 4891.5 4893.4 4911.5 4931.4 4412.8 4516.4 4539.3 4557.1 4575.4 5233.7 5258.5 5267.3 5282.9 5292.7 3828.8 3829.8 3838.6 3849.8 3864.8 5456.7 5586.8 5598.4 5613.1 5625.6 3871.7 3879.3 3897.0 3899.0 3911.9 3945.1 3946.1 3953.9 3975.1 3988.5 4500.9 4501.3 4507.3 4540.8 4562.6 5079.7 5283.5 5302.7 5321.5 5396.6 1359.5 1383.5 1384.3 1391.1 1392.2 837.8 873.4 880.9 893.9 906.7 4349.4 4477.0 4589.2 4608.9 4618.7 5510.6 5516.2 5531.4 5533.4 5542.4 4607.8 4609.4 4612.6 4613.2 4614.0 2787.5 2913.7 2919.7 2932.4 2956.1 5052.3 5066.1 5137.7 5140.5 5154.2 5346.3 5664.8 5670.5 5687.8 5701.1 5052.4 5053.7 5054.5 5084.4 5105.6 5544.0 5548.4 5562.5 5590.4 5608.6 5223.6 5416.4 5420.3 5432.7 5453.6 5043.6 5069.7 5090.5 5092.6 5109.8 3959.9 3993.0 3995.9 4012.0 4015.0 5285.0 5494.1 5501.7 5517.6 5562.9 5263.9 5270.5 5292.1 5298.8 5299.2 5260.3 5280.4 5291.2 5312.7 5317.8 4915.0 5172.8 5174.5 5176.6 5192.4 5111.1 5223.2 5330.7 5331.8 5333.8 5222.8 5230.2 5238.5 5239.8 5243.2 11:07:46 INFO - PROCESS | 4032 | 11:07:46 INFO - PROCESS | 4032 | [#5] yui.html Cycles:180 Average:17956.39 Median:3997.48 stddev:25579.56 (639.9%) stddev-sans-first:25618.12 11:07:46 INFO - PROCESS | 4032 | Values: 599.0 599.9 641.6 646.4 694.3 13276.0 14295.7 14422.8 14426.8 14446.5 13444.7 13549.7 13719.5 14293.2 14454.1 779.5 800.8 801.2 802.2 802.4 626.8 767.5 788.2 789.3 794.6 820.3 820.4 821.2 823.4 829.5 816.3 819.4 823.0 823.1 825.9 598.6 599.8 601.4 602.3 603.6 13496.5 13526.0 13558.7 13567.2 13575.1 12850.4 13163.5 13218.3 13256.9 13422.6 10767.0 10955.0 11028.6 11179.5 11349.4 3246.8 3261.5 3275.8 3283.5 3335.2 51609.5 52542.5 54124.0 60624.7 71299.0 10004.1 10408.7 10446.9 10949.9 10950.2 19424.4 19425.5 19451.5 19467.7 19900.3 6905.7 7014.8 7183.2 7202.3 7230.0 3720.7 3726.1 3740.4 3746.5 3754.0 2722.6 2823.7 3186.7 3378.4 3379.0 537.5 547.5 549.4 565.2 569.6 541.9 563.2 571.5 593.8 620.5 7972.5 8147.8 8280.9 8295.0 8305.7 495.0 520.2 549.3 558.1 562.0 3895.8 3927.7 4067.2 4072.8 4155.8 68897.0 104139.0 104819.5 107134.0 107459.0 53674.7 55842.0 93307.5 93616.5 96166.5 82800.0 83643.0 83984.6 84467.0 84992.0 7606.7 7788.0 7913.7 7930.9 8073.0 46714.0 47053.0 47292.8 47817.8 48275.5 54167.7 56054.0 56158.0 58760.0 58860.0 10771.5 11695.9 11812.3 12080.7 12193.8 12380.9 13192.5 13243.3 13862.2 14315.4 11970.5 12018.5 12268.1 12511.5 12682.2 12028.8 12183.9 12632.7 12742.5 12841.6 12392.4 12435.0 12655.9 12663.4 13309.3 10197.8 10252.3 10715.9 11079.9 11276.9 10316.6 10319.2 10620.4 10699.5 10761.9 11:07:46 INFO - PROCESS | 4032 | -------- Summary: end -------- 11:07:46 INFO - PROCESS | 4032 | 11:07:46 INFO - TEST-INFO | 4032: exit 0 11:07:46 INFO - TEST-OK | dromaeo_css | took 1117548ms 11:07:46 INFO - TEST-START | kraken 11:07:46 INFO - operating with platform_type : linux_ 11:07:46 INFO - Initialising browser for kraken test... 11:07:46 INFO - TEST-INFO | started process 4386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbaves/profile http://localhost:57304/getInfo.html) 11:07:51 INFO - PROCESS | 4386 | __metrics Screen width/height:1600/1200 11:07:51 INFO - PROCESS | 4386 | colorDepth:24 11:07:51 INFO - PROCESS | 4386 | Browser inner width/height: 1024/697 11:07:51 INFO - PROCESS | 4386 | __metrics 11:07:52 ERROR - PROCESS | 4386 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:07:53 INFO - TEST-INFO | 4386: exit 0 11:07:53 INFO - Browser initialized. 11:07:53 INFO - Running cycle 1/1 for kraken test... 11:07:53 INFO - TEST-INFO | started process 4505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbaves/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:05 INFO - PROCESS | 4505 | RSS: Main: 164954112 11:08:05 INFO - PROCESS | 4505 | 11:08:07 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57304/tests/kraken/driver.html?testName=audio-beat-detection) 11:08:08 INFO - PROCESS | 4505 | RSS: Main: 169791488 11:08:08 INFO - PROCESS | 4505 | 11:08:11 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57304/tests/kraken/driver.html?testName=audio-dft) 11:08:12 INFO - PROCESS | 4505 | RSS: Main: 169324544 11:08:12 INFO - PROCESS | 4505 | 11:08:15 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57304/tests/kraken/driver.html?testName=audio-fft) 11:08:15 INFO - PROCESS | 4505 | RSS: Main: 166195200 11:08:15 INFO - PROCESS | 4505 | 11:08:18 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57304/tests/kraken/driver.html?testName=audio-oscillator) 11:08:18 INFO - PROCESS | 4505 | RSS: Main: 166019072 11:08:18 INFO - PROCESS | 4505 | 11:08:20 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:08:21 INFO - PROCESS | 4505 | RSS: Main: 166404096 11:08:21 INFO - PROCESS | 4505 | 11:08:24 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57304/tests/kraken/driver.html?testName=imaging-darkroom) 11:08:25 INFO - PROCESS | 4505 | RSS: Main: 167067648 11:08:25 INFO - PROCESS | 4505 | 11:08:29 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57304/tests/kraken/driver.html?testName=imaging-desaturate) 11:08:29 INFO - PROCESS | 4505 | RSS: Main: 163962880 11:08:29 INFO - PROCESS | 4505 | 11:08:32 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57304/tests/kraken/driver.html?testName=json-parse-financial) 11:08:33 INFO - PROCESS | 4505 | RSS: Main: 166109184 11:08:33 INFO - PROCESS | 4505 | 11:08:34 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:08:35 INFO - PROCESS | 4505 | RSS: Main: 165904384 11:08:35 INFO - PROCESS | 4505 | 11:08:37 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57304/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:08:38 INFO - PROCESS | 4505 | RSS: Main: 166211584 11:08:38 INFO - PROCESS | 4505 | 11:08:40 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:08:41 INFO - PROCESS | 4505 | RSS: Main: 166703104 11:08:41 INFO - PROCESS | 4505 | 11:08:43 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:08:44 INFO - PROCESS | 4505 | RSS: Main: 167366656 11:08:44 INFO - PROCESS | 4505 | 11:08:47 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:08:48 INFO - PROCESS | 4505 | RSS: Main: 167297024 11:08:48 INFO - PROCESS | 4505 | 11:08:49 INFO - PROCESS | 4505 | Cycle 1(1): loaded http://localhost:57304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57304/tests/kraken/driver.html?testName=ai-astar) 11:08:50 INFO - PROCESS | 4505 | RSS: Main: 167997440 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | __start_tp_report 11:08:50 INFO - PROCESS | 4505 | _x_x_mozilla_page_load 11:08:50 INFO - PROCESS | 4505 | _x_x_mozilla_page_load_details 11:08:50 INFO - PROCESS | 4505 | |i|pagename|runs| 11:08:50 INFO - PROCESS | 4505 | |0;ai-astar;106;116;111;115;116;116;117;115;116;115 11:08:50 INFO - PROCESS | 4505 | |1;audio-beat-detection;150;124;144;186;124;149;155;124;193;123 11:08:50 INFO - PROCESS | 4505 | |2;audio-dft;163;169;165;175;164;164;162;164;162;162 11:08:50 INFO - PROCESS | 4505 | |3;audio-fft;75;75;77;172;77;76;76;76;169;77 11:08:50 INFO - PROCESS | 4505 | |4;audio-oscillator;86;86;153;86;85;85;139;86;85;147 11:08:50 INFO - PROCESS | 4505 | |5;imaging-gaussian-blur;118;119;118;119;120;119;118;118;118;118 11:08:50 INFO - PROCESS | 4505 | |6;imaging-darkroom;149;149;148;148;151;149;148;148;150;147 11:08:50 INFO - PROCESS | 4505 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;95;95 11:08:50 INFO - PROCESS | 4505 | |8;json-parse-financial;67;64;64;63;64;63;63;64;63;65 11:08:50 INFO - PROCESS | 4505 | |9;json-stringify-tinderbox;66;66;67;66;66;66;67;67;66;67 11:08:50 INFO - PROCESS | 4505 | |10;stanford-crypto-aes;81;85;80;81;81;82;83;86;85;81 11:08:50 INFO - PROCESS | 4505 | |11;stanford-crypto-ccm;134;135;140;138;134;135;132;143;150;131 11:08:50 INFO - PROCESS | 4505 | |12;stanford-crypto-pbkdf2;167;173;170;168;170;170;169;166;166;166 11:08:50 INFO - PROCESS | 4505 | |13;stanford-crypto-sha256-iterative;67;68;71;68;68;67;70;72;70;68 11:08:50 INFO - PROCESS | 4505 | __end_tp_report 11:08:50 INFO - PROCESS | 4505 | __start_cc_report 11:08:50 INFO - PROCESS | 4505 | _x_x_mozilla_cycle_collect,965 11:08:50 INFO - PROCESS | 4505 | __end_cc_report 11:08:50 INFO - PROCESS | 4505 | __startTimestamp1470420530137__endTimestamp 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | ------- Summary: start ------- 11:08:50 INFO - PROCESS | 4505 | Number of tests: 14 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#0] ai-astar Cycles:10 Average:114.30 Median:116.00 stddev:3.33 (2.9%) stddev-sans-first:1.72 11:08:50 INFO - PROCESS | 4505 | Values: 106.0 116.0 111.0 115.0 116.0 116.0 117.0 115.0 116.0 115.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:149.50 stddev:25.57 (17.1%) stddev-sans-first:27.10 11:08:50 INFO - PROCESS | 4505 | Values: 150.0 124.0 144.0 186.0 124.0 149.0 155.0 124.0 193.0 123.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.08 (2.5%) stddev-sans-first:4.27 11:08:50 INFO - PROCESS | 4505 | Values: 163.0 169.0 165.0 175.0 164.0 164.0 162.0 164.0 162.0 162.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:39.81 (52.4%) stddev-sans-first:41.56 11:08:50 INFO - PROCESS | 4505 | Values: 75.0 75.0 77.0 172.0 77.0 76.0 76.0 76.0 169.0 77.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:85.50 stddev:29.54 (34.5%) stddev-sans-first:30.62 11:08:50 INFO - PROCESS | 4505 | Values: 86.0 86.0 153.0 86.0 85.0 85.0 139.0 86.0 85.0 147.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 11:08:50 INFO - PROCESS | 4505 | Values: 118.0 119.0 118.0 119.0 120.0 119.0 118.0 118.0 118.0 118.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 11:08:50 INFO - PROCESS | 4505 | Values: 149.0 149.0 148.0 148.0 151.0 149.0 148.0 148.0 150.0 147.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:08:50 INFO - PROCESS | 4505 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:1.25 (1.9%) stddev-sans-first:0.71 11:08:50 INFO - PROCESS | 4505 | Values: 67.0 64.0 64.0 63.0 64.0 63.0 63.0 64.0 63.0 65.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 11:08:50 INFO - PROCESS | 4505 | Values: 66.0 66.0 67.0 66.0 66.0 66.0 67.0 67.0 66.0 67.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:2.12 (2.6%) stddev-sans-first:2.18 11:08:50 INFO - PROCESS | 4505 | Values: 81.0 85.0 80.0 81.0 81.0 82.0 83.0 86.0 85.0 81.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.50 stddev:5.79 (4.2%) stddev-sans-first:6.02 11:08:50 INFO - PROCESS | 4505 | Values: 134.0 135.0 140.0 138.0 134.0 135.0 132.0 143.0 150.0 131.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.50 stddev:2.32 (1.4%) stddev-sans-first:2.40 11:08:50 INFO - PROCESS | 4505 | Values: 167.0 173.0 170.0 168.0 170.0 170.0 169.0 166.0 166.0 166.0 11:08:50 INFO - PROCESS | 4505 | 11:08:50 INFO - PROCESS | 4505 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.73 (2.5%) stddev-sans-first:1.69 11:08:50 INFO - PROCESS | 4505 | Values: 67.0 68.0 71.0 68.0 68.0 67.0 70.0 72.0 70.0 68.0 11:08:50 INFO - PROCESS | 4505 | -------- Summary: end -------- 11:08:50 INFO - PROCESS | 4505 | 11:08:51 INFO - TEST-INFO | 4505: exit 0 11:08:51 INFO - TEST-OK | kraken | took 64336ms 11:08:51 INFO - SUITE-END | took 1181s 11:08:51 INFO - Completed test suite (00:19:41) 11:08:51 INFO - javascript benchmark 11:08:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6459.170965124057, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.0656167060692, 2642.656454660894, 2666.9999999999995, 2674.2913128021078, 2686.973130268697, 4782.378290822188, 4877.146499362615, 4898.632602554805, 4902.1911384621535, 4954.207326827708, 4752.691075080117, 4836.685615434994, 4838.34682317887, 4888.340074089997, 4922.852314430564, 4356.5425630308755, 4408.074304396065, 4422.093470838487, 4455.398521199629, 4522.2312206924735, 4480.103979204156, 4506.571875671806, 4522.29904364824, 4534.8866278342975, 4568.177728008957, 4357.237483440385, 4375.584319489675, 4446.288593825005, 4483.193025255453, 4512.661550383701, 4480.350349199381, 4505.549445055501, 4512.187806194884, 4537.342085397632, 4538.818447262105, 4431.423914891076, 4443.644508439317, 4449.977750111261, 4473.4855491618555, 4486.416765820422, 4713.410823647044, 4782.641301902337, 4836.347093142416, 4848.0788650156355, 4871.196252618313, 5248.422673505911, 5252.553532949704, 5254.369475662945, 5257.553107985826, 5286.735663216824, 5275.261463395128, 5276.261323414725, 5291.206319052135, 5293.523582877559, 5367.624266301361, 4777.856664300077, 4888.291197776302, 4928.654994150375, 4934.3338649282605, 4938.308636790852, 5418.729063546807, 5424.376196737347, 5426.131818908955, 5483.396826349099, 5491.450854914477, 5172.8965420691375, 5180.766865491062, 5195.2986346843445, 5196.882670225919, 5261.894762104736, 5030.949690503048, 5231.947680523146, 5278.788848446096, 5295.629305948623, 5301.522862942354, 5267.051930652443, 5271.0, 5293.602979776455, 5296.682199067991, 5314.229436731653, 5270.815521456807, 5277.261183434322, 5279.894402111936, 5292.655977361459, 5308.681479111188, 4373.059792144704, 4498.122866041091, 4522.706024108423, 4569.017661202857, 4569.748663823455, 3922.86269980555, 3933.1347103637154, 3960.821763020671, 3964.8810535683974, 3987.5813039631003, 4475.060237350128, 4487.28203487447, 4498.190325741332, 4502.774861256924, 4527.864164075083, 5076.238564215323, 5192.714400707997, 5258.50044245796, 5305.973470132624, 5325.573954083664, 4448.310511870665, 4470.0, 4491.214037543482, 4497.280435130363, 4508.301213311942, 4745.217039188564, 4752.097101550694, 4755.262934245197, 4773.76131193439, 4789.066132104206, 4694.64790140734, 4760.9047819042735, 4809.44691360498, 4864.80540778372, 4881.707097574157, 5260.763265652979, 5284.339457567804, 5286.656367336111, 5313.123334649739, 5333.306670132858, 4813.181759101031, 4834.540718631724, 4844.079624871263, 4850.296706977398, 4899.363082799213, 5042.974785126051, 5171.63798534099, 5187.559057480156, 5212.895742085213, 5238.476152384731, 5338.54622357104, 5357.491038351351, 5360.517553420211, 5368.7047212403695, 5382.67703937765, 5162.354705661793, 5171.3535808024, 5178.0679477694375, 5212.895742085213, 5260.105782017143, 4989.850304490871, 5127.53852153308, 5133.127368347465, 5182.922256166085, 5208.791648334176, 5034.345535080416, 5057.8735531612, 5067.594592432671, 5088.872778180576, 5110.948890511196, 5228.189630607262, 5228.398734145622, 5244.003639308519, 5256.78972841082, 5277.20841873722, 4759.524047595212, 4891.0, 4892.0, 5091.745412729423, 5126.128558145198], "value": 4812.28373965349, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.8321578702709, 548.0846985534155, 553.1094937151186, 563.9566801417378, 580.2398857496677, 35138.29723405534, 39121.413178802344, 39184.99999999996, 39380.40929386061, 39381.40927886084, 38613.80693096537, 39283.0, 39329.60670393295, 39406.0, 39439.211215775664, 7611.162772095079, 7732.652030658605, 7760.0, 7771.455998080137, 7781.610919454005, 7733.922660773376, 7755.612219389036, 7780.221977802203, 7781.3774898008305, 7796.064472263308, 7821.0, 7826.256505631955, 7834.451588388815, 7846.254605812467, 7871.252231038042, 7812.765617031499, 7813.804654883616, 7849.8037549061155, 7865.6067196640515, 7874.251946065143, 7695.076590809139, 7718.0, 7734.690612375498, 7814.023247094114, 7814.492058016211, 36436.27127457436, 36631.63368366309, 36712.265754684755, 36833.631663683285, 36835.447468287995, 2509.397744541315, 2938.1038783171125, 2977.865996030184, 3152.1016510294457, 3169.0492852144494, 27633.585496217373, 27878.442431151467, 27983.440331193466, 28104.0, 28690.856545717346, 2766.1286694691307, 3202.343519578481, 3267.1995361136437, 3277.885274015422, 3319.850606722703, 214359.0, 262941.0, 263157.0, 263471.0, 263722.0, 55312.72343638256, 55362.72318638381, 55881.0, 56363.0, 56429.71785141048, 32925.50611740826, 33450.0, 34157.316853662785, 35347.82326088353, 35385.0, 15174.24128793556, 15264.16047117397, 15368.0, 15407.768883466757, 15408.537743867702, 11570.42147892602, 11639.127065470124, 11657.941710291394, 11696.47365868538, 11714.23857449263, 18015.72976405355, 18090.638187236444, 18122.90938545299, 18162.545936351697, 18213.817861821477, 6689.755468597727, 6719.563228390139, 7053.8236544085785, 7131.286871312827, 7199.0, 820.7906983719114, 898.514802006922, 906.4334790755778, 926.4024704065974, 986.7730422002979, 27836.721632783818, 28045.57931631027, 28353.574696379572, 29075.273118172216, 29095.56356654652, 957.2485598804905, 990.7473594233569, 995.746084748399, 1019.4393083803878, 1083.4311986207304, 14862.182579958206, 15081.0, 15208.391664333303, 15217.61955951088, 15304.846951530564, 390770.0, 396413.0, 397347.0, 398100.0, 398310.0, 48814.26778598324, 49210.0, 49267.507324927006, 49325.0, 49486.257706134435, 1152.792497350485, 1159.4550561236206, 1165.1145129701488, 1176.952921883115, 1199.892009719147, 26546.86726566432, 27647.333538687402, 27826.304342391602, 28093.57859632066, 28166.2958426041, 41318.793406032775, 42248.57751422447, 42254.0, 42307.36538951856, 42414.36378454387, 337094.0, 339007.0, 339677.0, 339918.0, 339949.0, 25028.749712502642, 25146.62280065764, 25177.87411062933, 25454.981800727764, 25516.106936257143, 41332.58667413408, 41657.79171104246, 41747.37378939258, 42683.786581066895, 42887.14225715406, 35362.646373535936, 35641.1089722759, 35910.8204458976, 35983.64016359908, 36284.63715362812, 35379.82310088433, 35978.10054748652, 36275.45586816147, 36386.8180659095, 36470.08824779402, 35089.0, 35300.646993529735, 35472.82263588665, 35538.46692299669, 35620.0, 30749.0, 32763.34473310568, 32885.50671739974, 33222.83388583042, 33248.335033299685, 25212.24363269105, 25422.74577254204, 25476.0, 25635.102771403657, 25837.870810645825], "value": 17291.81460075614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.91927775889314, 374.2421596267558, 378.33224359006357, 380.8114983083371, 391.59274354671146, 16281.104539250337, 16728.41450549231, 17684.64630707385, 17835.554111147227, 17840.910795446038, 16758.32966681331, 17253.568660783454, 17383.13084345784, 17684.557886052822, 18109.818901810977, 4559.589636932676, 4762.309465127554, 4764.356811830393, 4770.260609605517, 4775.450823155329, 4535.138323718483, 4639.373684552593, 4692.06158768246, 4708.670393072486, 4710.670253082286, 4736.928946065812, 4740.07568524138, 4740.336352910595, 4743.92884106737, 4749.978754567767, 4725.574698277154, 4740.454847692525, 4743.430788305408, 4757.1437141314545, 5829.183914252008, 5392.703401312926, 5481.260029895953, 5485.451454854522, 5498.615096943216, 5498.697571633558, 11698.707532311675, 11791.587294444738, 18731.906340468347, 21699.240526581492, 21757.564848703096, 1909.284018493065, 1913.2050906163486, 1989.0651393844869, 2101.53766171442, 2268.943276418086, 8784.0, 8987.32595055367, 9261.861072083924, 9400.24798016157, 12885.742285154338, 1677.8406051425095, 1692.3653629888793, 1708.4874537638782, 1714.6827836850223, 1714.68826347844, 70092.0, 70135.99999999949, 70448.2955170452, 71673.0, 72894.63552682256, 9799.951000244953, 9991.601175835389, 10150.847737283946, 10439.582416703399, 10591.563940293776, 13985.090969086978, 14100.85899141016, 14138.43446262138, 14146.504872329419, 14199.14805111676, 7287.672054757549, 7290.088738907637, 7475.43934204926, 7475.439342049368, 7492.100947886289, 6943.61342834121, 7019.824504387431, 7072.681729322193, 7079.92920070803, 7368.115826100902, 4384.934225986613, 4434.423524941737, 4435.2903535434825, 4437.755923424178, 4581.358609794632, 1839.4849442156217, 1845.4094689699436, 1845.6401001804788, 1857.2385322017908, 1865.097600447536, 830.5099991005336, 854.4531499840107, 867.2065060469599, 871.407442938795, 893.5978809535735, 16869.83130168707, 17745.0, 17868.731969020475, 17931.193096310435, 18192.272309107488, 854.9102344253888, 876.9956150219335, 879.5997820991562, 901.9774505637412, 916.8716379706847, 8627.741167764852, 9502.04979502058, 10058.849117263248, 10070.899291007143, 10118.595256189818, 408566.0, 409115.0, 425543.0, 427064.0, 434336.0, 81583.0, 84347.20437580324, 85380.77596222368, 86486.0, 86669.1333086661, 919.5172534419349, 925.842606756853, 949.9525023748785, 964.2093483343731, 970.1947383671536, 16448.75326870074, 16722.749158762384, 16948.32206711767, 16980.23588938476, 17180.39868604593, 29076.0, 38804.22391552097, 39021.0, 40924.1815163701, 41986.37020444757, 55754.16368754391, 56297.0, 57047.71476142593, 57268.0, 57577.71211144085, 7494.400447964259, 7552.773416797505, 7646.8088297793, 7753.612319383896, 7787.844243114992, 8656.39405241627, 11992.880071199177, 12262.877371226174, 12291.262524248574, 12300.87699123033, 10356.741081473023, 10419.94790026045, 10477.214208934209, 10691.786164276826, 10711.64343844353, 7242.565446073252, 10252.692419227435, 10320.793584128125, 10473.68578942633, 10636.84044739345, 9570.282228832726, 10548.736281593021, 10586.206034547593, 10807.729806754895, 10865.130789536975, 6416.711247993758, 6726.7981960541265, 6769.28922463154, 7556.131044929683, 7804.102528209101, 9778.315517913677, 10232.59069637236, 10447.895521044997, 10792.946035270088, 11066.059384952046], "value": 8242.649960537716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.558793392148, 1392.3873495661908, 1445.7614493608555, 1639.6802623488425, 1640.8605268552164, 6714.6978385972625, 7373.262673732631, 7446.888296675541, 7963.522188668677, 7966.84066318674, 7581.962090189541, 7851.685932562691, 7856.528608283507, 7868.685252589889, 7873.0, 2087.958240835186, 2124.4476436126643, 2127.106615221611, 2133.1680644548637, 2136.1882484655807, 2051.8563700540967, 2101.8213451856536, 2124.4370241885913, 2134.1356750516065, 2142.1431427428997, 2096.2348742708955, 2097.64340062189, 2109.7468303803566, 2118.1315660579166, 2126.64910289802, 2069.0689189864547, 2071.420002399323, 2081.490034941434, 2084.1871670048695, 2090.1325949730845, 2046.9385918422472, 2082.7604825445114, 2088.060372832216, 2091.44576687178, 2094.465911192651, 7629.923700763033, 7675.923240767633, 7676.232376762335, 7725.652345644459, 7726.0, 4322.265214913472, 4434.756088415136, 4436.0462500562535, 4484.910301793979, 4486.0355023669745, 2740.5341092014405, 2788.219298596396, 2855.271905664063, 2856.614357061791, 2858.8427636479987, 845.4612605058795, 891.3448615267773, 893.2496702769705, 905.8233644439271, 907.8411278026385, 10497.055265026109, 10512.106470950055, 10518.474076296154, 10575.947120264349, 10628.94685526575, 3835.520559930009, 3972.682185425159, 4039.9192016159514, 4051.797410129541, 4094.61101195386, 9073.45559266446, 9080.909190908007, 9083.727488175366, 9083.772905677411, 9084.954575227082, 4569.565891240327, 4580.404547408815, 4584.404027476474, 4593.701409408378, 4600.171969045604, 3517.2437925846066, 3999.5400528938962, 4116.217918595457, 4137.648299894543, 4155.896102597399, 3581.767185132958, 3649.6897763690386, 3690.963090369062, 3701.4632878232505, 3780.9621903781162, 1123.3203911633507, 1128.2835399521364, 1183.1244878789805, 1183.9940800295944, 1188.1564089496383, 761.8666733321646, 763.7441457111819, 767.6277005652254, 780.8867714181412, 825.3644693585906, 4883.902321953541, 4891.437484689306, 4915.533024362751, 4921.0, 5128.615353848476, 374.5636333671242, 374.9850005999784, 376.38461116074865, 380.62698555415847, 389.3614472265487, 3186.433247312288, 3270.133414645121, 3277.3281477297096, 3307.6361600223954, 3353.832308384571, 9146.2225710814, 9443.244540436748, 9541.570629321697, 9571.856422153673, 9574.95212523933, 9477.952610236905, 9541.570629321697, 9549.474778887228, 9560.665376711782, 9583.712488625353, 7345.55926644403, 7357.675618388741, 7377.77866664001, 7422.331990120915, 7445.516041457288, 4909.337239472626, 4973.52751488608, 4977.178765503796, 4982.701037937735, 4983.103041452573, 8948.105189481, 8975.147361000694, 8977.326700497619, 8989.685361012333, 9118.088191180828, 8895.06601806801, 9124.041975592467, 9134.040925702706, 9179.632814687604, 9180.311476639145, 5736.483716465538, 6258.217722784652, 6479.773207937699, 6607.141071660653, 6681.732730690718, 7437.367823735043, 7437.888431673421, 7500.399968002437, 7518.774436766906, 7523.360514356341, 6642.136522252076, 6767.154105736783, 6770.1537307836525, 6813.727450901908, 6874.243833178446, 6615.0, 6654.700538475683, 6749.392554670103, 6772.627505487246, 6801.761938332333, 5990.430909063632, 6047.153398524122, 6050.667213303311, 6060.515158787198, 6062.939370606237, 4372.103718737588, 4379.562043795595, 4449.710768800018, 4460.576245256695, 4485.663575231805, 4470.105978804318, 4518.728876267434, 4572.81708731647, 4578.5650363215445, 4695.976520117378], "value": 3955.5815087893016, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.90318146602345, 300.69028900232763, 304.9965613132793, 306.44992238931115, 307.50645214430835, 5067.315912351832, 5130.8460746177625, 5147.7426128693505, 5150.562202212807, 5166.483351664831, 5004.324416203812, 5031.496850314967, 5034.798608055673, 5039.168537191368, 5052.393712754465, 3762.75542089764, 3852.4413959975786, 3899.532056153266, 3920.764754114748, 3967.960320396788, 3911.550171730245, 3921.8823435296986, 3926.4110383442426, 3932.233214523169, 3978.9801050994706, 3901.1222474943193, 3902.921941561167, 3963.286608410485, 3975.1254723960683, 3978.562358140602, 3856.1709232514863, 3939.1727737174942, 3968.0476685595536, 3972.582878797728, 3980.144268982183, 3451.32699123671, 3456.5333679953137, 3460.0138960396416, 3462.8441720122655, 3503.597086335053, 4869.8782530436665, 4891.4863939286215, 4893.437254715717, 4911.533404326583, 4931.408231012266, 4412.8085416937565, 4516.435445569304, 4539.319102134673, 4557.134144512565, 4575.382323386367, 5233.665415319069, 5258.474152584749, 5267.315249017642, 5282.9132492665185, 5292.68243905363, 3828.846846126152, 3829.8276577554075, 3838.5777564467885, 3849.8460061597502, 3864.8260828262514, 5456.699881506476, 5586.804461843816, 5598.44015598441, 5613.101903695389, 5625.634333768292, 3871.7483363581277, 3879.282332768447, 3897.0, 3899.0, 3911.882643520699, 3945.1320709443876, 3946.1121247719607, 3953.881383558498, 3975.1453437510495, 3988.484375937125, 4500.887477813016, 4501.279795232747, 4507.278835386388, 4540.79566419512, 4562.634989200856, 5079.6698214615935, 5283.498067683564, 5302.70835104073, 5321.467853214647, 5396.64921780083, 1359.4901911783081, 1383.481194552043, 1384.2732565403041, 1391.1305434103685, 1392.1786146173806, 837.8114924142142, 873.4366333714845, 880.8898887639045, 893.9418937769025, 906.6871929184421, 4349.412829268072, 4477.0, 4589.242774942097, 4608.861734147981, 4618.722876627346, 5510.586705997066, 5516.159178023321, 5531.3915469298345, 5533.391326954032, 5542.445755424425, 4607.792649330788, 4609.400777898852, 4612.630989520897, 4613.169629466728, 4613.95386046142, 2787.5261205595098, 2913.6649285332032, 2919.737223649882, 2932.372533244027, 2956.137633291013, 5052.317937078521, 5066.088104141216, 5137.691738495628, 5140.485951404829, 5154.175331946871, 5346.251524786533, 5664.801731939445, 5670.5180059695385, 5687.772489100473, 5701.144828275709, 5052.418971818214, 5053.69677819332, 5054.508919868647, 5084.41529224144, 5105.570440276729, 5544.002079625706, 5548.361938377138, 5562.527185189304, 5590.413006634245, 5608.635438696471, 5223.634345595924, 5416.350037995466, 5420.349558053059, 5432.701201433801, 5453.590980676386, 5043.562584663353, 5069.746512674278, 5090.516400941905, 5092.592592592658, 5109.824740309824, 3959.891230455477, 3992.9618299241824, 3995.860144894915, 4012.0371110933747, 4014.979925100356, 5285.0, 5494.09347457665, 5501.697406642673, 5517.5585953124455, 5562.9443705564045, 5263.868403289795, 5270.472952704698, 5292.126799078109, 5298.794229491103, 5299.178627312773, 5260.342457192851, 5280.4455532170105, 5291.1798671206025, 5312.707801070978, 5317.760700768552, 4915.0, 5172.818951336685, 5174.456682048331, 5176.611754118381, 5192.428832828461, 5111.080005599028, 5223.197996691136, 5330.706811125426, 5331.760070796746, 5333.7866485340155, 5222.764975576184, 5230.189320655304, 5238.476152384884, 5239.764210610456, 5243.161094224905], "value": 3998.1310050687275, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.9730462129204, 599.9070144127662, 641.5701480008394, 646.3665607704448, 694.2640800751201, 13276.0, 14295.714085718279, 14422.783658245135, 14426.783598246022, 14446.494372696945, 13444.731105377887, 13549.729005419886, 13719.451221951134, 14293.213873236968, 14454.060486068425, 779.4699604269109, 800.8438354520871, 801.1547817053007, 802.2458888644655, 802.4142376065475, 626.786892456567, 767.5202998126172, 788.1960400391597, 789.2975252025702, 794.5788731972063, 820.306840719591, 820.3847114664002, 821.1829229916242, 823.390690888744, 829.4732844643635, 816.3183741575791, 819.4018366592392, 823.0164952881279, 823.1192623892438, 825.9463134896273, 598.6408155106944, 599.8470390050553, 601.4316470934968, 602.256213576233, 603.6438501284264, 13496.527621533298, 13526.0, 13558.661033474144, 13567.1859688419, 13575.117617354841, 12850.421731022127, 13163.53927612529, 13218.272994985273, 13256.86743132566, 13422.597322080353, 10766.962389104086, 10955.0, 11028.558857645685, 11179.490768746278, 11349.375784331942, 3246.788958717699, 3261.528071586769, 3275.8034517928763, 3283.4910588858766, 3335.2162241873384, 51609.48390516084, 52542.47457525414, 54124.0, 60624.696876515336, 71299.0, 10004.149647279917, 10408.739781505523, 10446.947765261126, 10949.890501095046, 10950.233483656068, 19424.417267481997, 19425.51436214106, 19451.513712157026, 19467.707984380246, 19900.303489378093, 6905.654717264117, 7014.824629384306, 7183.209846916835, 7202.315780000891, 7229.963850180716, 3720.720945929066, 3726.142987112979, 3740.382836831947, 3746.456763769238, 3754.0, 2722.632444619951, 2823.661160660734, 3186.745060395163, 3378.44255697812, 3379.036974462316, 537.4625374625375, 547.5428017605265, 549.3929208224934, 565.203063680209, 569.6354333226739, 541.886203897186, 563.1637019026742, 571.4770137583293, 593.7684303121786, 620.4571000374672, 7972.521648701097, 8147.75556733299, 8280.917190828135, 8295.0, 8305.709300174465, 494.9951598255547, 520.1599416941611, 549.3407910507327, 558.1404636859272, 561.9768832204032, 3895.7857317847793, 3927.7250592458254, 4067.2272268268935, 4072.7759973201164, 4155.833766649361, 68897.0, 104139.0, 104819.47590262152, 107134.0, 107459.0, 53674.73162634162, 55842.0, 93307.53346233226, 93616.53191733998, 96166.51916740372, 82800.0, 83643.0, 83984.58007709922, 84467.0, 84992.0, 7606.657700403606, 7787.961060194662, 7913.723019694283, 7930.920690793018, 8072.959635201786, 46714.0, 47053.0, 47292.7635361821, 47817.76091119522, 48275.51724482851, 54167.72916135394, 56054.0, 56158.0, 58760.0, 58860.0, 10771.461426928465, 11695.941520292345, 11812.291262523931, 12080.736417594057, 12193.756124877631, 12380.876191237972, 13192.472301107848, 13243.271620060988, 13862.168269903837, 14315.427382904983, 11970.461329240032, 12018.459169337226, 12268.141230113806, 12511.499540018662, 12682.239065656091, 12028.75942481163, 12183.878161218274, 12632.747345052863, 12742.49030038788, 12841.614751557468, 12392.442340094538, 12435.0, 12655.87344126547, 12663.366831658564, 13309.334533273104, 10197.847032294374, 10252.282340236112, 10715.946420267848, 11079.889201108208, 11276.887231127585, 10316.638917637847, 10319.174466042849, 10620.375527090571, 10699.465026748787, 10761.946190268998], "value": 6694.016154962784, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 111.0, 115.0, 116.0, 116.0, 117.0, 115.0, 116.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 144.0, 186.0, 124.0, 149.0, 155.0, 124.0, 193.0, 123.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 165.0, 175.0, 164.0, 164.0, 162.0, 164.0, 162.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 172.0, 77.0, 76.0, 76.0, 76.0, 169.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 153.0, 86.0, 85.0, 85.0, 139.0, 86.0, 85.0, 147.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 119.0, 120.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 151.0, 149.0, 148.0, 148.0, 150.0, 147.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 80.0, 81.0, 81.0, 82.0, 83.0, 86.0, 85.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 140.0, 138.0, 134.0, 135.0, 132.0, 143.0, 150.0, 131.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 170.0, 168.0, 170.0, 170.0, 169.0, 166.0, 166.0, 166.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 68.0, 68.0, 67.0, 70.0, 72.0, 70.0, 68.0], "value": 68.9, "unit": "score"}]}]} 11:08:51 INFO - Return code: 0 11:08:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:08:51 ERROR - # TBPL SUCCESS # 11:08:51 INFO - Running post-action listener: _resource_record_post_action 11:08:51 INFO - [mozharness: 2016-08-05 18:08:51.438898Z] Finished run-tests step (success) 11:08:51 INFO - Running post-run listener: _resource_record_post_run 11:08:51 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 409755648; Read time: 72; Write time: 251152 11:08:51 INFO - TinderboxPrint: CPU usage
13.3% 11:08:51 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 72 11:08:51 INFO - TinderboxPrint: I/O write bytes / time
409,755,648 / 251,152 11:08:51 INFO - TinderboxPrint: CPU idle
8,284.9 (86.7%) 11:08:51 INFO - TinderboxPrint: CPU user
1,219.4 (12.8%) 11:08:51 INFO - TinderboxPrint: Swap in / out
0 / 0 11:08:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 125247488; Read time: 0; Write time: 71632 11:08:51 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284508160; Read time: 60; Write time: 179520 11:08:52 INFO - Running post-run listener: _upload_blobber_files 11:08:52 INFO - Blob upload gear active. 11:08:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:08:52 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 11:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:08:52 INFO - (blobuploader) - INFO - Open directory for files ... 11:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:08:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:08:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:08:57 INFO - (blobuploader) - INFO - Done attempting. 11:08:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:08:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:08:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:08:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:08:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:08:58 INFO - (blobuploader) - INFO - Done attempting. 11:08:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:08:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:08:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:08:59 INFO - (blobuploader) - INFO - Done attempting. 11:08:59 INFO - (blobuploader) - INFO - Iteration through files over. 11:08:59 INFO - Return code: 0 11:08:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:08:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:08:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b811f312ed7cc6b137de1a140c02c530e714fd189db6fb01017bd9750a152a79192bd24da485904b1557399ba84d42b36ef4178f00d4c3a394d2689d6b297a86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d1d96d961a7891ccf74788c7fa8edf33be6d091b8ffdeefea4fd0aad59969c746c957cfec3fd41a4580b077b1de68fbea483963a37647e6a3748e87cacb8f1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd2b22ba432feea72828324f00124aa009d84e12e45154ad7c58c3165bbe2c433ce94c4a532f884e10cb22ad1bff475652ff89e81ab2d6bab40c3801e52347e7"} 11:08:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:08:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:08:59 INFO - Contents: 11:08:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b811f312ed7cc6b137de1a140c02c530e714fd189db6fb01017bd9750a152a79192bd24da485904b1557399ba84d42b36ef4178f00d4c3a394d2689d6b297a86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d1d96d961a7891ccf74788c7fa8edf33be6d091b8ffdeefea4fd0aad59969c746c957cfec3fd41a4580b077b1de68fbea483963a37647e6a3748e87cacb8f1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd2b22ba432feea72828324f00124aa009d84e12e45154ad7c58c3165bbe2c433ce94c4a532f884e10cb22ad1bff475652ff89e81ab2d6bab40c3801e52347e7"} 11:08:59 INFO - Running post-run listener: copy_logs_to_upload_dir 11:08:59 INFO - Copying logs to upload dir... 11:08:59 INFO - mkdir: /builds/slave/test/build/upload/logs 11:08:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.294502 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-05 11:08:58.991494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:08:58.995402) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b811f312ed7cc6b137de1a140c02c530e714fd189db6fb01017bd9750a152a79192bd24da485904b1557399ba84d42b36ef4178f00d4c3a394d2689d6b297a86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d1d96d961a7891ccf74788c7fa8edf33be6d091b8ffdeefea4fd0aad59969c746c957cfec3fd41a4580b077b1de68fbea483963a37647e6a3748e87cacb8f1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd2b22ba432feea72828324f00124aa009d84e12e45154ad7c58c3165bbe2c433ce94c4a532f884e10cb22ad1bff475652ff89e81ab2d6bab40c3801e52347e7"} build_url:https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b811f312ed7cc6b137de1a140c02c530e714fd189db6fb01017bd9750a152a79192bd24da485904b1557399ba84d42b36ef4178f00d4c3a394d2689d6b297a86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d1d96d961a7891ccf74788c7fa8edf33be6d091b8ffdeefea4fd0aad59969c746c957cfec3fd41a4580b077b1de68fbea483963a37647e6a3748e87cacb8f1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd2b22ba432feea72828324f00124aa009d84e12e45154ad7c58c3165bbe2c433ce94c4a532f884e10cb22ad1bff475652ff89e81ab2d6bab40c3801e52347e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:08:59.025043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:08:59.025621) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470416849.66226-1451152853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:08:59.110743) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:08:59.111346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:08:59.111855) ========= ========= Total master_lag: 0.19 =========