builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1469076854.51 results: success (0) buildid: 20160720211719 builduid: 86b581f21e4b4223b9c4701f6055f8e4 revision: 17409ee90c864e7e982a43e2026e6814a0797e4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:14.513584) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:14.514017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:14.514289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:14.531894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:14.532216) ========= 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=826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 21:54: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.2M=0s 2016-07-20 21:54:15 (31.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088051 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:14.633893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:14.637253) ========= 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=826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019736 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:14.688557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:14.688876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 17409ee90c864e7e982a43e2026e6814a0797e4d --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 17409ee90c864e7e982a43e2026e6814a0797e4d --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=826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 21:54:15,483 truncating revision to first 12 chars 2016-07-20 21:54:15,483 Setting DEBUG logging. 2016-07-20 21:54:15,483 attempt 1/10 2016-07-20 21:54:15,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/17409ee90c86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 21:54:15,798 unpacking tar archive at: fx-team-17409ee90c86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693337 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:15.398751) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:15.402081) ========= script_repo_revision: 17409ee90c864e7e982a43e2026e6814a0797e4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:15.402483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:15.402754) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 21:54:15.413310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-20 21:54:15.413654) ========= /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=826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:54:16 INFO - MultiFileLogger online at 20160720 21:54:16 in /builds/slave/test 21:54: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 21:54:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:54:16 INFO - {'append_to_log': False, 21:54:16 INFO - 'base_work_dir': '/builds/slave/test', 21:54:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:54:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:54:16 INFO - 'branch': 'Fx-Team-Non-PGO', 21:54:16 INFO - 'buildbot_json_path': 'buildprops.json', 21:54:16 INFO - 'config_files': ('talos/linux_config.py',), 21:54:16 INFO - 'default_actions': ('clobber', 21:54:16 INFO - 'read-buildbot-config', 21:54:16 INFO - 'download-and-extract', 21:54:16 INFO - 'populate-webroot', 21:54:16 INFO - 'create-virtualenv', 21:54:16 INFO - 'install', 21:54:16 INFO - 'run-tests'), 21:54:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:54:16 INFO - 'download_minidump_stackwalk': True, 21:54:16 INFO - 'download_symbols': 'ondemand', 21:54:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:54:16 INFO - 'tooltool.py': '/tools/tooltool.py', 21:54:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:54:16 INFO - '/tools/misc-python/virtualenv.py')}, 21:54:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:54:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:54:16 INFO - 'installer_path': 'installer.exe', 21:54:16 INFO - 'log_level': 'info', 21:54:16 INFO - 'log_name': 'talos', 21:54:16 INFO - 'log_to_console': True, 21:54:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:54:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:54:16 INFO - 'opt_config_files': (), 21:54:16 INFO - 'pip_index': False, 21:54:16 INFO - 'sps_profile': False, 21:54:16 INFO - 'sps_profile_interval': 0, 21:54:16 INFO - 'suite': 'dromaeojs-e10s', 21:54:16 INFO - 'system_bits': '32', 21:54:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:54:16 INFO - 'title': 'talos-linux64-ix-052', 21:54:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:54:16 INFO - 'use_talos_json': True, 21:54:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:54:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:54:16 INFO - 'work_dir': 'build'} 21:54:16 INFO - [mozharness: 2016-07-21 04:54:16.292123Z] Running clobber step. 21:54:16 INFO - Running pre-action listener: _resource_record_pre_action 21:54:16 INFO - Running main action method: clobber 21:54:16 INFO - rmtree: /builds/slave/test/build 21:54:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:54:16 INFO - Running post-action listener: _resource_record_post_action 21:54:16 INFO - [mozharness: 2016-07-21 04:54:16.764188Z] Finished clobber step (success) 21:54:16 INFO - [mozharness: 2016-07-21 04:54:16.764289Z] Running read-buildbot-config step. 21:54:16 INFO - Running pre-action listener: _resource_record_pre_action 21:54:16 INFO - Running main action method: read_buildbot_config 21:54:16 INFO - Using buildbot properties: 21:54:16 INFO - { 21:54:16 INFO - "project": "", 21:54:16 INFO - "product": "firefox", 21:54:16 INFO - "script_repo_revision": "production", 21:54:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:54:16 INFO - "repository": "", 21:54:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 21:54:16 INFO - "buildid": "20160720211719", 21:54:16 INFO - "pgo_build": "False", 21:54:16 INFO - "basedir": "/builds/slave/test", 21:54:16 INFO - "buildnumber": 1497, 21:54:16 INFO - "slavename": "talos-linux64-ix-052", 21:54:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:54:16 INFO - "platform": "ubuntu64_hw", 21:54:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:54:16 INFO - "branch": "fx-team", 21:54:16 INFO - "repo_path": "integration/fx-team", 21:54:16 INFO - "revision": "17409ee90c864e7e982a43e2026e6814a0797e4d", 21:54:16 INFO - "stage_platform": "linux64", 21:54:16 INFO - "builduid": "86b581f21e4b4223b9c4701f6055f8e4", 21:54:16 INFO - "slavebuilddir": "test" 21:54:16 INFO - } 21:54:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:54:16 INFO - Running post-action listener: _resource_record_post_action 21:54:16 INFO - [mozharness: 2016-07-21 04:54:16.766754Z] Finished read-buildbot-config step (success) 21:54:16 INFO - [mozharness: 2016-07-21 04:54:16.766897Z] Running download-and-extract step. 21:54:16 INFO - Running pre-action listener: _resource_record_pre_action 21:54:16 INFO - Running main action method: download_and_extract 21:54:16 INFO - mkdir: /builds/slave/test/build/tests 21:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:16 INFO - https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:54:17 INFO - Downloaded 1361 bytes. 21:54:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:54:17 INFO - Using the following test package requirements: 21:54:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:54:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:54:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:54:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:17 INFO - u'jsshell-linux-x86_64.zip'], 21:54:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:54:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:54:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:54:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:54:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:54:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:54:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:17 INFO - https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:54:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:54:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:54:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:54:19 INFO - Downloaded 22772070 bytes. 21:54:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:54:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:54:21 INFO - Return code: 0 21:54:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:21 INFO - https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:54:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:54:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:54:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:54:22 INFO - Downloaded 22772070 bytes. 21:54:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:54:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:54:24 INFO - Return code: 0 21:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:24 INFO - https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:54:24 INFO - Downloaded 14403317 bytes. 21:54:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:54:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:54:25 INFO - Return code: 0 21:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:25 INFO - https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:54:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:54:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:54:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:54:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:54:26 INFO - Downloaded 57114688 bytes. 21:54:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:54:26 INFO - mkdir: /builds/slave/test/properties 21:54:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:54:26 INFO - Writing to file /builds/slave/test/properties/build_url 21:54:26 INFO - Contents: 21:54:26 INFO - build_url:https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:54:27 INFO - Running post-action listener: _resource_record_post_action 21:54:27 INFO - Running post-action listener: set_extra_try_arguments 21:54:27 INFO - [mozharness: 2016-07-21 04:54:27.176612Z] Finished download-and-extract step (success) 21:54:27 INFO - [mozharness: 2016-07-21 04:54:27.176845Z] Running populate-webroot step. 21:54:27 INFO - Running pre-action listener: _resource_record_pre_action 21:54:27 INFO - Running main action method: populate_webroot 21:54:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:54:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:54:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:54:27 INFO - '--tppagecycles', 21:54:27 INFO - '7'], 21:54:27 INFO - 'tests': ['tsvgm']}}, 21:54:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:54:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:54:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:54:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:54:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:27 INFO - 'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:27 INFO - 'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['damp', 'tps']}, 21:54:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:27 INFO - 'tests': ['damp', 'tps']}, 21:54:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['dromaeo_dom']}, 21:54:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:54:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['basic_compositor_video']}, 21:54:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:54:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['a11yr', 21:54:27 INFO - 'ts_paint', 21:54:27 INFO - 'tpaint', 21:54:27 INFO - 'sessionrestore', 21:54:27 INFO - 'sessionrestore_no_auto_restore', 21:54:27 INFO - 'tabpaint']}, 21:54:27 INFO - 'other-e10s': {'tests': ['a11yr', 21:54:27 INFO - 'ts_paint', 21:54:27 INFO - 'tpaint', 21:54:27 INFO - 'sessionrestore', 21:54:27 INFO - 'sessionrestore_no_auto_restore', 21:54:27 INFO - 'tabpaint']}, 21:54:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:54:27 INFO - 'ts_paint', 21:54:27 INFO - 'tpaint', 21:54:27 INFO - 'sessionrestore', 21:54:27 INFO - 'sessionrestore_no_auto_restore', 21:54:27 INFO - 'tabpaint']}, 21:54:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:54:27 INFO - 'ts_paint', 21:54:27 INFO - 'tpaint', 21:54:27 INFO - 'sessionrestore', 21:54:27 INFO - 'sessionrestore_no_auto_restore', 21:54:27 INFO - 'tabpaint']}, 21:54:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['a11yr', 21:54:27 INFO - 'ts_paint', 21:54:27 INFO - 'tpaint', 21:54:27 INFO - 'sessionrestore', 21:54:27 INFO - 'sessionrestore_no_auto_restore', 21:54:27 INFO - 'tabpaint']}, 21:54:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['a11yr', 21:54:27 INFO - 'ts_paint', 21:54:27 INFO - 'tpaint', 21:54:27 INFO - 'sessionrestore', 21:54:27 INFO - 'sessionrestore_no_auto_restore', 21:54:27 INFO - 'tabpaint']}, 21:54:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['tsvgx', 21:54:27 INFO - 'tsvgr_opacity', 21:54:27 INFO - 'tart', 21:54:27 INFO - 'tscrollx', 21:54:27 INFO - 'cart']}, 21:54:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:54:27 INFO - 'tsvgr_opacity', 21:54:27 INFO - 'tart', 21:54:27 INFO - 'tscrollx', 21:54:27 INFO - 'cart']}, 21:54:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:27 INFO - 'talos_options': ['--disable-e10s'], 21:54:27 INFO - 'tests': ['tp5o']}, 21:54:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:27 INFO - 'tests': ['tp5o']}, 21:54:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:27 INFO - 'talos_options': ['--disable-e10s', 21:54:27 INFO - '--xperf_path', 21:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:27 INFO - 'tests': ['tp5n']}, 21:54:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:27 INFO - 'talos_options': ['--xperf_path', 21:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:27 INFO - 'tests': ['tp5n']}}, 21:54:27 INFO - 'talos.zip': {'path': '', 21:54:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:54:27 INFO - Running post-action listener: _resource_record_post_action 21:54:27 INFO - [mozharness: 2016-07-21 04:54:27.196561Z] Finished populate-webroot step (success) 21:54:27 INFO - [mozharness: 2016-07-21 04:54:27.196649Z] Running create-virtualenv step. 21:54:27 INFO - Running pre-action listener: _resource_record_pre_action 21:54:27 INFO - Running main action method: create_virtualenv 21:54:27 INFO - Creating virtualenv /builds/slave/test/build/venv 21:54:27 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 21:54:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:54:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:54:27 INFO - Using real prefix '/usr' 21:54:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:54:27 INFO - Installing distribute.............................................................................................................................................................................................done. 21:54:29 INFO - Installing pip.................done. 21:54:29 INFO - Return code: 0 21:54:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:29 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 0x1c53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, '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': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', '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 21:54:29 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 21:54:29 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 21:54:29 INFO - Using env: {'DISPLAY': ':0', 21:54:29 INFO - 'HOME': '/home/cltbld', 21:54:29 INFO - 'LANG': 'en_US.UTF-8', 21:54:29 INFO - 'LANGUAGE': 'en_US:en', 21:54:29 INFO - 'LOGNAME': 'cltbld', 21:54:29 INFO - 'MAIL': '/var/mail/cltbld', 21:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:29 INFO - 'MOZ_NO_REMOTE': '1', 21:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:29 INFO - 'NO_EM_RESTART': '1', 21:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:29 INFO - 'PWD': '/builds/slave/test', 21:54:29 INFO - 'SHELL': '/bin/bash', 21:54:29 INFO - 'SHLVL': '1', 21:54:29 INFO - 'TERM': 'linux', 21:54:29 INFO - 'TMOUT': '86400', 21:54:29 INFO - 'USER': 'cltbld', 21:54:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:29 INFO - '_': '/tools/buildbot/bin/python'} 21:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:29 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 21:54:29 INFO - Cleaning up... 21:54:29 INFO - Return code: 0 21:54:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:29 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 0x1c53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, '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': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', '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 21:54:29 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 21:54:29 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 21:54:29 INFO - Using env: {'DISPLAY': ':0', 21:54:29 INFO - 'HOME': '/home/cltbld', 21:54:29 INFO - 'LANG': 'en_US.UTF-8', 21:54:29 INFO - 'LANGUAGE': 'en_US:en', 21:54:29 INFO - 'LOGNAME': 'cltbld', 21:54:29 INFO - 'MAIL': '/var/mail/cltbld', 21:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:29 INFO - 'MOZ_NO_REMOTE': '1', 21:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:29 INFO - 'NO_EM_RESTART': '1', 21:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:29 INFO - 'PWD': '/builds/slave/test', 21:54:29 INFO - 'SHELL': '/bin/bash', 21:54:29 INFO - 'SHLVL': '1', 21:54:29 INFO - 'TERM': 'linux', 21:54:29 INFO - 'TMOUT': '86400', 21:54:29 INFO - 'USER': 'cltbld', 21:54:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:29 INFO - '_': '/tools/buildbot/bin/python'} 21:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:30 INFO - Downloading/unpacking psutil>=3.1.1 21:54:30 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 21:54:30 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 21:54:30 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 21:54:30 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 21:54:30 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 21:54:30 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 21:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:54:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:32 INFO - Installing collected packages: psutil 21:54:32 INFO - Running setup.py install for psutil 21:54:32 INFO - building 'psutil._psutil_linux' extension 21:54:32 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 21:54:32 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 21:54:32 INFO - building 'psutil._psutil_posix' extension 21:54:32 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 21:54:32 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 21:54:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:32 INFO - Successfully installed psutil 21:54:32 INFO - Cleaning up... 21:54:32 INFO - Return code: 0 21:54:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:32 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 0x1c53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, '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': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', '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 21:54:32 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 21:54:32 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 21:54:32 INFO - Using env: {'DISPLAY': ':0', 21:54:32 INFO - 'HOME': '/home/cltbld', 21:54:32 INFO - 'LANG': 'en_US.UTF-8', 21:54:32 INFO - 'LANGUAGE': 'en_US:en', 21:54:32 INFO - 'LOGNAME': 'cltbld', 21:54:32 INFO - 'MAIL': '/var/mail/cltbld', 21:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:32 INFO - 'MOZ_NO_REMOTE': '1', 21:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:32 INFO - 'NO_EM_RESTART': '1', 21:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:32 INFO - 'PWD': '/builds/slave/test', 21:54:32 INFO - 'SHELL': '/bin/bash', 21:54:32 INFO - 'SHLVL': '1', 21:54:32 INFO - 'TERM': 'linux', 21:54:32 INFO - 'TMOUT': '86400', 21:54:32 INFO - 'USER': 'cltbld', 21:54:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:32 INFO - '_': '/tools/buildbot/bin/python'} 21:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:54:32 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 21:54:32 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 21:54:32 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 21:54:32 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 21:54:32 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 21:54:32 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 21:54:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:54:34 INFO - Installing collected packages: mozsystemmonitor 21:54:34 INFO - Running setup.py install for mozsystemmonitor 21:54:35 INFO - Successfully installed mozsystemmonitor 21:54:35 INFO - Cleaning up... 21:54:35 INFO - Return code: 0 21:54:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:35 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 0x1c53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, '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': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', '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 21:54:35 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 21:54:35 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 21:54:35 INFO - Using env: {'DISPLAY': ':0', 21:54:35 INFO - 'HOME': '/home/cltbld', 21:54:35 INFO - 'LANG': 'en_US.UTF-8', 21:54:35 INFO - 'LANGUAGE': 'en_US:en', 21:54:35 INFO - 'LOGNAME': 'cltbld', 21:54:35 INFO - 'MAIL': '/var/mail/cltbld', 21:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:35 INFO - 'MOZ_NO_REMOTE': '1', 21:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:35 INFO - 'NO_EM_RESTART': '1', 21:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:35 INFO - 'PWD': '/builds/slave/test', 21:54:35 INFO - 'SHELL': '/bin/bash', 21:54:35 INFO - 'SHLVL': '1', 21:54:35 INFO - 'TERM': 'linux', 21:54:35 INFO - 'TMOUT': '86400', 21:54:35 INFO - 'USER': 'cltbld', 21:54:35 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:35 INFO - '_': '/tools/buildbot/bin/python'} 21:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:35 INFO - Downloading/unpacking jsonschema==2.5.1 21:54:35 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 21:54:35 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 21:54:35 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 21:54:35 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 21:54:35 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 21:54:35 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 21:54:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:54:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:37 INFO - Downloading functools32-3.2.3-2.tar.gz 21:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:54:37 INFO - warning: no files found matching '*.txt' 21:54:37 INFO - no previously-included directories found matching 'build' 21:54:37 INFO - no previously-included directories found matching 'dist' 21:54:37 INFO - no previously-included directories found matching '.git*' 21:54:37 INFO - Installing collected packages: jsonschema, functools32 21:54:37 INFO - Running setup.py install for functools32 21:54:37 INFO - warning: no files found matching '*.txt' 21:54:37 INFO - no previously-included directories found matching 'build' 21:54:37 INFO - no previously-included directories found matching 'dist' 21:54:37 INFO - no previously-included directories found matching '.git*' 21:54:37 INFO - Successfully installed jsonschema functools32 21:54:37 INFO - Cleaning up... 21:54:37 INFO - Return code: 0 21:54:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, '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': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', '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 21:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:54:37 INFO - Using env: {'DISPLAY': ':0', 21:54:37 INFO - 'HOME': '/home/cltbld', 21:54:37 INFO - 'LANG': 'en_US.UTF-8', 21:54:37 INFO - 'LANGUAGE': 'en_US:en', 21:54:37 INFO - 'LOGNAME': 'cltbld', 21:54:37 INFO - 'MAIL': '/var/mail/cltbld', 21:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:37 INFO - 'MOZ_NO_REMOTE': '1', 21:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:37 INFO - 'NO_EM_RESTART': '1', 21:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:37 INFO - 'PWD': '/builds/slave/test', 21:54:37 INFO - 'SHELL': '/bin/bash', 21:54:37 INFO - 'SHLVL': '1', 21:54:37 INFO - 'TERM': 'linux', 21:54:37 INFO - 'TMOUT': '86400', 21:54:37 INFO - 'USER': 'cltbld', 21:54:37 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:37 INFO - '_': '/tools/buildbot/bin/python'} 21:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:37 INFO - Downloading/unpacking blobuploader==1.2.4 21:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:39 INFO - Downloading blobuploader-1.2.4.tar.gz 21:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:54:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:54:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54:40 INFO - Downloading docopt-0.6.1.tar.gz 21:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:54:40 INFO - Installing collected packages: blobuploader, requests, docopt 21:54:40 INFO - Running setup.py install for blobuploader 21:54:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:54:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:54:40 INFO - Running setup.py install for requests 21:54:41 INFO - Running setup.py install for docopt 21:54:41 INFO - Successfully installed blobuploader requests docopt 21:54:41 INFO - Cleaning up... 21:54:41 INFO - Return code: 0 21:54:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:41 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 0x1c53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, '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': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', '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 21:54:41 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 21:54:41 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 21:54:41 INFO - Using env: {'DISPLAY': ':0', 21:54:41 INFO - 'HOME': '/home/cltbld', 21:54:41 INFO - 'LANG': 'en_US.UTF-8', 21:54:41 INFO - 'LANGUAGE': 'en_US:en', 21:54:41 INFO - 'LOGNAME': 'cltbld', 21:54:41 INFO - 'MAIL': '/var/mail/cltbld', 21:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:41 INFO - 'MOZ_NO_REMOTE': '1', 21:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:41 INFO - 'NO_EM_RESTART': '1', 21:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:41 INFO - 'PWD': '/builds/slave/test', 21:54:41 INFO - 'SHELL': '/bin/bash', 21:54:41 INFO - 'SHLVL': '1', 21:54:41 INFO - 'TERM': 'linux', 21:54:41 INFO - 'TMOUT': '86400', 21:54:41 INFO - 'USER': 'cltbld', 21:54:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:41 INFO - '_': '/tools/buildbot/bin/python'} 21:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:54:41 INFO - Running setup.py (path:/tmp/pip-7zsQw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:54:41 INFO - Running setup.py (path:/tmp/pip-6QtSvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:54:41 INFO - Running setup.py (path:/tmp/pip-pTXdLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:54:41 INFO - Running setup.py (path:/tmp/pip-t8781Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:54:41 INFO - Running setup.py (path:/tmp/pip-rTha2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:54:41 INFO - Running setup.py (path:/tmp/pip-vKu2FX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:54:41 INFO - Running setup.py (path:/tmp/pip-KVikN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:54:41 INFO - Running setup.py (path:/tmp/pip-RHXb1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:54:42 INFO - Running setup.py (path:/tmp/pip-y0HFCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:54:42 INFO - Running setup.py (path:/tmp/pip-ynEBs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:54:42 INFO - Running setup.py (path:/tmp/pip-rsUOLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:54:42 INFO - Running setup.py (path:/tmp/pip-KPsknT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:54:42 INFO - Running setup.py (path:/tmp/pip-oNlGCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:54:42 INFO - Running setup.py (path:/tmp/pip-22aq7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:54:42 INFO - Running setup.py (path:/tmp/pip-rcTQFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:54:42 INFO - Running setup.py (path:/tmp/pip-KtpTR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:54:42 INFO - Running setup.py (path:/tmp/pip-tGrjio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:54:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:54:42 INFO - Running setup.py install for manifestparser 21:54:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:54:42 INFO - Running setup.py install for mozcrash 21:54:42 INFO - Running setup.py install for mozdebug 21:54:42 INFO - Running setup.py install for mozdevice 21:54:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Running setup.py install for mozfile 21:54:43 INFO - Running setup.py install for mozhttpd 21:54:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Running setup.py install for mozinfo 21:54:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Running setup.py install for mozInstall 21:54:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Running setup.py install for mozleak 21:54:43 INFO - Running setup.py install for mozlog 21:54:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Running setup.py install for moznetwork 21:54:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Running setup.py install for mozprocess 21:54:43 INFO - Running setup.py install for mozprofile 21:54:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:54:43 INFO - Running setup.py install for mozrunner 21:54:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:54:44 INFO - Running setup.py install for mozscreenshot 21:54:44 INFO - Running setup.py install for moztest 21:54:44 INFO - Running setup.py install for mozversion 21:54:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:54:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:54:44 INFO - Cleaning up... 21:54:44 INFO - Return code: 0 21:54:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:44 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 0x1c53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, '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': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', '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 21:54:44 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 21:54:44 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 21:54:44 INFO - Using env: {'DISPLAY': ':0', 21:54:44 INFO - 'HOME': '/home/cltbld', 21:54:44 INFO - 'LANG': 'en_US.UTF-8', 21:54:44 INFO - 'LANGUAGE': 'en_US:en', 21:54:44 INFO - 'LOGNAME': 'cltbld', 21:54:44 INFO - 'MAIL': '/var/mail/cltbld', 21:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:44 INFO - 'MOZ_NO_REMOTE': '1', 21:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:44 INFO - 'NO_EM_RESTART': '1', 21:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:44 INFO - 'PWD': '/builds/slave/test', 21:54:44 INFO - 'SHELL': '/bin/bash', 21:54:44 INFO - 'SHLVL': '1', 21:54:44 INFO - 'TERM': 'linux', 21:54:44 INFO - 'TMOUT': '86400', 21:54:44 INFO - 'USER': 'cltbld', 21:54:44 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:44 INFO - '_': '/tools/buildbot/bin/python'} 21:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:54:44 INFO - Running setup.py (path:/tmp/pip-P5XurZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:54:44 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)) 21:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:54:44 INFO - Running setup.py (path:/tmp/pip-vVxE6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:54:44 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)) 21:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:54:44 INFO - Running setup.py (path:/tmp/pip-qOuEJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:54:44 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)) 21:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:54:44 INFO - Running setup.py (path:/tmp/pip-i5RfsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:54:44 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)) 21:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:54:44 INFO - Running setup.py (path:/tmp/pip-NLhs2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:54:45 INFO - Running setup.py (path:/tmp/pip-TxN2kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:54:45 INFO - Running setup.py (path:/tmp/pip-dGC1cZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:54:45 INFO - Running setup.py (path:/tmp/pip-LbuBoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:54:45 INFO - Running setup.py (path:/tmp/pip-CFSf3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:54:45 INFO - Running setup.py (path:/tmp/pip-6lY4qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:54:45 INFO - Running setup.py (path:/tmp/pip-uz09D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:54:45 INFO - Running setup.py (path:/tmp/pip-ahUEOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:54:45 INFO - Running setup.py (path:/tmp/pip-OzCLw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:54:45 INFO - Running setup.py (path:/tmp/pip-46H1eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:54:45 INFO - Running setup.py (path:/tmp/pip-hh3Z_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:54:45 INFO - Running setup.py (path:/tmp/pip-rTeYz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:54:45 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)) 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:54:45 INFO - Running setup.py (path:/tmp/pip-CFVXwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:54:45 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)) 21:54:45 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)) 21:54:45 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)) 21:54:45 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)) 21:54:45 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)) 21:54:45 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)) 21:54:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:54:45 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 21:54:45 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 21:54:45 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 21:54:45 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 21:54:45 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 21:54:45 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 21:54:47 INFO - Downloading blessings-1.6.tar.gz 21:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:54:47 INFO - Installing collected packages: blessings 21:54:47 INFO - Running setup.py install for blessings 21:54:47 INFO - Successfully installed blessings 21:54:47 INFO - Cleaning up... 21:54:48 INFO - Return code: 0 21:54:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:54:48 INFO - Reading from file tmpfile_stdout 21:54:48 INFO - Current package versions: 21:54:48 INFO - argparse == 1.2.1 21:54:48 INFO - blessings == 1.6 21:54:48 INFO - blobuploader == 1.2.4 21:54:48 INFO - docopt == 0.6.1 21:54:48 INFO - functools32 == 3.2.3-2 21:54:48 INFO - jsonschema == 2.5.1 21:54:48 INFO - manifestparser == 1.1 21:54:48 INFO - mozInstall == 1.12 21:54:48 INFO - mozcrash == 0.17 21:54:48 INFO - mozdebug == 0.1 21:54:48 INFO - mozdevice == 0.48 21:54:48 INFO - mozfile == 1.2 21:54:48 INFO - mozhttpd == 0.7 21:54:48 INFO - mozinfo == 0.9 21:54:48 INFO - mozleak == 0.1 21:54:48 INFO - mozlog == 3.3 21:54:48 INFO - moznetwork == 0.27 21:54:48 INFO - mozprocess == 0.23 21:54:48 INFO - mozprofile == 0.28 21:54:48 INFO - mozrunner == 6.12 21:54:48 INFO - mozscreenshot == 0.1 21:54:48 INFO - mozsystemmonitor == 0.3 21:54:48 INFO - moztest == 0.7 21:54:48 INFO - mozversion == 1.4 21:54:48 INFO - psutil == 3.1.1 21:54:48 INFO - requests == 1.2.3 21:54:48 INFO - wsgiref == 0.1.2 21:54:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:48 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 0x1c53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, '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': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', '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 21:54:48 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 21:54:48 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 21:54:48 INFO - Using env: {'DISPLAY': ':0', 21:54:48 INFO - 'HOME': '/home/cltbld', 21:54:48 INFO - 'LANG': 'en_US.UTF-8', 21:54:48 INFO - 'LANGUAGE': 'en_US:en', 21:54:48 INFO - 'LOGNAME': 'cltbld', 21:54:48 INFO - 'MAIL': '/var/mail/cltbld', 21:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:48 INFO - 'MOZ_NO_REMOTE': '1', 21:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:48 INFO - 'NO_EM_RESTART': '1', 21:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:48 INFO - 'PWD': '/builds/slave/test', 21:54:48 INFO - 'SHELL': '/bin/bash', 21:54:48 INFO - 'SHLVL': '1', 21:54:48 INFO - 'TERM': 'linux', 21:54:48 INFO - 'TMOUT': '86400', 21:54:48 INFO - 'USER': 'cltbld', 21:54:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:48 INFO - '_': '/tools/buildbot/bin/python'} 21:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:48 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)) 21:54:48 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)) 21:54:48 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)) 21:54:48 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)) 21:54:48 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)) 21:54:48 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)) 21:54:48 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)) 21:54:48 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)) 21:54:48 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)) 21:54:48 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)) 21:54:48 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)) 21:54:48 INFO - Cleaning up... 21:54:48 INFO - Return code: 0 21:54:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:48 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 0x1c53030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, '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': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', '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 21:54:48 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 21:54:48 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 21:54:48 INFO - Using env: {'DISPLAY': ':0', 21:54:48 INFO - 'HOME': '/home/cltbld', 21:54:48 INFO - 'LANG': 'en_US.UTF-8', 21:54:48 INFO - 'LANGUAGE': 'en_US:en', 21:54:48 INFO - 'LOGNAME': 'cltbld', 21:54:48 INFO - 'MAIL': '/var/mail/cltbld', 21:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:48 INFO - 'MOZ_NO_REMOTE': '1', 21:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:48 INFO - 'NO_EM_RESTART': '1', 21:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:48 INFO - 'PWD': '/builds/slave/test', 21:54:48 INFO - 'SHELL': '/bin/bash', 21:54:48 INFO - 'SHLVL': '1', 21:54:48 INFO - 'TERM': 'linux', 21:54:48 INFO - 'TMOUT': '86400', 21:54:48 INFO - 'USER': 'cltbld', 21:54:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:48 INFO - '_': '/tools/buildbot/bin/python'} 21:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:54:48 INFO - Cleaning up... 21:54:48 INFO - Return code: 0 21:54:48 INFO - Running post-action listener: _resource_record_post_action 21:54:48 INFO - Running post-action listener: _start_resource_monitoring 21:54:48 INFO - Starting resource monitoring. 21:54:48 INFO - [mozharness: 2016-07-21 04:54:48.741013Z] Finished create-virtualenv step (success) 21:54:48 INFO - [mozharness: 2016-07-21 04:54:48.741491Z] Running install step. 21:54:48 INFO - Running pre-action listener: _resource_record_pre_action 21:54:48 INFO - Running main action method: install 21:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:54:48 INFO - Reading from file tmpfile_stdout 21:54:48 INFO - Detecting whether we're running mozinstall >=1.0... 21:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:54:49 INFO - Reading from file tmpfile_stdout 21:54:49 INFO - Output received: 21:54:49 INFO - Usage: mozinstall [options] installer 21:54:49 INFO - Options: 21:54:49 INFO - -h, --help show this help message and exit 21:54:49 INFO - -d DEST, --destination=DEST 21:54:49 INFO - Directory to install application into. [default: 21:54:49 INFO - "/builds/slave/test"] 21:54:49 INFO - --app=APP Application being installed. [default: firefox] 21:54:49 INFO - mkdir: /builds/slave/test/build/application 21:54:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:55:06 INFO - Reading from file tmpfile_stdout 21:55:06 INFO - Output received: 21:55:06 INFO - /builds/slave/test/build/application/firefox/firefox 21:55:06 INFO - Running post-action listener: _resource_record_post_action 21:55:06 INFO - [mozharness: 2016-07-21 04:55:06.082384Z] Finished install step (success) 21:55:06 INFO - [mozharness: 2016-07-21 04:55:06.082665Z] Running run-tests step. 21:55:06 INFO - Running pre-action listener: _resource_record_pre_action 21:55:06 INFO - Running main action method: run_tests 21:55:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:55:06 INFO - Python 2.7.3 21:55:06 INFO - Return code: 0 21:55:06 INFO - grabbing minidump binary from tooltool 21:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:06 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 0x1f11570>, '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 0x1f12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f12900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:55:06 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 21:55:06 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 21:55:06 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 21:55:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:55:06 INFO - Return code: 0 21:55:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:55:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:55:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:55:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:55:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:55:06 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/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 21:55:06 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/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 21:55:06 INFO - Using env: {'DISPLAY': ':0', 21:55:06 INFO - 'HOME': '/home/cltbld', 21:55:06 INFO - 'LANG': 'en_US.UTF-8', 21:55:06 INFO - 'LANGUAGE': 'en_US:en', 21:55:06 INFO - 'LOGNAME': 'cltbld', 21:55:06 INFO - 'MAIL': '/var/mail/cltbld', 21:55:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:55:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:06 INFO - 'MOZ_NO_REMOTE': '1', 21:55:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:06 INFO - 'NO_EM_RESTART': '1', 21:55:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:06 INFO - 'PWD': '/builds/slave/test', 21:55:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:55:06 INFO - 'SHELL': '/bin/bash', 21:55:06 INFO - 'SHLVL': '1', 21:55:06 INFO - 'TERM': 'linux', 21:55:06 INFO - 'TMOUT': '86400', 21:55:06 INFO - 'USER': 'cltbld', 21:55:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117', 21:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:06 INFO - '_': '/tools/buildbot/bin/python'} 21:55:06 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/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 21:55:06 INFO - mozversion application_buildid: 20160720211719 21:55:06 INFO - mozversion application_changeset: 17409ee90c864e7e982a43e2026e6814a0797e4d 21:55:06 INFO - mozversion application_display_name: Nightly 21:55:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:55:06 INFO - mozversion application_name: Firefox 21:55:06 INFO - mozversion application_remotingname: firefox 21:55:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:55:06 INFO - mozversion application_vendor: Mozilla 21:55:06 INFO - mozversion application_version: 50.0a1 21:55:06 INFO - mozversion platform_buildid: 20160720211719 21:55:06 INFO - mozversion platform_changeset: 17409ee90c864e7e982a43e2026e6814a0797e4d 21:55:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:55:06 INFO - mozversion platform_version: 50.0a1 21:55:06 INFO - using testdate: 1469076906 21:55:06 INFO - actual date: 1469076906 21:55:06 INFO - starting webserver on 'localhost:44120' 21:55:06 INFO - SUITE-START | Running 2 tests 21:55:06 INFO - TEST-START | dromaeo_css 21:55:06 INFO - operating with platform_type : linux_ 21:55:06 INFO - Initialising browser for dromaeo_css test... 21:55:06 INFO - TEST-INFO | started process 4970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQZmRf/profile http://localhost:44120/getInfo.html) 21:55:11 INFO - PROCESS | 4970 | __metrics Screen width/height:1600/1200 21:55:11 INFO - PROCESS | 4970 | colorDepth:24 21:55:11 INFO - PROCESS | 4970 | Browser inner width/height: 1024/697 21:55:11 INFO - PROCESS | 4970 | __metrics 21:55:11 ERROR - PROCESS | 4970 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:55:12 INFO - TEST-INFO | 4970: exit 0 21:55:12 INFO - Browser initialized. 21:55:12 INFO - Running cycle 1/1 for dromaeo_css test... 21:55:12 INFO - TEST-INFO | started process 5090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQZmRf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:24 INFO - PROCESS | 5090 | RSS: Main: 168595456 21:55:24 INFO - PROCESS | 5090 | 21:56:14 INFO - PROCESS | 5090 | 1469076974236 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] 21:58:27 INFO - PROCESS | 5090 | Cycle 1(1): loaded http://localhost:44120/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44120/tests/dromaeo/cssquery-ext.html) 21:58:28 INFO - PROCESS | 5090 | RSS: Main: 170250240 21:58:28 INFO - PROCESS | 5090 | 22:01:31 INFO - PROCESS | 5090 | Cycle 1(1): loaded http://localhost:44120/tests/dromaeo/cssquery-ext.html (next: http://localhost:44120/tests/dromaeo/cssquery-jquery.html) 22:01:31 INFO - PROCESS | 5090 | RSS: Main: 169517056 22:01:31 INFO - PROCESS | 5090 | 22:04:33 INFO - PROCESS | 5090 | Cycle 1(1): loaded http://localhost:44120/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44120/tests/dromaeo/cssquery-mootools.html) 22:04:34 INFO - PROCESS | 5090 | RSS: Main: 173494272 22:04:34 INFO - PROCESS | 5090 | 22:07:36 INFO - PROCESS | 5090 | Cycle 1(1): loaded http://localhost:44120/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44120/tests/dromaeo/cssquery-prototype.html) 22:07:37 INFO - PROCESS | 5090 | RSS: Main: 168427520 22:07:37 INFO - PROCESS | 5090 | 22:10:39 INFO - PROCESS | 5090 | Cycle 1(1): loaded http://localhost:44120/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44120/tests/dromaeo/cssquery-yui.html) 22:10:40 INFO - PROCESS | 5090 | RSS: Main: 169766912 22:10:40 INFO - PROCESS | 5090 | 22:13:43 INFO - PROCESS | 5090 | Cycle 1(1): loaded http://localhost:44120/tests/dromaeo/cssquery-yui.html (next: http://localhost:44120/tests/dromaeo/cssquery-dojo.html) 22:13:43 INFO - PROCESS | 5090 | RSS: Main: 171646976 22:13:43 INFO - PROCESS | 5090 | 22:13:43 INFO - PROCESS | 5090 | __start_tp_report 22:13:43 INFO - PROCESS | 5090 | _x_x_mozilla_page_load 22:13:43 INFO - PROCESS | 5090 | _x_x_mozilla_page_load_details 22:13:43 INFO - PROCESS | 5090 | |i|pagename|runs| 22:13:43 INFO - PROCESS | 5090 | |0;dojo.html;2640.8283461575;2660.7871370290377;2665.9999999999995;2701.1491380215243;2708.8103832731704;4841.540053694902;4911.36152300201;4914.778834952427;4918.213085906255;4922.655414121013;4657.51096134906;4724.645651576128;4811.735354555498;4909.09181801367;4973.626977976657;4385.035292235711;4413.3379993001145;4459.219636563605;4483.955160448402;4486.259767138435;4449.755263460508;4578.565036321561;4595.609373203281;4596.195665758496;4615.215413379734;4310.4611923509565;4394.231009573344;4398.032432864765;4433.911321773563;4435.179491794029;4374.803133858953;4375.540568240321;4380.8685739427865;4424.690271680984;4496.055828276066;4410;4418.5802348776815;4425.424694789689;4434.733915965053;4449.555044495557;4799.232122860326;4808.230683090689;4817.373741413594;4824.855254342376;4835.782389792468;5264.289320941701;5276.2085687146855;5282.683039017633;5289.127293996486;5311.7344132793205;5296.602754793406;5310.867228319285;5313.256144139785;5316.680999140064;5342.866428339284;4694.95305046952;4757.738324392191;4798.95201047992;4804.015176888729;4936.2102063669645;5243.711595862264;5261.184516399888;5262.60530460217;5269.130593452038;5300.814471493556;5026.974865125651;5033.798648054037;5036.7733451994745;5043.067032598981;5091.414487334004;5068.6451948363265;5113.488651134931;5134.024535338273;5148.716820574904;5195.68825870449;4993.4756850530175;5059.494050594984;5065.214891691794;5069.239614057921;5118.078745825787;5081.923771143362;5104.1578139606545;5106.617003724736;5121.180611102206;5135.38375394955;4168.24971505132;4214.072903961123;4278.978605106954;4317.697761156752;4331.350297455407;3686.2443199144113;3773.660370566662;3796.145867179918;3798.8860334189467;3815.065308999313;4553.271476563734;4558.88602784933;4566.1552612766745;4569.497355290915;4611.446626404786;5037.5214354636255;5124.128898087334;5269.683818970874;5273.578113750891;5276.34045744282;4483.417155769795;4493.078918821634;4502.279635258343;4549.226631472658;4555.088982203572;4669.859904202879;4670.602998745077;4674.135284972291;4682.297655351725;4705.12955103307;4801.927971080367;4808.110499557453;4851.199552074009;4852.684575502581;4888.388951381077;5137.486251374833;5139.357580302462;5171.3277273954145;5205.843824685266;5210.947890521198;4833.540813622701;4854.053459575349;4867.90264194707;4872;4916.606671466203;4951.084049450863;5034.572061374824;5088.262201980618;5099.796008159632;5127.948720512747;5126.820561280338;5161.251618515369;5176.767045482887;5196.246544251138;5220.660657057279;4935.3584034076775;4940.629452791127;4957.776900039579;4958.72727000004;5022.27177059317;4867.58625516835;4940.5800506955875;4942.20924652054;4942.777575009061;4998.575121114746;4963.454020057863;5003.699778013331;5017.397912250553;5031.823886163967;5040.49595040493;5014.799408023784;5033.295338652665;5044.873878153076;5070.036693028313;5095.490450954875;4850.223964165858;4922.581580565692;4923.901521969469;4939.135651261086;5009.198528235464 22:13:43 INFO - PROCESS | 5090 | |1;ext.html;544.1674238415225;548.5858177076307;555.9583031272655;560.5263552298309;588.7703795519751;35260;39960.20079598406;40020.1995960081;40074;40086;39876.80061599688;40256.79871600645;40406.7979660102;40424;40437.393439098436;7606.88589671154;7823.178566250519;7830.060392752849;7842.176571460001;7855.567943763091;7771.300582947533;7805.219478052178;7868.724594639189;7869.606519674022;7871.094824095245;7895.328897043758;7910.881336779953;7930.325922296612;7939.682412703485;7961.36309095271;7802.921970780277;7857.764267071997;7861.095973962982;7866.213378662145;7887.369010479148;7822.491538050009;7843;7860.6069696515515;7867.016622922135;7873;37849;37898.43152352717;38246.42630360547;38279.808600956814;38322.233555328734;2406.843555168926;2735.7811375089946;2747.2582402751145;2829.4765468388414;2957.1128661401494;25655;26670.5999410009;28280.71719282822;28431.147065588066;28436.431271374662;3181.7772755907095;3208.2941752814577;3214.4214041472524;3232.2565809863627;3261.445554255782;227344;228782;230118.9999999983;230490;230988.9999999983;31711.682883171336;31787.523187152212;31886.52170217402;31960.200994975312;32110;34281.31437371238;34327.313453730785;34594.65405345965;34632;34819.65180348215;12322.81515777264;12338.629841104781;12362.134650574373;12368.505259789688;12372.876271237352;10342.482875856178;10360.585576577003;10365.63720269787;10376.896231037745;10376.948115259527;7860.5676687782725;7893.368530517545;7991.560464174526;8034.758957231175;8071;3099.891503797356;3165.509346051366;3197.424463596575;3208.6630903755236;3218;859.4714250735752;920.2729843423621;962.7256231973994;979.1970584120952;984.1880448629765;28272.575911360935;28450.430991380057;28907.855460722563;29216.707832921824;29497.557536636967;958.9616415343447;995.3530205366569;1001.6694490818013;1034.6792494326783;1049.4647729657777;14485;15031.774523382159;15372.538823835303;15517.22413879324;15573.221338933008;431632;435995;438046;439010;440414;50052.74973625181;50119.49880501221;50620.49379506158;50747.746261269196;50896;1176.2236923630362;1176.335370515656;1204.4098391788136;1220.1641875315615;1225.7609766095704;24226.53122819834;27725.86137069302;28037.34614527337;28204.576931346455;28340.57489137706;42740.786296069564;42814.35778463388;42893.356599651655;42958.14083718371;43072;360009;360961;361718;362139;362154;25333;25478.59867707294;25623.871880640476;25794.484110318062;25836.224913252634;39632.2073558533;42055.57944420516;43321.13357732891;43367;43860.780696097594;36399.63600363962;36451.81774091112;36526.634733652325;36854.63145368512;37336.81331593324;36985.44521832228;37501.2499749998;37747.81126094352;38157.80921095377;38449.4232586517;35295.8226513351;35358.292834143685;35764;35845.1038724034;36265;31486.52770208403;33546.66453335436;33612.327753445286;33659.831700841336;33905;25902.481950361263;25982.74017259803;25987.74012259853;26081.870760371676;26150.607740884283 22:13:43 INFO - PROCESS | 5090 | |2;jquery.html;354.4682975536695;362.7932078715132;366.6370293409524;375.6787946305907;381.207089254351;16107.194640267984;17484.825151748493;17569.648607027866;18072.81927180728;18130.18414171362;16578.419755308565;17030.23363948622;17289;17400.21699023544;17465.650686986253;5063.569596584285;5247.658902171346;5286.867828304285;5293.841184764463;5298;3832.7125465590193;5153.974230128844;5908.822735317947;6151.692415379235;6186.505079593644;6170.352113028135;6222.657753823538;6225.782097626584;6235.282942461629;6249.468795152395;6069.180660610805;6206.906896396557;6212.471939885115;6229.283632382266;6265.185525881629;4571.748553829538;4833.806647734086;5402.6758394496455;5415.891682166334;5430.728463576845;12251.081168912368;12376.381180941007;17002.979821210643;20632.58734825295;21056.894715526323;1823.8085001074828;1862.850971922243;1971.9507012324664;2310.861348319106;2440.9145679901117;9044.728658140266;9051.864222036675;9145.588448519833;9166.86249706255;9336.439813611205;1644.8601868841163;1655.9172041397883;1690.5097521718687;1694.6102396448887;1706.7695861058721;67028;68900.31099689039;69985.65007174983;70339.29660703379;70872.645636772;9603.759906002266;9721.611135554498;9778.364406313567;9914.454704991294;9919.50402479873;13657.453701852013;13767.31163441824;13794.103383280255;13863.168209907237;13885.305734713224;6836;6853.623050732158;6953.860922781516;7022.508424410345;7173.995640610318;6507.577007494498;6642.900356494656;6668.833279167962;6681.665916704243;6971.6165610891885;4138.193052354822;4215.641670457984;4226.4716910386205;4375.737455752601;4432.312991486325;1703.2505697493064;1753.9386121485686;1765.9823401766075;1812.3203798575535;1848.8243616856378;797.0395673213764;815.1970309245388;832.7085520067927;902.4269588811021;963.9277054220961;16845.410410635814;17026;17307.567310817078;17674.911625442048;17731.29074836992;800.2597597222546;859.1365677494078;873.8558137907174;890.8841850559386;892.4333048514111;9493.952530237304;9850.556724947395;9935.65225217114;9943.80112397748;9950.10449059588;423853;427213;430006;433394;433796;79525.20474795294;84377.57811210904;86394.56802715946;88196.5590172045;88487;825.8224481736455;869.1569177897429;873.9431936924079;874.5059041641452;904.4573256046451;15268.923655382096;15587.298571564534;16093.839061609702;16383.754243686115;16438.75341869849;38506.422403664525;38865.805670971466;38944.80527597344;39344.80327598344;40029.79985100056;49468;53203.201951971525;54123.72938135442;54476;55372.44627553834;6312.621242725451;6730.293319201413;6881.552699074544;6948.722051117898;7944.165862584346;9614.95192524033;11620.709482262673;11727.765444690887;11908.52365905354;12138.696532586757;9879;10116.949415252877;10463.11063559606;10532.947335263274;10664.146868250366;4704.223803072591;10240.795184096127;10257.897421025695;10300.484975751333;10320.329178603366;9582.520873956413;9760;10022.849657255292;10472.947635261775;10501.264911456125;7491.7264065107975;7527.510711803715;7545.434092442979;7619.428542859197;7667.731629392944;8842.513661748666;9799.804003920024;9921.851172232278;10540.420276884844;10725.570977161138 22:13:43 INFO - PROCESS | 5090 | |3;mootools.html;1376.807246985422;1421.5095791951776;1468.7870258812472;1675.137304288291;1690.467502736637;6931.72273109075;7546.28310310521;7560.281773231541;8111.269985701286;8130.3902207334395;7534.246575342477;7789.493682910621;7793.53238805672;7794.064712234525;7811.453198276123;2037.1851259496173;2060.186226440555;2068.834493240545;2073.8963051847422;2074.52285974226;2127.7765834587376;2139.657654775236;2164.415607785897;2204.7574766775642;2205.3494219205295;2119.1841141160685;2146.946326341846;2151.279321427324;2152.365052309565;2203.790639889216;2143.7062343292528;2144.8391370647264;2156.1806513524916;2157.1802714968367;2158.6006588781124;2064.1227478321653;2084.5101401170714;2102.737157855268;2113.028007116728;2117.7246957895527;7837.529748215125;7842.058952925629;7850.411219158586;7873.448858579902;7890.56601886896;4601.861944141681;4603.10239503297;4648.814047438098;4671.906561868744;4786.425628924517;2808.4523517914013;2872.7989040767156;2900.4779139754837;2932.164333165059;2952.70472952703;888.5290795878195;935.9298052646011;939.262678797141;942.792585631167;946.394307643109;10489.213309001856;10590.470476476145;10626.787464250672;10676.145908327315;10681.519331630096;3996.820143093568;4249.91500170001;4256.233877902007;4313.61177494027;4314.80583373749;9023.774405639911;9083.318751093562;9104.681336153202;9114.316426268057;9132.589033493508;4700.2949557566635;4700.647451441156;4702.412198475191;4703.435587729495;4716.858494245178;3642.617525159873;4176.7076304658385;4262.595053469915;4277.465316835395;4297.957020429756;3586;3640.8725694601094;3657.5428071491065;3682.576503702055;3698.352788262097;1161.6456980620824;1208.4199584199635;1214.5870404062484;1220.4317452074042;1226.3439060102803;657.9407853293227;775.0466925681443;781.25780508516;786.8662327404355;801.8075661841116;4725.740084295397;4819.277108433763;4848.0788650156355;5207.453217412193;5259.631825772236;867.509856930832;897.8563429851323;901.9819603608022;914.3371055984358;920.0661328751323;3224.516322551589;3312.7846689965077;3330.0842268375904;3370.1069216657606;3372.561566996324;9345.392549484262;9771.51142442875;9853.852192217122;9889.80220395588;9891.060349266809;9608.90391096094;9713.514324283757;9748.561314740853;9804.509774511245;9809.607615695293;7335.083114610674;7421.962890185622;7508.587027713419;7521.699132034767;7542.47202695806;4817.566419022305;4844.806207751651;4928.112939670894;4970.726610036482;5107.544349860272;8850.247728943112;8947.955260223658;8949.865752013595;9032.096790320915;9087.273018158663;8984.86522702173;9075.27397808187;9126.863097053416;9147.954260228656;9244.260459163117;6402.167718196604;6559.7376104955265;6788.898166527605;6851.280615535297;6853.828654283683;7621.047369078865;7632.771016869503;7640.961795190989;7647.502912310682;7674.270944260286;6635.9004614929845;6732.528722989539;6749.3250674932115;6807.863842723217;6963.268856769966;6365.809025729235;6411.358864113551;6418.614883107029;6433.163688720437;6602.207735071822;6040.456358927718;6091.177691011657;6125.142480052886;6134.8159555213415;6146;4265.893352666209;4284.1645879053285;4311.892202694958;4326.286162783105;4390.07808360248;4190.14102109073;4316.870493885189;4370.737755734539;4378.693491455568;4387.473503179639 22:13:43 INFO - PROCESS | 5090 | |4;prototype.html;295.9896403625873;297.16941149487195;302.7895612549278;305.2338630038602;306.2649640861932;5090.211017292317;5094.261332106847;5120.257562653418;5124.692518448886;5132.4610915853855;5018.749062546867;5042.478760619691;5048.394192696873;5060.797568097271;5065.290859279704;3760.887173384796;3874.2638898609175;3956.4263181838614;3960.6633436157963;3964.7621142731527;3927.136030073379;3941.940870886939;3946.2107578484274;3951.802409879509;3953.655757042605;3906.5312162540536;3923.15652134791;3925.2149570085953;3928.2732694451474;3929.6856251499953;3817.351050321452;3900.6294402031763;3917.6669983051474;3945.3490174121234;3966.246413181501;3478.269563391691;3484.721222302235;3486.1110416843794;3490.127468132967;3496.0910163357457;4932.235503496928;4936.605071594264;4942.357493525855;4945.455999840015;4950.603951683856;4441.977790111061;4547.840300723295;4548.158590660705;4548.295014272793;4559.726416414993;5228.738563071869;5237.6071794615555;5285.127953887604;5308.309919710451;5324.4675532446445;3802.2889699635275;3804.1821008483307;3808.1050953026015;3832.9616703833162;3842.7703134996814;5365.973170134163;5512.421195774426;5575.916361254584;5582.469665381782;5598.440155984369;3852.6339997700175;3875.418687196943;3881.146147847469;3892.1048158923604;3914;3962.1481381503113;3970.781607011642;3973.2450834341385;3976.363781794899;3986.421968814506;4451.5103338632725;4480.61914737251;4485.215087359699;4486.798094085774;4541.545845415498;5158.303629010111;5231.450697676765;5272.578193744491;5291.841244762663;5302.522772950453;1354.525915929417;1385.452746165259;1385.840628327735;1386.2791348498724;1389.7498450279047;834.6619619054293;866.0733015673169;875.4397185801092;886.4016788667624;889.3330002498126;4463.888402789957;4521.163584736769;4659.324397962277;4717.622590192776;4726.952730472652;5445.591580631469;5473.890522189534;5486.725663716798;5491.533219676292;5509.228707980886;4576.382188404523;4699.530046995274;4700.579201711122;4716.882077948078;4742.596879265232;2842.4173044525824;2855.729200505755;2880.5247134223036;2887.8556072196307;2890.6675732290637;5082.856357319647;5089.923651145235;5095.617828662865;5097.8215762448135;5100.260462232955;5282.392524859613;5503.779848806083;5545.611807173459;5570.749316280777;5610.298712660918;5155.097857874857;5161.458046905021;5163;5168;5168.715720635326;5539.529140023144;5548.306461692288;5549.889002220014;5586.190002449704;5593.356763972195;5235.612562670819;5380;5386.8383948481605;5394.541463975606;5406.189071639285;5112.795488180431;5127.102971900272;5144.742762861917;5145.691258524501;5189.4032186299055;3824.6749026333073;3852.499175107218;3872.6320999505;3879.4180872869297;3888.183481468923;5368.677879327252;5458.754356054066;5497.917531236954;5518.668879867221;5612.579056570692;5202.2196670499725;5249.742610677446;5255.290535777621;5257.579393648422;5277.736113194402;5216.686998780086;5233.424323324507;5243.5542978847225;5261.605379596469;5305.787768489217;4919.778609962632;5172.387944088211;5226.477352264895;5232.607554433356;5247.658902171346;5094.872628184325;5233.738313084406;5326.573874089986;5329;5372.247885295984;5249.370075590953;5255.185446255837;5268.57851371897;5269.9974009876005;5275.129603615361 22:13:43 INFO - PROCESS | 5090 | |5;yui.html;605.7772649504635;620.7889317632004;652.9673516324183;734.7391675955035;739.6301849075461;13468.865311346895;14076.929615351935;14101.153930764149;14136.293185340717;14146;13189.472421103144;13295.933520332408;13299.867001329983;13325.46698132076;13340.599782006531;621.754407009231;747.9551226926388;771.6257615056693;789.1713700614332;798.8641930871737;762.0854974031157;764.2472164917551;765.5904091311149;766.3600893254112;768.1550294675868;804.8350088231898;806.7942674617964;807.3702512040618;807.5356669914793;808.3331251717357;797.9202079792003;804.7706403674954;805.0299389235956;807.1081454992208;808.086861846113;589.669784920446;591.2904514582475;593.5192494079766;594.6610432053731;595.9374265702082;13742.862571374259;13785.793213101811;13789.310534473336;13794.586162415144;13796.793048104286;13720.176789392668;13729.725405491934;13741.862581374258;13759.243241621707;13828.308584570832;10505.894941050645;10514.526846291936;10613.681589552325;10682.252242343038;11126.499307531181;3350.7654464187517;3380.4253276942977;3391.118309239591;3391.4743214801747;3489.91275218119;59879.40120598825;60829;62309.68845155791;63368.99999999954;64659.3534064658;10704.398646570311;10766.246362754531;10804.621838235624;11007.779844403067;11044.502997365138;19776.505587360145;19906.800931990783;19914.103865326095;20014.399568012985;20014.89992550028;6791.456683465311;6825.1127353443735;6902.896456553156;6903.6203008835;7009;3604;3613.512175856278;3642.85428582859;3682.4660424238336;3738.2897249522503;2945.23423909785;2991.685872983349;3013.050888969967;3038.5442183672626;3049.7560195184774;496.29773869974304;500.27959737977926;507.22901190190703;507.4925074925075;514.5420575687641;423.3501575082234;463.88402899275184;465.7089319175515;510.69358384968723;570.5635189080357;7875.212478752079;8149.592520373958;8243.711470098639;8339.374546909006;8408.32733381328;451.1946176075689;522.9686218826882;542.3735585398871;551.181495479213;554.3292615934764;3788.6969042476535;3825.311443940062;3855.5951625079524;3865.7680539167177;3934.409838524187;78881.60559197167;80022;93846.5307673471;94659.52670236604;95701.52149239209;49328.75335623299;55827;57911.42088579144;81818;84211;37249;45803;46575.30137047947;72326.27673723195;73475;8291.461055031403;8843.955780221058;9010.729678109405;9090.36367454272;9180.17378435944;44615.55384446244;45187.20170405024;46520.7673961628;46624.30063548982;48031.75984120057;37100.81449592735;50229.497705022484;62834.37165628285;63195.6840215796;64346.67826660837;9296.116868897443;9543.665971690958;9633;11036.889631103586;11503.654890353302;10105.39367637944;10866.402347870942;11010.50452729613;11012.724681883017;11042.613508527164;11386.54453821871;11954.342511161622;12146.210496317712;12364.010879129468;12664.556740514037;11045.83431248548;11384.43077846121;11576.94211528937;11728;11764.58823941158;11697.590584329508;12118.394080295773;12180;12457.937710311391;12463.376831158224;10193.643222487177;10412.375257484575;10692.14462842955;10847.566097356017;10938.835917461085;8797.296216302553;9145.496997665192;10156.18750499973;10717.35695858251;10859.945700271448 22:13:43 INFO - PROCESS | 5090 | __end_tp_report 22:13:43 INFO - PROCESS | 5090 | __start_cc_report 22:13:43 INFO - PROCESS | 5090 | _x_x_mozilla_cycle_collect,420 22:13:43 INFO - PROCESS | 5090 | __end_cc_report 22:13:43 INFO - PROCESS | 5090 | __startTimestamp1469078023620__endTimestamp 22:13:43 INFO - PROCESS | 5090 | 22:13:43 INFO - PROCESS | 5090 | ------- Summary: start ------- 22:13:43 INFO - PROCESS | 5090 | Number of tests: 6 22:13:43 INFO - PROCESS | 5090 | 22:13:43 INFO - PROCESS | 5090 | [#0] dojo.html Cycles:165 Average:4772.26 Median:4916.61 stddev:506.89 (10.3%) stddev-sans-first:480.07 22:13:43 INFO - PROCESS | 5090 | Values: 2640.8 2660.8 2666.0 2701.1 2708.8 4841.5 4911.4 4914.8 4918.2 4922.7 4657.5 4724.6 4811.7 4909.1 4973.6 4385.0 4413.3 4459.2 4484.0 4486.3 4449.8 4578.6 4595.6 4596.2 4615.2 4310.5 4394.2 4398.0 4433.9 4435.2 4374.8 4375.5 4380.9 4424.7 4496.1 4410.0 4418.6 4425.4 4434.7 4449.6 4799.2 4808.2 4817.4 4824.9 4835.8 5264.3 5276.2 5282.7 5289.1 5311.7 5296.6 5310.9 5313.3 5316.7 5342.9 4695.0 4757.7 4799.0 4804.0 4936.2 5243.7 5261.2 5262.6 5269.1 5300.8 5027.0 5033.8 5036.8 5043.1 5091.4 5068.6 5113.5 5134.0 5148.7 5195.7 4993.5 5059.5 5065.2 5069.2 5118.1 5081.9 5104.2 5106.6 5121.2 5135.4 4168.2 4214.1 4279.0 4317.7 4331.4 3686.2 3773.7 3796.1 3798.9 3815.1 4553.3 4558.9 4566.2 4569.5 4611.4 5037.5 5124.1 5269.7 5273.6 5276.3 4483.4 4493.1 4502.3 4549.2 4555.1 4669.9 4670.6 4674.1 4682.3 4705.1 4801.9 4808.1 4851.2 4852.7 4888.4 5137.5 5139.4 5171.3 5205.8 5210.9 4833.5 4854.1 4867.9 4872.0 4916.6 4951.1 5034.6 5088.3 5099.8 5127.9 5126.8 5161.3 5176.8 5196.2 5220.7 4935.4 4940.6 4957.8 4958.7 5022.3 4867.6 4940.6 4942.2 4942.8 4998.6 4963.5 5003.7 5017.4 5031.8 5040.5 5014.8 5033.3 5044.9 5070.0 5095.5 4850.2 4922.6 4923.9 4939.1 5009.2 22:13:43 INFO - PROCESS | 5090 | 22:13:43 INFO - PROCESS | 5090 | [#1] ext.html Cycles:180 Average:47900.50 Median:361928.50 stddev:93716.99 (25.9%) stddev-sans-first:93912.44 22:13:43 INFO - PROCESS | 5090 | Values: 544.2 548.6 556.0 560.5 588.8 35260.0 39960.2 40020.2 40074.0 40086.0 39876.8 40256.8 40406.8 40424.0 40437.4 7606.9 7823.2 7830.1 7842.2 7855.6 7771.3 7805.2 7868.7 7869.6 7871.1 7895.3 7910.9 7930.3 7939.7 7961.4 7802.9 7857.8 7861.1 7866.2 7887.4 7822.5 7843.0 7860.6 7867.0 7873.0 37849.0 37898.4 38246.4 38279.8 38322.2 2406.8 2735.8 2747.3 2829.5 2957.1 25655.0 26670.6 28280.7 28431.1 28436.4 3181.8 3208.3 3214.4 3232.3 3261.4 227344.0 228782.0 230119.0 230490.0 230989.0 31711.7 31787.5 31886.5 31960.2 32110.0 34281.3 34327.3 34594.7 34632.0 34819.7 12322.8 12338.6 12362.1 12368.5 12372.9 10342.5 10360.6 10365.6 10376.9 10376.9 7860.6 7893.4 7991.6 8034.8 8071.0 3099.9 3165.5 3197.4 3208.7 3218.0 859.5 920.3 962.7 979.2 984.2 28272.6 28450.4 28907.9 29216.7 29497.6 959.0 995.4 1001.7 1034.7 1049.5 14485.0 15031.8 15372.5 15517.2 15573.2 431632.0 435995.0 438046.0 439010.0 440414.0 50052.7 50119.5 50620.5 50747.7 50896.0 1176.2 1176.3 1204.4 1220.2 1225.8 24226.5 27725.9 28037.3 28204.6 28340.6 42740.8 42814.4 42893.4 42958.1 43072.0 360009.0 360961.0 361718.0 362139.0 362154.0 25333.0 25478.6 25623.9 25794.5 25836.2 39632.2 42055.6 43321.1 43367.0 43860.8 36399.6 36451.8 36526.6 36854.6 37336.8 36985.4 37501.2 37747.8 38157.8 38449.4 35295.8 35358.3 35764.0 35845.1 36265.0 31486.5 33546.7 33612.3 33659.8 33905.0 25902.5 25982.7 25987.7 26081.9 26150.6 22:13:43 INFO - PROCESS | 5090 | 22:13:43 INFO - PROCESS | 5090 | [#2] jquery.html Cycles:180 Average:25672.41 Median:5290.35 stddev:70952.74 (1341.2%) stddev-sans-first:71126.32 22:13:43 INFO - PROCESS | 5090 | Values: 354.5 362.8 366.6 375.7 381.2 16107.2 17484.8 17569.6 18072.8 18130.2 16578.4 17030.2 17289.0 17400.2 17465.7 5063.6 5247.7 5286.9 5293.8 5298.0 3832.7 5154.0 5908.8 6151.7 6186.5 6170.4 6222.7 6225.8 6235.3 6249.5 6069.2 6206.9 6212.5 6229.3 6265.2 4571.7 4833.8 5402.7 5415.9 5430.7 12251.1 12376.4 17003.0 20632.6 21056.9 1823.8 1862.9 1972.0 2310.9 2440.9 9044.7 9051.9 9145.6 9166.9 9336.4 1644.9 1655.9 1690.5 1694.6 1706.8 67028.0 68900.3 69985.7 70339.3 70872.6 9603.8 9721.6 9778.4 9914.5 9919.5 13657.5 13767.3 13794.1 13863.2 13885.3 6836.0 6853.6 6953.9 7022.5 7174.0 6507.6 6642.9 6668.8 6681.7 6971.6 4138.2 4215.6 4226.5 4375.7 4432.3 1703.3 1753.9 1766.0 1812.3 1848.8 797.0 815.2 832.7 902.4 963.9 16845.4 17026.0 17307.6 17674.9 17731.3 800.3 859.1 873.9 890.9 892.4 9494.0 9850.6 9935.7 9943.8 9950.1 423853.0 427213.0 430006.0 433394.0 433796.0 79525.2 84377.6 86394.6 88196.6 88487.0 825.8 869.2 873.9 874.5 904.5 15268.9 15587.3 16093.8 16383.8 16438.8 38506.4 38865.8 38944.8 39344.8 40029.8 49468.0 53203.2 54123.7 54476.0 55372.4 6312.6 6730.3 6881.6 6948.7 7944.2 9615.0 11620.7 11727.8 11908.5 12138.7 9879.0 10116.9 10463.1 10532.9 10664.1 4704.2 10240.8 10257.9 10300.5 10320.3 9582.5 9760.0 10022.8 10472.9 10501.3 7491.7 7527.5 7545.4 7619.4 7667.7 8842.5 9799.8 9921.9 10540.4 10725.6 22:13:43 INFO - PROCESS | 5090 | 22:13:43 INFO - PROCESS | 5090 | [#3] mootools.html Cycles:180 Average:5104.86 Median:4949.42 stddev:2903.88 (58.7%) stddev-sans-first:2898.52 22:13:43 INFO - PROCESS | 5090 | Values: 1376.8 1421.5 1468.8 1675.1 1690.5 6931.7 7546.3 7560.3 8111.3 8130.4 7534.2 7789.5 7793.5 7794.1 7811.5 2037.2 2060.2 2068.8 2073.9 2074.5 2127.8 2139.7 2164.4 2204.8 2205.3 2119.2 2146.9 2151.3 2152.4 2203.8 2143.7 2144.8 2156.2 2157.2 2158.6 2064.1 2084.5 2102.7 2113.0 2117.7 7837.5 7842.1 7850.4 7873.4 7890.6 4601.9 4603.1 4648.8 4671.9 4786.4 2808.5 2872.8 2900.5 2932.2 2952.7 888.5 935.9 939.3 942.8 946.4 10489.2 10590.5 10626.8 10676.1 10681.5 3996.8 4249.9 4256.2 4313.6 4314.8 9023.8 9083.3 9104.7 9114.3 9132.6 4700.3 4700.6 4702.4 4703.4 4716.9 3642.6 4176.7 4262.6 4277.5 4298.0 3586.0 3640.9 3657.5 3682.6 3698.4 1161.6 1208.4 1214.6 1220.4 1226.3 657.9 775.0 781.3 786.9 801.8 4725.7 4819.3 4848.1 5207.5 5259.6 867.5 897.9 902.0 914.3 920.1 3224.5 3312.8 3330.1 3370.1 3372.6 9345.4 9771.5 9853.9 9889.8 9891.1 9608.9 9713.5 9748.6 9804.5 9809.6 7335.1 7422.0 7508.6 7521.7 7542.5 4817.6 4844.8 4928.1 4970.7 5107.5 8850.2 8948.0 8949.9 9032.1 9087.3 8984.9 9075.3 9126.9 9148.0 9244.3 6402.2 6559.7 6788.9 6851.3 6853.8 7621.0 7632.8 7641.0 7647.5 7674.3 6635.9 6732.5 6749.3 6807.9 6963.3 6365.8 6411.4 6418.6 6433.2 6602.2 6040.5 6091.2 6125.1 6134.8 6146.0 4265.9 4284.2 4311.9 4326.3 4390.1 4190.1 4316.9 4370.7 4378.7 4387.5 22:13:43 INFO - PROCESS | 5090 | 22:13:43 INFO - PROCESS | 5090 | [#4] prototype.html Cycles:180 Average:4405.65 Median:5074.07 stddev:1281.25 (25.3%) stddev-sans-first:1247.16 22:13:43 INFO - PROCESS | 5090 | Values: 296.0 297.2 302.8 305.2 306.3 5090.2 5094.3 5120.3 5124.7 5132.5 5018.7 5042.5 5048.4 5060.8 5065.3 3760.9 3874.3 3956.4 3960.7 3964.8 3927.1 3941.9 3946.2 3951.8 3953.7 3906.5 3923.2 3925.2 3928.3 3929.7 3817.4 3900.6 3917.7 3945.3 3966.2 3478.3 3484.7 3486.1 3490.1 3496.1 4932.2 4936.6 4942.4 4945.5 4950.6 4442.0 4547.8 4548.2 4548.3 4559.7 5228.7 5237.6 5285.1 5308.3 5324.5 3802.3 3804.2 3808.1 3833.0 3842.8 5366.0 5512.4 5575.9 5582.5 5598.4 3852.6 3875.4 3881.1 3892.1 3914.0 3962.1 3970.8 3973.2 3976.4 3986.4 4451.5 4480.6 4485.2 4486.8 4541.5 5158.3 5231.5 5272.6 5291.8 5302.5 1354.5 1385.5 1385.8 1386.3 1389.7 834.7 866.1 875.4 886.4 889.3 4463.9 4521.2 4659.3 4717.6 4727.0 5445.6 5473.9 5486.7 5491.5 5509.2 4576.4 4699.5 4700.6 4716.9 4742.6 2842.4 2855.7 2880.5 2887.9 2890.7 5082.9 5089.9 5095.6 5097.8 5100.3 5282.4 5503.8 5545.6 5570.7 5610.3 5155.1 5161.5 5163.0 5168.0 5168.7 5539.5 5548.3 5549.9 5586.2 5593.4 5235.6 5380.0 5386.8 5394.5 5406.2 5112.8 5127.1 5144.7 5145.7 5189.4 3824.7 3852.5 3872.6 3879.4 3888.2 5368.7 5458.8 5497.9 5518.7 5612.6 5202.2 5249.7 5255.3 5257.6 5277.7 5216.7 5233.4 5243.6 5261.6 5305.8 4919.8 5172.4 5226.5 5232.6 5247.7 5094.9 5233.7 5326.6 5329.0 5372.2 5249.4 5255.2 5268.6 5270.0 5275.1 22:13:43 INFO - PROCESS | 5090 | 22:13:43 INFO - PROCESS | 5090 | [#5] yui.html Cycles:180 Average:16414.18 Median:45495.10 stddev:22235.21 (48.9%) stddev-sans-first:22265.90 22:13:43 INFO - PROCESS | 5090 | Values: 605.8 620.8 653.0 734.7 739.6 13468.9 14076.9 14101.2 14136.3 14146.0 13189.5 13295.9 13299.9 13325.5 13340.6 621.8 748.0 771.6 789.2 798.9 762.1 764.2 765.6 766.4 768.2 804.8 806.8 807.4 807.5 808.3 797.9 804.8 805.0 807.1 808.1 589.7 591.3 593.5 594.7 595.9 13742.9 13785.8 13789.3 13794.6 13796.8 13720.2 13729.7 13741.9 13759.2 13828.3 10505.9 10514.5 10613.7 10682.3 11126.5 3350.8 3380.4 3391.1 3391.5 3489.9 59879.4 60829.0 62309.7 63369.0 64659.4 10704.4 10766.2 10804.6 11007.8 11044.5 19776.5 19906.8 19914.1 20014.4 20014.9 6791.5 6825.1 6902.9 6903.6 7009.0 3604.0 3613.5 3642.9 3682.5 3738.3 2945.2 2991.7 3013.1 3038.5 3049.8 496.3 500.3 507.2 507.5 514.5 423.4 463.9 465.7 510.7 570.6 7875.2 8149.6 8243.7 8339.4 8408.3 451.2 523.0 542.4 551.2 554.3 3788.7 3825.3 3855.6 3865.8 3934.4 78881.6 80022.0 93846.5 94659.5 95701.5 49328.8 55827.0 57911.4 81818.0 84211.0 37249.0 45803.0 46575.3 72326.3 73475.0 8291.5 8844.0 9010.7 9090.4 9180.2 44615.6 45187.2 46520.8 46624.3 48031.8 37100.8 50229.5 62834.4 63195.7 64346.7 9296.1 9543.7 9633.0 11036.9 11503.7 10105.4 10866.4 11010.5 11012.7 11042.6 11386.5 11954.3 12146.2 12364.0 12664.6 11045.8 11384.4 11576.9 11728.0 11764.6 11697.6 12118.4 12180.0 12457.9 12463.4 10193.6 10412.4 10692.1 10847.6 10938.8 8797.3 9145.5 10156.2 10717.4 10859.9 22:13:43 INFO - PROCESS | 5090 | -------- Summary: end -------- 22:13:43 INFO - PROCESS | 5090 | 22:13:44 INFO - TEST-INFO | 5090: exit 0 22:13:44 INFO - TEST-OK | dromaeo_css | took 1118041ms 22:13:44 INFO - TEST-START | kraken 22:13:44 INFO - operating with platform_type : linux_ 22:13:44 INFO - Initialising browser for kraken test... 22:13:44 INFO - TEST-INFO | started process 5334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOHn0iA/profile http://localhost:44120/getInfo.html) 22:13:48 INFO - PROCESS | 5334 | __metrics Screen width/height:1600/1200 22:13:48 INFO - PROCESS | 5334 | colorDepth:24 22:13:48 INFO - PROCESS | 5334 | Browser inner width/height: 1024/697 22:13:48 INFO - PROCESS | 5334 | __metrics 22:13:49 ERROR - PROCESS | 5334 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:13:50 INFO - TEST-INFO | 5334: exit 0 22:13:50 INFO - Browser initialized. 22:13:50 INFO - Running cycle 1/1 for kraken test... 22:13:50 INFO - TEST-INFO | started process 5452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOHn0iA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:02 INFO - PROCESS | 5452 | RSS: Main: 168280064 22:14:02 INFO - PROCESS | 5452 | 22:14:04 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44120/tests/kraken/driver.html?testName=audio-beat-detection) 22:14:05 INFO - PROCESS | 5452 | RSS: Main: 173432832 22:14:05 INFO - PROCESS | 5452 | 22:14:08 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44120/tests/kraken/driver.html?testName=audio-dft) 22:14:09 INFO - PROCESS | 5452 | RSS: Main: 172756992 22:14:09 INFO - PROCESS | 5452 | 22:14:12 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44120/tests/kraken/driver.html?testName=audio-fft) 22:14:12 INFO - PROCESS | 5452 | RSS: Main: 169013248 22:14:12 INFO - PROCESS | 5452 | 22:14:15 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44120/tests/kraken/driver.html?testName=audio-oscillator) 22:14:15 INFO - PROCESS | 5452 | RSS: Main: 169721856 22:14:15 INFO - PROCESS | 5452 | 22:14:17 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44120/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:14:18 INFO - PROCESS | 5452 | RSS: Main: 169996288 22:14:18 INFO - PROCESS | 5452 | 22:14:21 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44120/tests/kraken/driver.html?testName=imaging-darkroom) 22:14:22 INFO - PROCESS | 5452 | RSS: Main: 170287104 22:14:22 INFO - PROCESS | 5452 | 22:14:25 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44120/tests/kraken/driver.html?testName=imaging-desaturate) 22:14:26 INFO - PROCESS | 5452 | RSS: Main: 167555072 22:14:26 INFO - PROCESS | 5452 | 22:14:29 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44120/tests/kraken/driver.html?testName=json-parse-financial) 22:14:30 INFO - PROCESS | 5452 | RSS: Main: 169082880 22:14:30 INFO - PROCESS | 5452 | 22:14:31 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44120/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:14:32 INFO - PROCESS | 5452 | RSS: Main: 169230336 22:14:32 INFO - PROCESS | 5452 | 22:14:34 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44120/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:14:35 INFO - PROCESS | 5452 | RSS: Main: 169537536 22:14:35 INFO - PROCESS | 5452 | 22:14:37 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44120/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:14:38 INFO - PROCESS | 5452 | RSS: Main: 170070016 22:14:38 INFO - PROCESS | 5452 | 22:14:40 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:14:41 INFO - PROCESS | 5452 | RSS: Main: 169857024 22:14:41 INFO - PROCESS | 5452 | 22:14:44 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:14:44 INFO - PROCESS | 5452 | RSS: Main: 169893888 22:14:44 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | Cycle 1(1): loaded http://localhost:44120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44120/tests/kraken/driver.html?testName=ai-astar) 22:14:46 INFO - PROCESS | 5452 | RSS: Main: 170831872 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | __start_tp_report 22:14:46 INFO - PROCESS | 5452 | _x_x_mozilla_page_load 22:14:46 INFO - PROCESS | 5452 | _x_x_mozilla_page_load_details 22:14:46 INFO - PROCESS | 5452 | |i|pagename|runs| 22:14:46 INFO - PROCESS | 5452 | |0;ai-astar;106;116;109;114;117;117;118;115;115;115 22:14:46 INFO - PROCESS | 5452 | |1;audio-beat-detection;151;123;147;195;123;151;155;126;190;123 22:14:46 INFO - PROCESS | 5452 | |2;audio-dft;163;163;163;165;173;165;163;164;165;164 22:14:46 INFO - PROCESS | 5452 | |3;audio-fft;88;82;77;138;78;84;77;77;167;77 22:14:46 INFO - PROCESS | 5452 | |4;audio-oscillator;84;85;140;86;88;86;134;86;86;146 22:14:46 INFO - PROCESS | 5452 | |5;imaging-gaussian-blur;117;118;118;117;118;117;117;117;118;118 22:14:46 INFO - PROCESS | 5452 | |6;imaging-darkroom;148;147;148;147;147;147;149;149;150;147 22:14:46 INFO - PROCESS | 5452 | |7;imaging-desaturate;96;95;96;95;96;97;95;95;96;96 22:14:46 INFO - PROCESS | 5452 | |8;json-parse-financial;65;65;63;63;65;65;64;64;63;63 22:14:46 INFO - PROCESS | 5452 | |9;json-stringify-tinderbox;65;66;66;66;66;66;66;69;66;65 22:14:46 INFO - PROCESS | 5452 | |10;stanford-crypto-aes;80;79;85;79;91;86;80;79;84;82 22:14:46 INFO - PROCESS | 5452 | |11;stanford-crypto-ccm;135;128;134;141;140;132;131;132;173;133 22:14:46 INFO - PROCESS | 5452 | |12;stanford-crypto-pbkdf2;168;169;169;164;167;166;165;175;167;165 22:14:46 INFO - PROCESS | 5452 | |13;stanford-crypto-sha256-iterative;69;68;69;69;68;76;69;69;68;67 22:14:46 INFO - PROCESS | 5452 | __end_tp_report 22:14:46 INFO - PROCESS | 5452 | __start_cc_report 22:14:46 INFO - PROCESS | 5452 | _x_x_mozilla_cycle_collect,1005 22:14:46 INFO - PROCESS | 5452 | __end_cc_report 22:14:46 INFO - PROCESS | 5452 | __startTimestamp1469078086897__endTimestamp 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | ------- Summary: start ------- 22:14:46 INFO - PROCESS | 5452 | Number of tests: 14 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.50 stddev:3.79 (3.3%) stddev-sans-first:2.62 22:14:46 INFO - PROCESS | 5452 | Values: 106.0 116.0 109.0 114.0 117.0 117.0 118.0 115.0 115.0 115.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:151.00 stddev:26.66 (17.7%) stddev-sans-first:28.26 22:14:46 INFO - PROCESS | 5452 | Values: 151.0 123.0 147.0 195.0 123.0 151.0 155.0 126.0 190.0 123.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.01 (1.8%) stddev-sans-first:3.12 22:14:46 INFO - PROCESS | 5452 | Values: 163.0 163.0 163.0 165.0 173.0 165.0 163.0 164.0 165.0 164.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#3] audio-fft Cycles:10 Average:94.50 Median:77.50 stddev:31.54 (40.7%) stddev-sans-first:33.37 22:14:46 INFO - PROCESS | 5452 | Values: 88.0 82.0 77.0 138.0 78.0 84.0 77.0 77.0 167.0 77.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:86.00 stddev:26.32 (30.6%) stddev-sans-first:27.09 22:14:46 INFO - PROCESS | 5452 | Values: 84.0 85.0 140.0 86.0 88.0 86.0 134.0 86.0 86.0 146.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 22:14:46 INFO - PROCESS | 5452 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 22:14:46 INFO - PROCESS | 5452 | Values: 148.0 147.0 148.0 147.0 147.0 147.0 149.0 149.0 150.0 147.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 22:14:46 INFO - PROCESS | 5452 | Values: 96.0 95.0 96.0 95.0 96.0 97.0 95.0 95.0 96.0 96.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.50 stddev:0.94 (1.5%) stddev-sans-first:0.93 22:14:46 INFO - PROCESS | 5452 | Values: 65.0 65.0 63.0 63.0 65.0 65.0 64.0 64.0 63.0 63.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.09 22:14:46 INFO - PROCESS | 5452 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 66.0 69.0 66.0 65.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:3.98 (4.8%) stddev-sans-first:4.12 22:14:46 INFO - PROCESS | 5452 | Values: 80.0 79.0 85.0 79.0 91.0 86.0 80.0 79.0 84.0 82.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:134.50 stddev:12.95 (9.6%) stddev-sans-first:13.69 22:14:46 INFO - PROCESS | 5452 | Values: 135.0 128.0 134.0 141.0 140.0 132.0 131.0 132.0 173.0 133.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.50 stddev:3.14 (1.9%) stddev-sans-first:3.32 22:14:46 INFO - PROCESS | 5452 | Values: 168.0 169.0 169.0 164.0 167.0 166.0 165.0 175.0 167.0 165.0 22:14:46 INFO - PROCESS | 5452 | 22:14:46 INFO - PROCESS | 5452 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:2.49 (3.6%) stddev-sans-first:2.64 22:14:46 INFO - PROCESS | 5452 | Values: 69.0 68.0 69.0 69.0 68.0 76.0 69.0 69.0 68.0 67.0 22:14:46 INFO - PROCESS | 5452 | -------- Summary: end -------- 22:14:46 INFO - PROCESS | 5452 | 22:14:47 INFO - TEST-INFO | 5452: exit 0 22:14:47 INFO - TEST-OK | kraken | took 63587ms 22:14:47 INFO - SUITE-END | took 1181s 22:14:48 INFO - Completed test suite (00:19:41) 22:14:48 INFO - javascript benchmark 22:14:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6367.213318936478, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.8283461575, 2660.7871370290377, 2665.9999999999995, 2701.1491380215243, 2708.8103832731704, 4841.540053694902, 4911.36152300201, 4914.778834952427, 4918.213085906255, 4922.655414121013, 4657.51096134906, 4724.645651576128, 4811.735354555498, 4909.09181801367, 4973.626977976657, 4385.035292235711, 4413.3379993001145, 4459.219636563605, 4483.955160448402, 4486.259767138435, 4449.755263460508, 4578.565036321561, 4595.609373203281, 4596.195665758496, 4615.215413379734, 4310.4611923509565, 4394.231009573344, 4398.032432864765, 4433.911321773563, 4435.179491794029, 4374.803133858953, 4375.540568240321, 4380.8685739427865, 4424.690271680984, 4496.055828276066, 4410.0, 4418.5802348776815, 4425.424694789689, 4434.733915965053, 4449.555044495557, 4799.232122860326, 4808.230683090689, 4817.373741413594, 4824.855254342376, 4835.782389792468, 5264.289320941701, 5276.2085687146855, 5282.683039017633, 5289.127293996486, 5311.7344132793205, 5296.602754793406, 5310.867228319285, 5313.256144139785, 5316.680999140064, 5342.866428339284, 4694.95305046952, 4757.738324392191, 4798.95201047992, 4804.015176888729, 4936.2102063669645, 5243.711595862264, 5261.184516399888, 5262.60530460217, 5269.130593452038, 5300.814471493556, 5026.974865125651, 5033.798648054037, 5036.7733451994745, 5043.067032598981, 5091.414487334004, 5068.6451948363265, 5113.488651134931, 5134.024535338273, 5148.716820574904, 5195.68825870449, 4993.4756850530175, 5059.494050594984, 5065.214891691794, 5069.239614057921, 5118.078745825787, 5081.923771143362, 5104.1578139606545, 5106.617003724736, 5121.180611102206, 5135.38375394955, 4168.24971505132, 4214.072903961123, 4278.978605106954, 4317.697761156752, 4331.350297455407, 3686.2443199144113, 3773.660370566662, 3796.145867179918, 3798.8860334189467, 3815.065308999313, 4553.271476563734, 4558.88602784933, 4566.1552612766745, 4569.497355290915, 4611.446626404786, 5037.5214354636255, 5124.128898087334, 5269.683818970874, 5273.578113750891, 5276.34045744282, 4483.417155769795, 4493.078918821634, 4502.279635258343, 4549.226631472658, 4555.088982203572, 4669.859904202879, 4670.602998745077, 4674.135284972291, 4682.297655351725, 4705.12955103307, 4801.927971080367, 4808.110499557453, 4851.199552074009, 4852.684575502581, 4888.388951381077, 5137.486251374833, 5139.357580302462, 5171.3277273954145, 5205.843824685266, 5210.947890521198, 4833.540813622701, 4854.053459575349, 4867.90264194707, 4872.0, 4916.606671466203, 4951.084049450863, 5034.572061374824, 5088.262201980618, 5099.796008159632, 5127.948720512747, 5126.820561280338, 5161.251618515369, 5176.767045482887, 5196.246544251138, 5220.660657057279, 4935.3584034076775, 4940.629452791127, 4957.776900039579, 4958.72727000004, 5022.27177059317, 4867.58625516835, 4940.5800506955875, 4942.20924652054, 4942.777575009061, 4998.575121114746, 4963.454020057863, 5003.699778013331, 5017.397912250553, 5031.823886163967, 5040.49595040493, 5014.799408023784, 5033.295338652665, 5044.873878153076, 5070.036693028313, 5095.490450954875, 4850.223964165858, 4922.581580565692, 4923.901521969469, 4939.135651261086, 5009.198528235464], "value": 4739.305136515185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.1674238415225, 548.5858177076307, 555.9583031272655, 560.5263552298309, 588.7703795519751, 35260.0, 39960.20079598406, 40020.1995960081, 40074.0, 40086.0, 39876.80061599688, 40256.79871600645, 40406.7979660102, 40424.0, 40437.393439098436, 7606.88589671154, 7823.178566250519, 7830.060392752849, 7842.176571460001, 7855.567943763091, 7771.300582947533, 7805.219478052178, 7868.724594639189, 7869.606519674022, 7871.094824095245, 7895.328897043758, 7910.881336779953, 7930.325922296612, 7939.682412703485, 7961.36309095271, 7802.921970780277, 7857.764267071997, 7861.095973962982, 7866.213378662145, 7887.369010479148, 7822.491538050009, 7843.0, 7860.6069696515515, 7867.016622922135, 7873.0, 37849.0, 37898.43152352717, 38246.42630360547, 38279.808600956814, 38322.233555328734, 2406.843555168926, 2735.7811375089946, 2747.2582402751145, 2829.4765468388414, 2957.1128661401494, 25655.0, 26670.5999410009, 28280.71719282822, 28431.147065588066, 28436.431271374662, 3181.7772755907095, 3208.2941752814577, 3214.4214041472524, 3232.2565809863627, 3261.445554255782, 227344.0, 228782.0, 230118.9999999983, 230490.0, 230988.9999999983, 31711.682883171336, 31787.523187152212, 31886.52170217402, 31960.200994975312, 32110.0, 34281.31437371238, 34327.313453730785, 34594.65405345965, 34632.0, 34819.65180348215, 12322.81515777264, 12338.629841104781, 12362.134650574373, 12368.505259789688, 12372.876271237352, 10342.482875856178, 10360.585576577003, 10365.63720269787, 10376.896231037745, 10376.948115259527, 7860.5676687782725, 7893.368530517545, 7991.560464174526, 8034.758957231175, 8071.0, 3099.891503797356, 3165.509346051366, 3197.424463596575, 3208.6630903755236, 3218.0, 859.4714250735752, 920.2729843423621, 962.7256231973994, 979.1970584120952, 984.1880448629765, 28272.575911360935, 28450.430991380057, 28907.855460722563, 29216.707832921824, 29497.557536636967, 958.9616415343447, 995.3530205366569, 1001.6694490818013, 1034.6792494326783, 1049.4647729657777, 14485.0, 15031.774523382159, 15372.538823835303, 15517.22413879324, 15573.221338933008, 431632.0, 435995.0, 438046.0, 439010.0, 440414.0, 50052.74973625181, 50119.49880501221, 50620.49379506158, 50747.746261269196, 50896.0, 1176.2236923630362, 1176.335370515656, 1204.4098391788136, 1220.1641875315615, 1225.7609766095704, 24226.53122819834, 27725.86137069302, 28037.34614527337, 28204.576931346455, 28340.57489137706, 42740.786296069564, 42814.35778463388, 42893.356599651655, 42958.14083718371, 43072.0, 360009.0, 360961.0, 361718.0, 362139.0, 362154.0, 25333.0, 25478.59867707294, 25623.871880640476, 25794.484110318062, 25836.224913252634, 39632.2073558533, 42055.57944420516, 43321.13357732891, 43367.0, 43860.780696097594, 36399.63600363962, 36451.81774091112, 36526.634733652325, 36854.63145368512, 37336.81331593324, 36985.44521832228, 37501.2499749998, 37747.81126094352, 38157.80921095377, 38449.4232586517, 35295.8226513351, 35358.292834143685, 35764.0, 35845.1038724034, 36265.0, 31486.52770208403, 33546.66453335436, 33612.327753445286, 33659.831700841336, 33905.0, 25902.481950361263, 25982.74017259803, 25987.74012259853, 26081.870760371676, 26150.607740884283], "value": 16299.381410340911, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.4682975536695, 362.7932078715132, 366.6370293409524, 375.6787946305907, 381.207089254351, 16107.194640267984, 17484.825151748493, 17569.648607027866, 18072.81927180728, 18130.18414171362, 16578.419755308565, 17030.23363948622, 17289.0, 17400.21699023544, 17465.650686986253, 5063.569596584285, 5247.658902171346, 5286.867828304285, 5293.841184764463, 5298.0, 3832.7125465590193, 5153.974230128844, 5908.822735317947, 6151.692415379235, 6186.505079593644, 6170.352113028135, 6222.657753823538, 6225.782097626584, 6235.282942461629, 6249.468795152395, 6069.180660610805, 6206.906896396557, 6212.471939885115, 6229.283632382266, 6265.185525881629, 4571.748553829538, 4833.806647734086, 5402.6758394496455, 5415.891682166334, 5430.728463576845, 12251.081168912368, 12376.381180941007, 17002.979821210643, 20632.58734825295, 21056.894715526323, 1823.8085001074828, 1862.850971922243, 1971.9507012324664, 2310.861348319106, 2440.9145679901117, 9044.728658140266, 9051.864222036675, 9145.588448519833, 9166.86249706255, 9336.439813611205, 1644.8601868841163, 1655.9172041397883, 1690.5097521718687, 1694.6102396448887, 1706.7695861058721, 67028.0, 68900.31099689039, 69985.65007174983, 70339.29660703379, 70872.645636772, 9603.759906002266, 9721.611135554498, 9778.364406313567, 9914.454704991294, 9919.50402479873, 13657.453701852013, 13767.31163441824, 13794.103383280255, 13863.168209907237, 13885.305734713224, 6836.0, 6853.623050732158, 6953.860922781516, 7022.508424410345, 7173.995640610318, 6507.577007494498, 6642.900356494656, 6668.833279167962, 6681.665916704243, 6971.6165610891885, 4138.193052354822, 4215.641670457984, 4226.4716910386205, 4375.737455752601, 4432.312991486325, 1703.2505697493064, 1753.9386121485686, 1765.9823401766075, 1812.3203798575535, 1848.8243616856378, 797.0395673213764, 815.1970309245388, 832.7085520067927, 902.4269588811021, 963.9277054220961, 16845.410410635814, 17026.0, 17307.567310817078, 17674.911625442048, 17731.29074836992, 800.2597597222546, 859.1365677494078, 873.8558137907174, 890.8841850559386, 892.4333048514111, 9493.952530237304, 9850.556724947395, 9935.65225217114, 9943.80112397748, 9950.10449059588, 423853.0, 427213.0, 430006.0, 433394.0, 433796.0, 79525.20474795294, 84377.57811210904, 86394.56802715946, 88196.5590172045, 88487.0, 825.8224481736455, 869.1569177897429, 873.9431936924079, 874.5059041641452, 904.4573256046451, 15268.923655382096, 15587.298571564534, 16093.839061609702, 16383.754243686115, 16438.75341869849, 38506.422403664525, 38865.805670971466, 38944.80527597344, 39344.80327598344, 40029.79985100056, 49468.0, 53203.201951971525, 54123.72938135442, 54476.0, 55372.44627553834, 6312.621242725451, 6730.293319201413, 6881.552699074544, 6948.722051117898, 7944.165862584346, 9614.95192524033, 11620.709482262673, 11727.765444690887, 11908.52365905354, 12138.696532586757, 9879.0, 10116.949415252877, 10463.11063559606, 10532.947335263274, 10664.146868250366, 4704.223803072591, 10240.795184096127, 10257.897421025695, 10300.484975751333, 10320.329178603366, 9582.520873956413, 9760.0, 10022.849657255292, 10472.947635261775, 10501.264911456125, 7491.7264065107975, 7527.510711803715, 7545.434092442979, 7619.428542859197, 7667.731629392944, 8842.513661748666, 9799.804003920024, 9921.851172232278, 10540.420276884844, 10725.570977161138], "value": 8217.774795020467, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.807246985422, 1421.5095791951776, 1468.7870258812472, 1675.137304288291, 1690.467502736637, 6931.72273109075, 7546.28310310521, 7560.281773231541, 8111.269985701286, 8130.3902207334395, 7534.246575342477, 7789.493682910621, 7793.53238805672, 7794.064712234525, 7811.453198276123, 2037.1851259496173, 2060.186226440555, 2068.834493240545, 2073.8963051847422, 2074.52285974226, 2127.7765834587376, 2139.657654775236, 2164.415607785897, 2204.7574766775642, 2205.3494219205295, 2119.1841141160685, 2146.946326341846, 2151.279321427324, 2152.365052309565, 2203.790639889216, 2143.7062343292528, 2144.8391370647264, 2156.1806513524916, 2157.1802714968367, 2158.6006588781124, 2064.1227478321653, 2084.5101401170714, 2102.737157855268, 2113.028007116728, 2117.7246957895527, 7837.529748215125, 7842.058952925629, 7850.411219158586, 7873.448858579902, 7890.56601886896, 4601.861944141681, 4603.10239503297, 4648.814047438098, 4671.906561868744, 4786.425628924517, 2808.4523517914013, 2872.7989040767156, 2900.4779139754837, 2932.164333165059, 2952.70472952703, 888.5290795878195, 935.9298052646011, 939.262678797141, 942.792585631167, 946.394307643109, 10489.213309001856, 10590.470476476145, 10626.787464250672, 10676.145908327315, 10681.519331630096, 3996.820143093568, 4249.91500170001, 4256.233877902007, 4313.61177494027, 4314.80583373749, 9023.774405639911, 9083.318751093562, 9104.681336153202, 9114.316426268057, 9132.589033493508, 4700.2949557566635, 4700.647451441156, 4702.412198475191, 4703.435587729495, 4716.858494245178, 3642.617525159873, 4176.7076304658385, 4262.595053469915, 4277.465316835395, 4297.957020429756, 3586.0, 3640.8725694601094, 3657.5428071491065, 3682.576503702055, 3698.352788262097, 1161.6456980620824, 1208.4199584199635, 1214.5870404062484, 1220.4317452074042, 1226.3439060102803, 657.9407853293227, 775.0466925681443, 781.25780508516, 786.8662327404355, 801.8075661841116, 4725.740084295397, 4819.277108433763, 4848.0788650156355, 5207.453217412193, 5259.631825772236, 867.509856930832, 897.8563429851323, 901.9819603608022, 914.3371055984358, 920.0661328751323, 3224.516322551589, 3312.7846689965077, 3330.0842268375904, 3370.1069216657606, 3372.561566996324, 9345.392549484262, 9771.51142442875, 9853.852192217122, 9889.80220395588, 9891.060349266809, 9608.90391096094, 9713.514324283757, 9748.561314740853, 9804.509774511245, 9809.607615695293, 7335.083114610674, 7421.962890185622, 7508.587027713419, 7521.699132034767, 7542.47202695806, 4817.566419022305, 4844.806207751651, 4928.112939670894, 4970.726610036482, 5107.544349860272, 8850.247728943112, 8947.955260223658, 8949.865752013595, 9032.096790320915, 9087.273018158663, 8984.86522702173, 9075.27397808187, 9126.863097053416, 9147.954260228656, 9244.260459163117, 6402.167718196604, 6559.7376104955265, 6788.898166527605, 6851.280615535297, 6853.828654283683, 7621.047369078865, 7632.771016869503, 7640.961795190989, 7647.502912310682, 7674.270944260286, 6635.9004614929845, 6732.528722989539, 6749.3250674932115, 6807.863842723217, 6963.268856769966, 6365.809025729235, 6411.358864113551, 6418.614883107029, 6433.163688720437, 6602.207735071822, 6040.456358927718, 6091.177691011657, 6125.142480052886, 6134.8159555213415, 6146.0, 4265.893352666209, 4284.1645879053285, 4311.892202694958, 4326.286162783105, 4390.07808360248, 4190.14102109073, 4316.870493885189, 4370.737755734539, 4378.693491455568, 4387.473503179639], "value": 4097.357710407091, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.9896403625873, 297.16941149487195, 302.7895612549278, 305.2338630038602, 306.2649640861932, 5090.211017292317, 5094.261332106847, 5120.257562653418, 5124.692518448886, 5132.4610915853855, 5018.749062546867, 5042.478760619691, 5048.394192696873, 5060.797568097271, 5065.290859279704, 3760.887173384796, 3874.2638898609175, 3956.4263181838614, 3960.6633436157963, 3964.7621142731527, 3927.136030073379, 3941.940870886939, 3946.2107578484274, 3951.802409879509, 3953.655757042605, 3906.5312162540536, 3923.15652134791, 3925.2149570085953, 3928.2732694451474, 3929.6856251499953, 3817.351050321452, 3900.6294402031763, 3917.6669983051474, 3945.3490174121234, 3966.246413181501, 3478.269563391691, 3484.721222302235, 3486.1110416843794, 3490.127468132967, 3496.0910163357457, 4932.235503496928, 4936.605071594264, 4942.357493525855, 4945.455999840015, 4950.603951683856, 4441.977790111061, 4547.840300723295, 4548.158590660705, 4548.295014272793, 4559.726416414993, 5228.738563071869, 5237.6071794615555, 5285.127953887604, 5308.309919710451, 5324.4675532446445, 3802.2889699635275, 3804.1821008483307, 3808.1050953026015, 3832.9616703833162, 3842.7703134996814, 5365.973170134163, 5512.421195774426, 5575.916361254584, 5582.469665381782, 5598.440155984369, 3852.6339997700175, 3875.418687196943, 3881.146147847469, 3892.1048158923604, 3914.0, 3962.1481381503113, 3970.781607011642, 3973.2450834341385, 3976.363781794899, 3986.421968814506, 4451.5103338632725, 4480.61914737251, 4485.215087359699, 4486.798094085774, 4541.545845415498, 5158.303629010111, 5231.450697676765, 5272.578193744491, 5291.841244762663, 5302.522772950453, 1354.525915929417, 1385.452746165259, 1385.840628327735, 1386.2791348498724, 1389.7498450279047, 834.6619619054293, 866.0733015673169, 875.4397185801092, 886.4016788667624, 889.3330002498126, 4463.888402789957, 4521.163584736769, 4659.324397962277, 4717.622590192776, 4726.952730472652, 5445.591580631469, 5473.890522189534, 5486.725663716798, 5491.533219676292, 5509.228707980886, 4576.382188404523, 4699.530046995274, 4700.579201711122, 4716.882077948078, 4742.596879265232, 2842.4173044525824, 2855.729200505755, 2880.5247134223036, 2887.8556072196307, 2890.6675732290637, 5082.856357319647, 5089.923651145235, 5095.617828662865, 5097.8215762448135, 5100.260462232955, 5282.392524859613, 5503.779848806083, 5545.611807173459, 5570.749316280777, 5610.298712660918, 5155.097857874857, 5161.458046905021, 5163.0, 5168.0, 5168.715720635326, 5539.529140023144, 5548.306461692288, 5549.889002220014, 5586.190002449704, 5593.356763972195, 5235.612562670819, 5380.0, 5386.8383948481605, 5394.541463975606, 5406.189071639285, 5112.795488180431, 5127.102971900272, 5144.742762861917, 5145.691258524501, 5189.4032186299055, 3824.6749026333073, 3852.499175107218, 3872.6320999505, 3879.4180872869297, 3888.183481468923, 5368.677879327252, 5458.754356054066, 5497.917531236954, 5518.668879867221, 5612.579056570692, 5202.2196670499725, 5249.742610677446, 5255.290535777621, 5257.579393648422, 5277.736113194402, 5216.686998780086, 5233.424323324507, 5243.5542978847225, 5261.605379596469, 5305.787768489217, 4919.778609962632, 5172.387944088211, 5226.477352264895, 5232.607554433356, 5247.658902171346, 5094.872628184325, 5233.738313084406, 5326.573874089986, 5329.0, 5372.247885295984, 5249.370075590953, 5255.185446255837, 5268.57851371897, 5269.9974009876005, 5275.129603615361], "value": 3992.952286591087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.7772649504635, 620.7889317632004, 652.9673516324183, 734.7391675955035, 739.6301849075461, 13468.865311346895, 14076.929615351935, 14101.153930764149, 14136.293185340717, 14146.0, 13189.472421103144, 13295.933520332408, 13299.867001329983, 13325.46698132076, 13340.599782006531, 621.754407009231, 747.9551226926388, 771.6257615056693, 789.1713700614332, 798.8641930871737, 762.0854974031157, 764.2472164917551, 765.5904091311149, 766.3600893254112, 768.1550294675868, 804.8350088231898, 806.7942674617964, 807.3702512040618, 807.5356669914793, 808.3331251717357, 797.9202079792003, 804.7706403674954, 805.0299389235956, 807.1081454992208, 808.086861846113, 589.669784920446, 591.2904514582475, 593.5192494079766, 594.6610432053731, 595.9374265702082, 13742.862571374259, 13785.793213101811, 13789.310534473336, 13794.586162415144, 13796.793048104286, 13720.176789392668, 13729.725405491934, 13741.862581374258, 13759.243241621707, 13828.308584570832, 10505.894941050645, 10514.526846291936, 10613.681589552325, 10682.252242343038, 11126.499307531181, 3350.7654464187517, 3380.4253276942977, 3391.118309239591, 3391.4743214801747, 3489.91275218119, 59879.40120598825, 60829.0, 62309.68845155791, 63368.99999999954, 64659.3534064658, 10704.398646570311, 10766.246362754531, 10804.621838235624, 11007.779844403067, 11044.502997365138, 19776.505587360145, 19906.800931990783, 19914.103865326095, 20014.399568012985, 20014.89992550028, 6791.456683465311, 6825.1127353443735, 6902.896456553156, 6903.6203008835, 7009.0, 3604.0, 3613.512175856278, 3642.85428582859, 3682.4660424238336, 3738.2897249522503, 2945.23423909785, 2991.685872983349, 3013.050888969967, 3038.5442183672626, 3049.7560195184774, 496.29773869974304, 500.27959737977926, 507.22901190190703, 507.4925074925075, 514.5420575687641, 423.3501575082234, 463.88402899275184, 465.7089319175515, 510.69358384968723, 570.5635189080357, 7875.212478752079, 8149.592520373958, 8243.711470098639, 8339.374546909006, 8408.32733381328, 451.1946176075689, 522.9686218826882, 542.3735585398871, 551.181495479213, 554.3292615934764, 3788.6969042476535, 3825.311443940062, 3855.5951625079524, 3865.7680539167177, 3934.409838524187, 78881.60559197167, 80022.0, 93846.5307673471, 94659.52670236604, 95701.52149239209, 49328.75335623299, 55827.0, 57911.42088579144, 81818.0, 84211.0, 37249.0, 45803.0, 46575.30137047947, 72326.27673723195, 73475.0, 8291.461055031403, 8843.955780221058, 9010.729678109405, 9090.36367454272, 9180.17378435944, 44615.55384446244, 45187.20170405024, 46520.7673961628, 46624.30063548982, 48031.75984120057, 37100.81449592735, 50229.497705022484, 62834.37165628285, 63195.6840215796, 64346.67826660837, 9296.116868897443, 9543.665971690958, 9633.0, 11036.889631103586, 11503.654890353302, 10105.39367637944, 10866.402347870942, 11010.50452729613, 11012.724681883017, 11042.613508527164, 11386.54453821871, 11954.342511161622, 12146.210496317712, 12364.010879129468, 12664.556740514037, 11045.83431248548, 11384.43077846121, 11576.94211528937, 11728.0, 11764.58823941158, 11697.590584329508, 12118.394080295773, 12180.0, 12457.937710311391, 12463.376831158224, 10193.643222487177, 10412.375257484575, 10692.14462842955, 10847.566097356017, 10938.835917461085, 8797.296216302553, 9145.496997665192, 10156.18750499973, 10717.35695858251, 10859.945700271448], "value": 6415.256795733789, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 109.0, 114.0, 117.0, 117.0, 118.0, 115.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 147.0, 195.0, 123.0, 151.0, 155.0, 126.0, 190.0, 123.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 165.0, 173.0, 165.0, 163.0, 164.0, 165.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 77.0, 138.0, 78.0, 84.0, 77.0, 77.0, 167.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 140.0, 86.0, 88.0, 86.0, 134.0, 86.0, 86.0, 146.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 149.0, 149.0, 150.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 63.0, 65.0, 65.0, 64.0, 64.0, 63.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 69.0, 66.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 85.0, 79.0, 91.0, 86.0, 80.0, 79.0, 84.0, 82.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 128.0, 134.0, 141.0, 140.0, 132.0, 131.0, 132.0, 173.0, 133.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 169.0, 164.0, 167.0, 166.0, 165.0, 175.0, 167.0, 165.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 69.0, 68.0, 76.0, 69.0, 69.0, 68.0, 67.0], "value": 69.2, "unit": "score"}]}]} 22:14:48 INFO - Return code: 0 22:14:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:14:48 ERROR - # TBPL SUCCESS # 22:14:48 INFO - Running post-action listener: _resource_record_post_action 22:14:48 INFO - [mozharness: 2016-07-21 05:14:48.215572Z] Finished run-tests step (success) 22:14:48 INFO - Running post-run listener: _resource_record_post_run 22:14:48 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547262464; Read time: 300; Write time: 665572 22:14:48 INFO - TinderboxPrint: CPU usage
13.3% 22:14:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 300 22:14:48 INFO - TinderboxPrint: I/O write bytes / time
547,262,464 / 665,572 22:14:48 INFO - TinderboxPrint: CPU idle
8,291.6 (86.7%) 22:14:48 INFO - TinderboxPrint: CPU user
1,218.6 (12.7%) 22:14:48 INFO - TinderboxPrint: Swap in / out
0 / 0 22:14:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258072576; Read time: 0; Write time: 325096 22:14:48 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289189888; Read time: 300; Write time: 340476 22:14:48 INFO - Running post-run listener: _upload_blobber_files 22:14:48 INFO - Blob upload gear active. 22:14:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:14:48 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 22:14:48 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'] 22:14:48 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 22:14:49 INFO - (blobuploader) - INFO - Open directory for files ... 22:14:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:14:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:14:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:14:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:14:50 INFO - (blobuploader) - INFO - Done attempting. 22:14:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:14:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:14:54 INFO - (blobuploader) - INFO - Done attempting. 22:14:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:14:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:14:54 INFO - (blobuploader) - INFO - Done attempting. 22:14:54 INFO - (blobuploader) - INFO - Iteration through files over. 22:14:54 INFO - Return code: 0 22:14:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:14:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:14:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d1644546404fe59a1524f1b3c233d600226782128f4b56971038ba8f24815014ce549f3fb522559cca3702de31ca527cd011fcf7e5b500a85fe280abe94346e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b717834b2b6af347df4d4263934bee48f9dd0050cd062490ce7b052ea028fb107b566c0cd1fed56649679c7ffdea6e4719e9488fe3b3b8e28dbb08c3840f680c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1700e4e0ccaaef7121df50b80eb460a241793de00df5723fa8234d928a1536eb51dbb63cae9d8ecd4138cce5f2e0d0ec682eaf57f2760f293954f7dca097c523"} 22:14:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:14:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:14:54 INFO - Contents: 22:14:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d1644546404fe59a1524f1b3c233d600226782128f4b56971038ba8f24815014ce549f3fb522559cca3702de31ca527cd011fcf7e5b500a85fe280abe94346e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b717834b2b6af347df4d4263934bee48f9dd0050cd062490ce7b052ea028fb107b566c0cd1fed56649679c7ffdea6e4719e9488fe3b3b8e28dbb08c3840f680c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1700e4e0ccaaef7121df50b80eb460a241793de00df5723fa8234d928a1536eb51dbb63cae9d8ecd4138cce5f2e0d0ec682eaf57f2760f293954f7dca097c523"} 22:14:54 INFO - Running post-run listener: copy_logs_to_upload_dir 22:14:54 INFO - Copying logs to upload dir... 22:14:54 INFO - mkdir: /builds/slave/test/build/upload/logs 22:14:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.699824 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-20 22:14:54.121484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 22:14:54.127354) ========= 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=826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117 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/7d1644546404fe59a1524f1b3c233d600226782128f4b56971038ba8f24815014ce549f3fb522559cca3702de31ca527cd011fcf7e5b500a85fe280abe94346e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b717834b2b6af347df4d4263934bee48f9dd0050cd062490ce7b052ea028fb107b566c0cd1fed56649679c7ffdea6e4719e9488fe3b3b8e28dbb08c3840f680c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1700e4e0ccaaef7121df50b80eb460a241793de00df5723fa8234d928a1536eb51dbb63cae9d8ecd4138cce5f2e0d0ec682eaf57f2760f293954f7dca097c523"} build_url:https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/WU40-pKsSU2-tXtDsUp6KA/artifacts/public/build/firefox-50.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/7d1644546404fe59a1524f1b3c233d600226782128f4b56971038ba8f24815014ce549f3fb522559cca3702de31ca527cd011fcf7e5b500a85fe280abe94346e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b717834b2b6af347df4d4263934bee48f9dd0050cd062490ce7b052ea028fb107b566c0cd1fed56649679c7ffdea6e4719e9488fe3b3b8e28dbb08c3840f680c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1700e4e0ccaaef7121df50b80eb460a241793de00df5723fa8234d928a1536eb51dbb63cae9d8ecd4138cce5f2e0d0ec682eaf57f2760f293954f7dca097c523"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 22:14:54.156256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 22:14:54.156591) ========= 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=826874ccc97bd7bf541b4875000001d5-1469075955.762537-1160027117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 22:14:54.241153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 22:14:54.241781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 22:14:54.242434) ========= ========= Total master_lag: 0.17 =========