builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1469465836.15 results: success (0) buildid: 20160725053009 builduid: d1604a1e5ea84d9697e95657efe31ddc revision: 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:16.145625) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:16.146180) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:16.146523) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:16.162500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:16.162908) ========= 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=920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 09:57:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-07-25 09:57:16 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:16.311367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:16.311731) ========= 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=920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018065 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:16.361904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:16.362306) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f --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 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f --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=920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 09:57:16,574 truncating revision to first 12 chars 2016-07-25 09:57:16,574 Setting DEBUG logging. 2016-07-25 09:57:16,574 attempt 1/10 2016-07-25 09:57:16,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1bb05a19ff9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 09:57:16,944 unpacking tar archive at: fx-team-1bb05a19ff9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.789517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:17.169684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:17.170299) ========= script_repo_revision: 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:17.170772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:17.171269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 09:57:17.183513) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-25 09:57:17.183880) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:17 INFO - MultiFileLogger online at 20160725 09:57:17 in /builds/slave/test 09:57:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:57:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:17 INFO - {'append_to_log': False, 09:57:17 INFO - 'base_work_dir': '/builds/slave/test', 09:57:17 INFO - 'blob_upload_branch': 'Fx-Team', 09:57:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:17 INFO - 'branch': 'Fx-Team', 09:57:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:17 INFO - 'config_files': ('talos/linux_config.py',), 09:57:17 INFO - 'default_actions': ('clobber', 09:57:17 INFO - 'read-buildbot-config', 09:57:17 INFO - 'download-and-extract', 09:57:17 INFO - 'populate-webroot', 09:57:17 INFO - 'create-virtualenv', 09:57:17 INFO - 'install', 09:57:17 INFO - 'run-tests'), 09:57:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:17 INFO - 'download_minidump_stackwalk': True, 09:57:17 INFO - 'download_symbols': 'ondemand', 09:57:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:17 INFO - 'installer_path': 'installer.exe', 09:57:17 INFO - 'log_level': 'info', 09:57:17 INFO - 'log_name': 'talos', 09:57:17 INFO - 'log_to_console': True, 09:57:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:17 INFO - 'opt_config_files': (), 09:57:17 INFO - 'pip_index': False, 09:57:17 INFO - 'sps_profile': False, 09:57:17 INFO - 'sps_profile_interval': 0, 09:57:17 INFO - 'suite': 'dromaeojs', 09:57:17 INFO - 'system_bits': '32', 09:57:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:17 INFO - 'title': 'talos-linux64-ix-053', 09:57:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:17 INFO - 'use_talos_json': True, 09:57:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:17 INFO - 'work_dir': 'build'} 09:57:17 INFO - [mozharness: 2016-07-25 16:57:17.497683Z] Running clobber step. 09:57:17 INFO - Running pre-action listener: _resource_record_pre_action 09:57:17 INFO - Running main action method: clobber 09:57:17 INFO - rmtree: /builds/slave/test/build 09:57:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:17 INFO - Running post-action listener: _resource_record_post_action 09:57:17 INFO - [mozharness: 2016-07-25 16:57:17.971070Z] Finished clobber step (success) 09:57:17 INFO - [mozharness: 2016-07-25 16:57:17.971171Z] Running read-buildbot-config step. 09:57:17 INFO - Running pre-action listener: _resource_record_pre_action 09:57:17 INFO - Running main action method: read_buildbot_config 09:57:17 INFO - Using buildbot properties: 09:57:17 INFO - { 09:57:17 INFO - "project": "", 09:57:17 INFO - "product": "firefox", 09:57:17 INFO - "script_repo_revision": "production", 09:57:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:57:17 INFO - "repository": "", 09:57:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:57:17 INFO - "buildid": "20160725053009", 09:57:17 INFO - "pgo_build": "True", 09:57:17 INFO - "basedir": "/builds/slave/test", 09:57:17 INFO - "buildnumber": 1354, 09:57:17 INFO - "slavename": "talos-linux64-ix-053", 09:57:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:57:17 INFO - "platform": "ubuntu64_hw", 09:57:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:57:17 INFO - "branch": "fx-team", 09:57:17 INFO - "repo_path": "integration/fx-team", 09:57:17 INFO - "revision": "1bb05a19ff9d70ed1d858d526fdbe27a8408f19f", 09:57:17 INFO - "stage_platform": "linux64-pgo", 09:57:17 INFO - "builduid": "d1604a1e5ea84d9697e95657efe31ddc", 09:57:17 INFO - "slavebuilddir": "test" 09:57:17 INFO - } 09:57:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:57:17 INFO - Running post-action listener: _resource_record_post_action 09:57:17 INFO - [mozharness: 2016-07-25 16:57:17.973625Z] Finished read-buildbot-config step (success) 09:57:17 INFO - [mozharness: 2016-07-25 16:57:17.973715Z] Running download-and-extract step. 09:57:17 INFO - Running pre-action listener: _resource_record_pre_action 09:57:17 INFO - Running main action method: download_and_extract 09:57:17 INFO - mkdir: /builds/slave/test/build/tests 09:57: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')]} 09:57:17 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:57:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:57:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:57:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:18 INFO - Downloaded 1361 bytes. 09:57:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:57:18 INFO - Using the following test package requirements: 09:57:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:57:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:18 INFO - u'jsshell-linux-x86_64.zip'], 09:57:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:57:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:57:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:18 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:57:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:57:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:19 INFO - Downloaded 24307890 bytes. 09:57: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'] 09:57: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 09:57:20 INFO - Return code: 0 09:57:20 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 09:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:57:20 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:57:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:57:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:21 INFO - Downloaded 24307890 bytes. 09:57:21 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'] 09:57:21 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 09:57:23 INFO - Return code: 0 09:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:23 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:57:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:24 INFO - Downloaded 14403289 bytes. 09:57: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'] 09:57: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 09:57:24 INFO - Return code: 0 09:57: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')]} 09:57:24 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:57:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:57:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:57:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/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 09:57:25 INFO - Downloaded 60837310 bytes. 09:57:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:57:25 INFO - mkdir: /builds/slave/test/properties 09:57:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:25 INFO - Contents: 09:57:25 INFO - build_url:https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:57:26 INFO - Running post-action listener: _resource_record_post_action 09:57:26 INFO - Running post-action listener: set_extra_try_arguments 09:57:26 INFO - [mozharness: 2016-07-25 16:57:26.729141Z] Finished download-and-extract step (success) 09:57:26 INFO - [mozharness: 2016-07-25 16:57:26.729410Z] Running populate-webroot step. 09:57:26 INFO - Running pre-action listener: _resource_record_pre_action 09:57:26 INFO - Running main action method: populate_webroot 09:57:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:26 INFO - '--tppagecycles', 09:57:26 INFO - '7'], 09:57:26 INFO - 'tests': ['tsvgm']}}, 09:57:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['damp', 'tps']}, 09:57:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'tests': ['damp', 'tps']}, 09:57:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['dromaeo_dom']}, 09:57:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['basic_compositor_video']}, 09:57:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:57:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore', 09:57:26 INFO - 'tabpaint']}, 09:57:26 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore', 09:57:26 INFO - 'tabpaint']}, 09:57:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore', 09:57:26 INFO - 'tabpaint']}, 09:57:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore', 09:57:26 INFO - 'tabpaint']}, 09:57:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore', 09:57:26 INFO - 'tabpaint']}, 09:57:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore', 09:57:26 INFO - 'tabpaint']}, 09:57:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['tsvgx', 09:57:26 INFO - 'tsvgr_opacity', 09:57:26 INFO - 'tart', 09:57:26 INFO - 'tscrollx', 09:57:26 INFO - 'cart']}, 09:57:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:26 INFO - 'tsvgr_opacity', 09:57:26 INFO - 'tart', 09:57:26 INFO - 'tscrollx', 09:57:26 INFO - 'cart']}, 09:57:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--disable-e10s'], 09:57:26 INFO - 'tests': ['tp5o']}, 09:57:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'tests': ['tp5o']}, 09:57:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--disable-e10s', 09:57:26 INFO - '--xperf_path', 09:57:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:26 INFO - 'tests': ['tp5n']}, 09:57:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--xperf_path', 09:57:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:26 INFO - 'tests': ['tp5n']}}, 09:57:26 INFO - 'talos.zip': {'path': '', 09:57:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:26 INFO - Running post-action listener: _resource_record_post_action 09:57:26 INFO - [mozharness: 2016-07-25 16:57:26.747953Z] Finished populate-webroot step (success) 09:57:26 INFO - [mozharness: 2016-07-25 16:57:26.748041Z] Running create-virtualenv step. 09:57:26 INFO - Running pre-action listener: _resource_record_pre_action 09:57:26 INFO - Running main action method: create_virtualenv 09:57:26 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:26 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 09:57:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:26 INFO - Using real prefix '/usr' 09:57:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:27 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:29 INFO - Installing pip.................done. 09:57:29 INFO - Return code: 0 09:57:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x11bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, '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': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', '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 09:57: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 09:57: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 09:57:29 INFO - Using env: {'DISPLAY': ':0', 09:57:29 INFO - 'HOME': '/home/cltbld', 09:57:29 INFO - 'LANG': 'en_US.UTF-8', 09:57:29 INFO - 'LANGUAGE': 'en_US:en', 09:57:29 INFO - 'LOGNAME': 'cltbld', 09:57:29 INFO - 'MAIL': '/var/mail/cltbld', 09:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:29 INFO - 'MOZ_NO_REMOTE': '1', 09:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:29 INFO - 'NO_EM_RESTART': '1', 09:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:29 INFO - 'PWD': '/builds/slave/test', 09:57:29 INFO - 'SHELL': '/bin/bash', 09:57:29 INFO - 'SHLVL': '1', 09:57:29 INFO - 'TERM': 'linux', 09:57:29 INFO - 'TMOUT': '86400', 09:57:29 INFO - 'USER': 'cltbld', 09:57:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:29 INFO - '_': '/tools/buildbot/bin/python'} 09:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57: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 09:57:29 INFO - Cleaning up... 09:57:29 INFO - Return code: 0 09:57:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x11bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, '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': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', '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 09:57: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 09:57: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 09:57:29 INFO - Using env: {'DISPLAY': ':0', 09:57:29 INFO - 'HOME': '/home/cltbld', 09:57:29 INFO - 'LANG': 'en_US.UTF-8', 09:57:29 INFO - 'LANGUAGE': 'en_US:en', 09:57:29 INFO - 'LOGNAME': 'cltbld', 09:57:29 INFO - 'MAIL': '/var/mail/cltbld', 09:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:29 INFO - 'MOZ_NO_REMOTE': '1', 09:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:29 INFO - 'NO_EM_RESTART': '1', 09:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:29 INFO - 'PWD': '/builds/slave/test', 09:57:29 INFO - 'SHELL': '/bin/bash', 09:57:29 INFO - 'SHLVL': '1', 09:57:29 INFO - 'TERM': 'linux', 09:57:29 INFO - 'TMOUT': '86400', 09:57:29 INFO - 'USER': 'cltbld', 09:57:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:29 INFO - '_': '/tools/buildbot/bin/python'} 09:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:29 INFO - Downloading/unpacking psutil>=3.1.1 09:57:29 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 09:57:29 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 09:57:29 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 09:57:29 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 09:57:29 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 09:57:29 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 09:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:31 INFO - Installing collected packages: psutil 09:57:31 INFO - Running setup.py install for psutil 09:57:31 INFO - building 'psutil._psutil_linux' extension 09:57:31 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 09:57: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 09:57:32 INFO - building 'psutil._psutil_posix' extension 09:57: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 09:57: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 09:57:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:32 INFO - Successfully installed psutil 09:57:32 INFO - Cleaning up... 09:57:32 INFO - Return code: 0 09:57:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x11bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, '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': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', '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 09:57: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 09:57: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 09:57:32 INFO - Using env: {'DISPLAY': ':0', 09:57:32 INFO - 'HOME': '/home/cltbld', 09:57:32 INFO - 'LANG': 'en_US.UTF-8', 09:57:32 INFO - 'LANGUAGE': 'en_US:en', 09:57:32 INFO - 'LOGNAME': 'cltbld', 09:57:32 INFO - 'MAIL': '/var/mail/cltbld', 09:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:32 INFO - 'MOZ_NO_REMOTE': '1', 09:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:32 INFO - 'NO_EM_RESTART': '1', 09:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:32 INFO - 'PWD': '/builds/slave/test', 09:57:32 INFO - 'SHELL': '/bin/bash', 09:57:32 INFO - 'SHLVL': '1', 09:57:32 INFO - 'TERM': 'linux', 09:57:32 INFO - 'TMOUT': '86400', 09:57:32 INFO - 'USER': 'cltbld', 09:57:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:32 INFO - '_': '/tools/buildbot/bin/python'} 09:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:57:34 INFO - Installing collected packages: mozsystemmonitor 09:57:34 INFO - Running setup.py install for mozsystemmonitor 09:57:34 INFO - Successfully installed mozsystemmonitor 09:57:34 INFO - Cleaning up... 09:57:34 INFO - Return code: 0 09:57:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, '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': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', '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 09:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:57:34 INFO - Using env: {'DISPLAY': ':0', 09:57:34 INFO - 'HOME': '/home/cltbld', 09:57:34 INFO - 'LANG': 'en_US.UTF-8', 09:57:34 INFO - 'LANGUAGE': 'en_US:en', 09:57:34 INFO - 'LOGNAME': 'cltbld', 09:57:34 INFO - 'MAIL': '/var/mail/cltbld', 09:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:34 INFO - 'MOZ_NO_REMOTE': '1', 09:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:34 INFO - 'NO_EM_RESTART': '1', 09:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:34 INFO - 'PWD': '/builds/slave/test', 09:57:34 INFO - 'SHELL': '/bin/bash', 09:57:34 INFO - 'SHLVL': '1', 09:57:34 INFO - 'TERM': 'linux', 09:57:34 INFO - 'TMOUT': '86400', 09:57:34 INFO - 'USER': 'cltbld', 09:57:34 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:34 INFO - '_': '/tools/buildbot/bin/python'} 09:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:34 INFO - Downloading/unpacking jsonschema==2.5.1 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:37 INFO - warning: no files found matching '*.txt' 09:57:37 INFO - no previously-included directories found matching 'build' 09:57:37 INFO - no previously-included directories found matching 'dist' 09:57:37 INFO - no previously-included directories found matching '.git*' 09:57:37 INFO - Installing collected packages: jsonschema, functools32 09:57:37 INFO - Running setup.py install for functools32 09:57:37 INFO - warning: no files found matching '*.txt' 09:57:37 INFO - no previously-included directories found matching 'build' 09:57:37 INFO - no previously-included directories found matching 'dist' 09:57:37 INFO - no previously-included directories found matching '.git*' 09:57:37 INFO - Successfully installed jsonschema functools32 09:57:37 INFO - Cleaning up... 09:57:37 INFO - Return code: 0 09:57:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x11bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, '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': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', '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 09:57: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 09:57: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 09:57:37 INFO - Using env: {'DISPLAY': ':0', 09:57:37 INFO - 'HOME': '/home/cltbld', 09:57:37 INFO - 'LANG': 'en_US.UTF-8', 09:57:37 INFO - 'LANGUAGE': 'en_US:en', 09:57:37 INFO - 'LOGNAME': 'cltbld', 09:57:37 INFO - 'MAIL': '/var/mail/cltbld', 09:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:37 INFO - 'MOZ_NO_REMOTE': '1', 09:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:37 INFO - 'NO_EM_RESTART': '1', 09:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:37 INFO - 'PWD': '/builds/slave/test', 09:57:37 INFO - 'SHELL': '/bin/bash', 09:57:37 INFO - 'SHLVL': '1', 09:57:37 INFO - 'TERM': 'linux', 09:57:37 INFO - 'TMOUT': '86400', 09:57:37 INFO - 'USER': 'cltbld', 09:57:37 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:37 INFO - '_': '/tools/buildbot/bin/python'} 09:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:40 INFO - Downloading docopt-0.6.1.tar.gz 09:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:40 INFO - Running setup.py install for blobuploader 09:57:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:40 INFO - Running setup.py install for requests 09:57:40 INFO - Running setup.py install for docopt 09:57:40 INFO - Successfully installed blobuploader requests docopt 09:57:40 INFO - Cleaning up... 09:57:40 INFO - Return code: 0 09:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:40 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')]} 09:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:40 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')]} 09:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:40 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 0x11bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, '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': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', '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 09:57:40 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 09:57:40 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 09:57:40 INFO - Using env: {'DISPLAY': ':0', 09:57:40 INFO - 'HOME': '/home/cltbld', 09:57:40 INFO - 'LANG': 'en_US.UTF-8', 09:57:40 INFO - 'LANGUAGE': 'en_US:en', 09:57:40 INFO - 'LOGNAME': 'cltbld', 09:57:40 INFO - 'MAIL': '/var/mail/cltbld', 09:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:40 INFO - 'MOZ_NO_REMOTE': '1', 09:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:40 INFO - 'NO_EM_RESTART': '1', 09:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:40 INFO - 'PWD': '/builds/slave/test', 09:57:40 INFO - 'SHELL': '/bin/bash', 09:57:40 INFO - 'SHLVL': '1', 09:57:40 INFO - 'TERM': 'linux', 09:57:40 INFO - 'TMOUT': '86400', 09:57:40 INFO - 'USER': 'cltbld', 09:57:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:40 INFO - '_': '/tools/buildbot/bin/python'} 09:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:41 INFO - Running setup.py (path:/tmp/pip-1xIXvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:41 INFO - Running setup.py (path:/tmp/pip-74Wsy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:41 INFO - Running setup.py (path:/tmp/pip-4aL2CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:41 INFO - Running setup.py (path:/tmp/pip-ENvNg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:41 INFO - Running setup.py (path:/tmp/pip-uEmmA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:41 INFO - Running setup.py (path:/tmp/pip-6UY3Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:41 INFO - Running setup.py (path:/tmp/pip-6wsZJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:41 INFO - Running setup.py (path:/tmp/pip-F365TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:41 INFO - Running setup.py (path:/tmp/pip-P6m6IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:41 INFO - Running setup.py (path:/tmp/pip-X9Xa5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:41 INFO - Running setup.py (path:/tmp/pip-Y9HO4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:41 INFO - Running setup.py (path:/tmp/pip-ctSo4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:41 INFO - Running setup.py (path:/tmp/pip-j478HK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:41 INFO - Running setup.py (path:/tmp/pip-eVu3YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:42 INFO - Running setup.py (path:/tmp/pip-2jRk_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:42 INFO - Running setup.py (path:/tmp/pip-otQaG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:42 INFO - Running setup.py (path:/tmp/pip-2pTmLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:42 INFO - Running setup.py install for manifestparser 09:57:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:42 INFO - Running setup.py install for mozcrash 09:57:42 INFO - Running setup.py install for mozdebug 09:57:42 INFO - Running setup.py install for mozdevice 09:57:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:42 INFO - Running setup.py install for mozfile 09:57:42 INFO - Running setup.py install for mozhttpd 09:57:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:42 INFO - Running setup.py install for mozinfo 09:57:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:42 INFO - Running setup.py install for mozInstall 09:57:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Running setup.py install for mozleak 09:57:43 INFO - Running setup.py install for mozlog 09:57:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Running setup.py install for moznetwork 09:57:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Running setup.py install for mozprocess 09:57:43 INFO - Running setup.py install for mozprofile 09:57:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Running setup.py install for mozrunner 09:57:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:43 INFO - Running setup.py install for mozscreenshot 09:57:43 INFO - Running setup.py install for moztest 09:57:43 INFO - Running setup.py install for mozversion 09:57:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:44 INFO - Cleaning up... 09:57:44 INFO - Return code: 0 09:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x11bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, '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': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', '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 09:57: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 09:57: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 09:57:44 INFO - Using env: {'DISPLAY': ':0', 09:57:44 INFO - 'HOME': '/home/cltbld', 09:57:44 INFO - 'LANG': 'en_US.UTF-8', 09:57:44 INFO - 'LANGUAGE': 'en_US:en', 09:57:44 INFO - 'LOGNAME': 'cltbld', 09:57:44 INFO - 'MAIL': '/var/mail/cltbld', 09:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:44 INFO - 'MOZ_NO_REMOTE': '1', 09:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:44 INFO - 'NO_EM_RESTART': '1', 09:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:44 INFO - 'PWD': '/builds/slave/test', 09:57:44 INFO - 'SHELL': '/bin/bash', 09:57:44 INFO - 'SHLVL': '1', 09:57:44 INFO - 'TERM': 'linux', 09:57:44 INFO - 'TMOUT': '86400', 09:57:44 INFO - 'USER': 'cltbld', 09:57:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:44 INFO - '_': '/tools/buildbot/bin/python'} 09:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:44 INFO - Running setup.py (path:/tmp/pip-CiOahC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57: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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:44 INFO - Running setup.py (path:/tmp/pip-YwvbER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57: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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:44 INFO - Running setup.py (path:/tmp/pip-IP8SNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57: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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:44 INFO - Running setup.py (path:/tmp/pip-wwGHSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57: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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:44 INFO - Running setup.py (path:/tmp/pip-PhKdAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:44 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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:44 INFO - Running setup.py (path:/tmp/pip-SpaeeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:44 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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:44 INFO - Running setup.py (path:/tmp/pip-kyPp1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:44 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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:44 INFO - Running setup.py (path:/tmp/pip-f5nB1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:44 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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:44 INFO - Running setup.py (path:/tmp/pip-etgY7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:44 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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:44 INFO - Running setup.py (path:/tmp/pip-cY2VMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57: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)) 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:45 INFO - Running setup.py (path:/tmp/pip-N9zDcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57: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)) 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:45 INFO - Running setup.py (path:/tmp/pip-5nsQ6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57: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)) 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:45 INFO - Running setup.py (path:/tmp/pip-CLmvBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57: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)) 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:45 INFO - Running setup.py (path:/tmp/pip-te4laN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57: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)) 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:45 INFO - Running setup.py (path:/tmp/pip-Oit9kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57: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)) 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:45 INFO - Running setup.py (path:/tmp/pip-5OwK1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57: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)) 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:45 INFO - Running setup.py (path:/tmp/pip-V3Ajcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:47 INFO - Downloading blessings-1.6.tar.gz 09:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:47 INFO - Installing collected packages: blessings 09:57:47 INFO - Running setup.py install for blessings 09:57:47 INFO - Successfully installed blessings 09:57:47 INFO - Cleaning up... 09:57:47 INFO - Return code: 0 09:57:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:47 INFO - Reading from file tmpfile_stdout 09:57:47 INFO - Current package versions: 09:57:47 INFO - argparse == 1.2.1 09:57:47 INFO - blessings == 1.6 09:57:47 INFO - blobuploader == 1.2.4 09:57:47 INFO - docopt == 0.6.1 09:57:47 INFO - functools32 == 3.2.3-2 09:57:47 INFO - jsonschema == 2.5.1 09:57:47 INFO - manifestparser == 1.1 09:57:47 INFO - mozInstall == 1.12 09:57:47 INFO - mozcrash == 0.17 09:57:47 INFO - mozdebug == 0.1 09:57:47 INFO - mozdevice == 0.48 09:57:47 INFO - mozfile == 1.2 09:57:47 INFO - mozhttpd == 0.7 09:57:47 INFO - mozinfo == 0.9 09:57:47 INFO - mozleak == 0.1 09:57:47 INFO - mozlog == 3.3 09:57:47 INFO - moznetwork == 0.27 09:57:47 INFO - mozprocess == 0.23 09:57:47 INFO - mozprofile == 0.28 09:57:47 INFO - mozrunner == 6.12 09:57:47 INFO - mozscreenshot == 0.1 09:57:47 INFO - mozsystemmonitor == 0.3 09:57:47 INFO - moztest == 0.7 09:57:47 INFO - mozversion == 1.4 09:57:47 INFO - psutil == 3.1.1 09:57:47 INFO - requests == 1.2.3 09:57:47 INFO - wsgiref == 0.1.2 09:57:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:47 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')]} 09:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:47 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')]} 09:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:47 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 0x11bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, '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': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', '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 09:57:47 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 09:57:47 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 09:57:47 INFO - Using env: {'DISPLAY': ':0', 09:57:47 INFO - 'HOME': '/home/cltbld', 09:57:47 INFO - 'LANG': 'en_US.UTF-8', 09:57:47 INFO - 'LANGUAGE': 'en_US:en', 09:57:47 INFO - 'LOGNAME': 'cltbld', 09:57:47 INFO - 'MAIL': '/var/mail/cltbld', 09:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:47 INFO - 'MOZ_NO_REMOTE': '1', 09:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:47 INFO - 'NO_EM_RESTART': '1', 09:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:47 INFO - 'PWD': '/builds/slave/test', 09:57:47 INFO - 'SHELL': '/bin/bash', 09:57:47 INFO - 'SHLVL': '1', 09:57:47 INFO - 'TERM': 'linux', 09:57:47 INFO - 'TMOUT': '86400', 09:57:47 INFO - 'USER': 'cltbld', 09:57:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:47 INFO - '_': '/tools/buildbot/bin/python'} 09:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57:48 INFO - Cleaning up... 09:57:48 INFO - Return code: 0 09:57:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x11bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, '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': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', '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 09:57: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 09:57: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 09:57:48 INFO - Using env: {'DISPLAY': ':0', 09:57:48 INFO - 'HOME': '/home/cltbld', 09:57:48 INFO - 'LANG': 'en_US.UTF-8', 09:57:48 INFO - 'LANGUAGE': 'en_US:en', 09:57:48 INFO - 'LOGNAME': 'cltbld', 09:57:48 INFO - 'MAIL': '/var/mail/cltbld', 09:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:48 INFO - 'MOZ_NO_REMOTE': '1', 09:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:48 INFO - 'NO_EM_RESTART': '1', 09:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:48 INFO - 'PWD': '/builds/slave/test', 09:57:48 INFO - 'SHELL': '/bin/bash', 09:57:48 INFO - 'SHLVL': '1', 09:57:48 INFO - 'TERM': 'linux', 09:57:48 INFO - 'TMOUT': '86400', 09:57:48 INFO - 'USER': 'cltbld', 09:57:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:48 INFO - '_': '/tools/buildbot/bin/python'} 09:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:57:48 INFO - Cleaning up... 09:57:48 INFO - Return code: 0 09:57:48 INFO - Running post-action listener: _resource_record_post_action 09:57:48 INFO - Running post-action listener: _start_resource_monitoring 09:57:48 INFO - Starting resource monitoring. 09:57:48 INFO - [mozharness: 2016-07-25 16:57:48.352938Z] Finished create-virtualenv step (success) 09:57:48 INFO - [mozharness: 2016-07-25 16:57:48.353530Z] Running install step. 09:57:48 INFO - Running pre-action listener: _resource_record_pre_action 09:57:48 INFO - Running main action method: install 09:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:48 INFO - Reading from file tmpfile_stdout 09:57:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:48 INFO - Reading from file tmpfile_stdout 09:57:48 INFO - Output received: 09:57:48 INFO - Usage: mozinstall [options] installer 09:57:48 INFO - Options: 09:57:48 INFO - -h, --help show this help message and exit 09:57:48 INFO - -d DEST, --destination=DEST 09:57:48 INFO - Directory to install application into. [default: 09:57:48 INFO - "/builds/slave/test"] 09:57:48 INFO - --app=APP Application being installed. [default: firefox] 09:57:48 INFO - mkdir: /builds/slave/test/build/application 09:57:48 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'] 09:57:48 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 09:58:05 INFO - Reading from file tmpfile_stdout 09:58:05 INFO - Output received: 09:58:05 INFO - /builds/slave/test/build/application/firefox/firefox 09:58:05 INFO - Running post-action listener: _resource_record_post_action 09:58:05 INFO - [mozharness: 2016-07-25 16:58:05.873007Z] Finished install step (success) 09:58:05 INFO - [mozharness: 2016-07-25 16:58:05.873279Z] Running run-tests step. 09:58:05 INFO - Running pre-action listener: _resource_record_pre_action 09:58:05 INFO - Running main action method: run_tests 09:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:05 INFO - Python 2.7.3 09:58:05 INFO - Return code: 0 09:58:05 INFO - grabbing minidump binary from tooltool 09:58:05 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')]} 09:58:05 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 0x147b3b0>, '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 0x147c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:05 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 09:58:05 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 09:58:05 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 09:58:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:05 INFO - Return code: 0 09:58:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:58:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:58:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:58:05 INFO - Using env: {'DISPLAY': ':0', 09:58:05 INFO - 'HOME': '/home/cltbld', 09:58:05 INFO - 'LANG': 'en_US.UTF-8', 09:58:05 INFO - 'LANGUAGE': 'en_US:en', 09:58:05 INFO - 'LOGNAME': 'cltbld', 09:58:05 INFO - 'MAIL': '/var/mail/cltbld', 09:58:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:05 INFO - 'MOZ_NO_REMOTE': '1', 09:58:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:05 INFO - 'NO_EM_RESTART': '1', 09:58:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:05 INFO - 'PWD': '/builds/slave/test', 09:58:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:05 INFO - 'SHELL': '/bin/bash', 09:58:05 INFO - 'SHLVL': '1', 09:58:05 INFO - 'TERM': 'linux', 09:58:05 INFO - 'TMOUT': '86400', 09:58:05 INFO - 'USER': 'cltbld', 09:58:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386', 09:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:05 INFO - '_': '/tools/buildbot/bin/python'} 09:58:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:58:06 INFO - mozversion application_buildid: 20160725053009 09:58:06 INFO - mozversion application_changeset: 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f 09:58:06 INFO - mozversion application_display_name: Nightly 09:58:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:06 INFO - mozversion application_name: Firefox 09:58:06 INFO - mozversion application_remotingname: firefox 09:58:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:58:06 INFO - mozversion application_vendor: Mozilla 09:58:06 INFO - mozversion application_version: 50.0a1 09:58:06 INFO - mozversion platform_buildid: 20160725053009 09:58:06 INFO - mozversion platform_changeset: 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f 09:58:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:58:06 INFO - mozversion platform_version: 50.0a1 09:58:06 INFO - using testdate: 1469465886 09:58:06 INFO - actual date: 1469465886 09:58:06 INFO - starting webserver on 'localhost:45213' 09:58:06 INFO - SUITE-START | Running 2 tests 09:58:06 INFO - TEST-START | dromaeo_css 09:58:06 INFO - operating with platform_type : linux_ 09:58:06 INFO - Initialising browser for dromaeo_css test... 09:58:06 INFO - TEST-INFO | started process 966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmATsBc/profile http://localhost:45213/getInfo.html) 09:58:09 INFO - PROCESS | 966 | JavaScript error: , line 0: uncaught exception: undefined 09:58:10 INFO - PROCESS | 966 | __metrics Screen width/height:1600/1200 09:58:10 INFO - PROCESS | 966 | colorDepth:24 09:58:10 INFO - PROCESS | 966 | Browser inner width/height: 1024/697 09:58:10 INFO - PROCESS | 966 | __metrics 09:58:11 INFO - PROCESS | 966 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:58:11 INFO - PROCESS | 966 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:11 INFO - PROCESS | 966 | console.error: PushService: 09:58:11 INFO - PROCESS | 966 | stateChangeProcessEnqueue: Error transitioning state 09:58:11 INFO - PROCESS | 966 | UnknownError 09:58:12 INFO - TEST-INFO | 966: exit 0 09:58:12 INFO - Browser initialized. 09:58:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:12 INFO - TEST-INFO | started process 1052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmATsBc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:24 INFO - PROCESS | 1052 | RSS: Main: 157466624 09:58:24 INFO - PROCESS | 1052 | 09:59:15 INFO - PROCESS | 1052 | 1469465955926 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:01:23 INFO - PROCESS | 1052 | Cycle 1(1): loaded http://localhost:45213/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45213/tests/dromaeo/cssquery-ext.html) 10:01:24 INFO - PROCESS | 1052 | RSS: Main: 260042752 10:01:24 INFO - PROCESS | 1052 | 10:04:27 INFO - PROCESS | 1052 | Cycle 1(1): loaded http://localhost:45213/tests/dromaeo/cssquery-ext.html (next: http://localhost:45213/tests/dromaeo/cssquery-jquery.html) 10:04:27 INFO - PROCESS | 1052 | RSS: Main: 254849024 10:04:27 INFO - PROCESS | 1052 | 10:07:29 INFO - PROCESS | 1052 | Cycle 1(1): loaded http://localhost:45213/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45213/tests/dromaeo/cssquery-mootools.html) 10:07:30 INFO - PROCESS | 1052 | RSS: Main: 248705024 10:07:30 INFO - PROCESS | 1052 | 10:10:32 INFO - PROCESS | 1052 | Cycle 1(1): loaded http://localhost:45213/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45213/tests/dromaeo/cssquery-prototype.html) 10:10:33 INFO - PROCESS | 1052 | RSS: Main: 231608320 10:10:33 INFO - PROCESS | 1052 | 10:13:35 INFO - PROCESS | 1052 | Cycle 1(1): loaded http://localhost:45213/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45213/tests/dromaeo/cssquery-yui.html) 10:13:36 INFO - PROCESS | 1052 | RSS: Main: 186810368 10:13:36 INFO - PROCESS | 1052 | 10:16:38 INFO - PROCESS | 1052 | Cycle 1(1): loaded http://localhost:45213/tests/dromaeo/cssquery-yui.html (next: http://localhost:45213/tests/dromaeo/cssquery-dojo.html) 10:16:39 INFO - PROCESS | 1052 | RSS: Main: 276664320 10:16:39 INFO - PROCESS | 1052 | 10:16:39 INFO - PROCESS | 1052 | __start_tp_report 10:16:39 INFO - PROCESS | 1052 | _x_x_mozilla_page_load 10:16:39 INFO - PROCESS | 1052 | _x_x_mozilla_page_load_details 10:16:39 INFO - PROCESS | 1052 | |i|pagename|runs| 10:16:39 INFO - PROCESS | 1052 | |0;dojo.html;3043.1935537082677;3061.051074167008;3067.9539806902894;3094.118176319749;3128.5463607776874;5244.108501554735;5293.57651387889;5393.649412788171;5475.4524547545225;5497.367802702685;5432.674039557629;5451.291332126818;5507.752151153198;5572.58205634578;5588.441155884409;4856.708597484162;4867.683600565952;4884.19410797218;4970.751462426882;4977.950220497785;5022.4224214215465;5056.014077254937;5105.259737338084;5110.846674599749;5116.872078198056;4906.362172917497;4957.206846904496;4966.1557535218735;4966.230234313687;4967.304577359155;4792.496787837296;4815.301781241736;4855.126077306083;4879.1461494238365;4919.72941488218;4814.037192561502;4814.085323788469;4826.203676393391;4829.2997515360075;4885.022995400898;5407;5433.782648694048;5446.836594902159;5455.8363249102595;5466;5590.580706446992;5717.085266357363;5798.9130163047585;5812.331581868097;5835.883282334372;5901.468867801876;5902.026165682657;5902.557308201859;5922.289325280951;5923.881522369528;5479.917801232985;5491.450854914477;5496.148097044925;5497.725113744297;5498.5876059295315;5767.971160144172;5786.016377215883;5834.5624078194305;5889.204957330791;5992;5714.028615135437;5716.79991200306;5756.424357564294;5767.134929760569;5768.3654797972185;5802.3037235531165;5850.093235548412;5857.6192547485125;5858.970705146447;5865.032269675541;5580.051391263414;5668.348139963874;5699.458551437607;5714.371419143891;5761.740721667535;5735.053716136791;5743.483086522233;5744;5749.68376739275;5773.88452230953;4344.826206951687;4354.238008348526;4384.7369157850635;4390.517043125254;4433.844815431445;3873.0317420644838;3904.668103211202;3935.2523020626563;3956.7625942443547;3956.9604303957167;5542.97228513863;5547.528460080857;5552.4531312325325;5554;5608.10270356741;5541.806036788693;5898.764049437975;5900.114982752536;5904.321003084614;5944.583879128506;5444.509994100471;5474.863128421821;5502.669839809624;5522;5536.889262214733;5002.59979201663;5009.674371165863;5017.523335283142;5017.8243761468175;5091.66904151229;5762.049261871828;5989.341172471025;5998.130271110665;6010.66941318223;6016.909746353808;5759.539236861125;5837.591368604157;5839.065749480233;5866.67733274674;5929.970350148222;6001.7599296027665;6012.188354572252;6020.157177995172;6023.879522409439;6025.18659980897;5490.780368785204;5710.800121995876;5729.2265544151005;5761.625494342854;5763.7982670606325;5770.913436298543;5803.767849285981;5817.621854579439;5861.238039055066;5911.645301281937;5655.1517272409465;5656.236408084856;5699.544036477155;5702.971485142548;5706.343770466449;5508;5670.773169073191;5688.232088668143;5688.544916406595;5694.487496125369;5545.667259964415;5570.693611851225;5602.5517958562405;5637.126245431965;5698.202251684685;5731.885362292647;5739.139129130664;5789.044807606698;5793.131030345314;5795.33353664334;5348.117560602457;5613.578981576316;5622.7750889963945;5628.774849005994;5630.943690563042 10:16:39 INFO - PROCESS | 1052 | |1;ext.html;587.4125874125874;613.2977740487142;620.5780069552706;640.154995406064;644.9519530762511;31748.523772143435;45336.546634533646;46217.07565848681;46324.53675463244;46380.53619463804;46540;47049.529504704944;47089.52910470894;47127;47174;8302.626381812803;9126.224270936962;9278.304127190453;9284.25725941923;10773.245872788908;10671.146308295356;11110.277831940897;11119.332840029583;11127.944360278187;11131.554737810518;11189.776204475946;11207.495662695157;11215.495302711397;11230.101591872672;11236.325820450798;11120.944395278053;11130.554777808878;11141.164412669;11148.665540033853;11192;10935.671929842038;10980.725481863017;10996.890031099747;11000.284981476178;11022.118230541617;44052.55947440548;44529.33206001913;44612.776936115435;44737.55262447399;44764.552354476364;3519.63043880394;3551.8579256829694;3999.960000399988;4237;4364.10535840152;32209.51685724716;34636.82681586576;34725.30549388998;35059.12352191216;36477.81761091204;4389.429374181368;4487.259602165639;4503.707259028185;4512.774361281956;4562.498125206224;390530;392724;392941;394549;394693;64565.35434645687;64868;64941.675291623236;64949.67525162344;64963.35036649573;37225.25549488995;37440.251194976496;37880.810595946845;39486;39580.604193958265;16389.918050409673;16410.1794910254;16489.91755041241;16519.6696066078;16539.91730041342;11149.944250278697;12128.696782580506;12400.875991239973;12437.440315185839;12489.12576119681;20376.490587735425;20409.652889917554;20497.95020497938;20606.14544690985;20618.27836025762;7062.540934839219;7156.856862862818;7172.892406613905;7262.854742905112;7522.201288349458;923.787528868364;970.3207754571828;971.3394891473865;1034.162328513891;1074.8602681651491;34556.30887382238;34587.48118778221;34877.476837847455;34880.65119348825;35040.82479587637;1085.7394225386008;1107;1120.9495572699248;1127.1039523578775;1154.5151036564664;17466.7599720086;18038.098095095193;18048.9097554514;18111.18499667518;18157.307410014946;652981;663955;664199;665624;665649;62700.05949910755;63389.68305158537;63510.6824465884;63534.682326588074;63652;1237.7586370657634;1295.747329270802;1337.732453509302;1344.2069179184327;1368.3090039529973;34083.31833363369;35626.46560301546;35959.82020089883;36150.8192459036;36304.63695363118;54187;54856.72571637116;54919;54942;54946.72526637341;430128;433147;433325;433743;434494;29228.26929326784;30478.390432190787;30492.237694057825;30497.237569060064;30501;51653.48346516487;52231.73884130555;52390.21414678859;52545.737271313395;53012.20481692855;43318.350224747286;43642.12715745604;44088.338674920546;44133.117337652424;45666.771666142784;43515.129697406504;43620.56379436165;44351.77824110859;45695.543044570455;46077.76961115173;42650.360244596974;42798.57201427946;44105.55894441014;44134.4831896013;44311.55688443203;36582.451263231604;39091.6090839088;39764.80117599393;42845.78577107094;42988.31385642708;29596.704032960257;29890.252743681584;30036.05316851899;30292.394152117275;30377.24056898595 10:16:39 INFO - PROCESS | 1052 | |2;jquery.html;356.2803137661925;377.2266852951449;382.388178913738;391.90398352403656;408.3282999465879;14529.854701452996;18222.817771822294;18687.81312186876;19244.230230790752;19856;18528.629427411444;19507.21971121157;19724.112414941326;19885.204591816346;19897.602047959033;5565.053940830058;5805.883882322351;5809.244798176232;5812.505936995361;5814.854628634275;5708.257926469574;5718.027935250997;5725.370209276976;5739.569532285074;5771.220885180489;5784.479396854283;5802.274715660543;5805.332386775512;5808.854778630526;5815.5638327125425;5337.572994160458;5536.363318218416;5567.359753628344;5665.320161580596;5802.361740208574;5424.810131645413;5480.123180291174;5495.203195536625;5745.310562732457;5783.190353350535;13361.265130417823;13551.39018744159;13660.112092713942;13729.107608005448;13799.034067615272;2152.214441728773;2214.9557008859892;2309.2725791375665;2328.697269354973;2425.7695518925675;9592.520373981342;9927.51087336898;9967.352122112039;10516.421596812172;14580.416783328654;1864.4872660018468;1869.3457289948544;1912.8469722422174;1922.1830721943259;1977.238763076226;80698.93091159887;81907;83345.58327208385;83562.58218708928;86686.56656716739;10827.47798622708;10931.617393391192;10937.343759374464;11157.832632510519;11402.657920262405;15378.769318460232;15414.845851541566;15433.151176685391;15437.614059648598;15453.613659658598;8017.278444939983;8076;8173.95913020443;8238.629261683238;8348.749537513884;7795.376369890395;7895.881561776578;8056.83886322282;8062.355011599058;8082.353411727047;4599.747013914267;4642.187617166982;4663.253879379283;4793.209120495149;4862.149123903303;1811.9275228990957;1948.279136719423;1955.9315423960093;2029.979700202979;2052.230413594902;882.3779235638859;960.6109525642127;972.6741541583507;980.4068538534084;982.5087456271864;18168.45494635163;19772.604547908963;19899.303524376577;19930.103145358495;20154.193832246838;961.990380096204;998.3859926145368;1013.1793247469574;1023.048564834696;1051.831706926888;10429.791404171874;10842.837357439645;10934.726631834108;11093.722656933642;11095.1123910087;439553;474741;494485;500001;503252;92090;94206.0579394211;94648;95039;95275;973.9610415583297;998.3560603410759;1018.8013337399136;1068.9946550267198;1071.5660157636325;16092.919535402716;16503.83496165071;17717;18537.81462185361;18763.718544221574;43444.348334775634;43881.78059109684;44319.33520997252;44447.777761110985;45171;56736.716316418155;56785;57204.713976431514;65384.05771740378;65855.34144658492;7916.960415197887;8129.79675508117;8449.83100338002;8594.570271486526;8900.554972251492;12512.061595380565;13104.737905242033;13262.668433289246;13877.79183312231;13882.722345552831;11759.588414405454;11944.343061131722;11958.64124076279;12007.159498834997;12015.09886758514;11159.553617855196;11418.828717569077;11425;11437;11831.34927578957;11587.420628968686;12278.938605306916;12343.814842777187;12507.499700011898;12571.108645011516;8074.515529068275;8090.7168249111;8193.877091843746;8403.411761176903;8598.097199794182;9784;11604.88395116038;11719.179657423898;11944.283342999448;12099.758004839678 10:16:39 INFO - PROCESS | 1052 | |3;mootools.html;1336.4119787293596;1455.1196526101708;1509.034218100416;1622.2537632688961;1786.9106544672763;8542.103079176683;8671.349648776344;8862.77843053924;9201.815963680723;9228.261739060876;9066.863997040049;9175.220106290973;9177.08229177082;9181.586828592712;9185.357025008252;2387.904483820645;2409.313345696477;2413.5776239158076;2414.130912871365;2416.55293770653;2335.871527066011;2393.6768536247646;2401.6757737705448;2402.25530085674;2404.3147702904675;2347.1550241912896;2369.490559529701;2393.617021276596;2397.928062158138;2398.6761787158684;2311.456807650209;2315.7452680205165;2338.8362814602983;2339.836211465198;2356.752540983198;2303.9654405183937;2314.6065168921155;2336.112277334602;2341.7541158178315;2345.425370784169;9064.274858011344;9109.772255693595;9111.316651251183;9182.67860624875;9197.034311397274;5244.160934250502;5457.290552228224;5468.207109969032;5469.453054694539;5471.206675032098;3286.9835650821833;3337.8664853405835;3386.221169131089;3389.389909816232;3400.1499625093725;1131.3155540897721;1141.2353723005606;1157.7915975124474;1175.9647210583696;1186.3712232516693;12913.806292905614;12929.612111636667;13030.869691303154;13033;13035.15271507349;4448.666350023761;4551.135284295973;4678.69588476748;4703.506131856174;4707.152712511781;10214.336068155546;10232.846507302396;10256.948715256525;10265.486725663686;10270.589176432859;5281.128613778684;5288.497592728685;5289.68261904287;5290.709011004355;5294.54996325309;4282.850100246476;4744.881377965578;4896.436909755424;4906.803727850917;4919.852404427873;3819.217060502646;3859.6526312632;3901.4733011043713;3932.075962148893;3960.4653371795016;1132.9263597866113;1147.73602071524;1148.3807830958308;1149.3908228638834;1154.3997121496775;807.8788181772782;869.4044579463088;990.4107056301489;998.286225348879;1031.9587216511256;6138.355472675394;6155.261368635793;6277.591956522811;6416.533423375956;6445.258795238514;970.9514524273758;1015.1422048369117;1020.6529779874878;1030.2742905633036;1032.87605487342;4326.918270432392;4556.384888040138;4558.247889098328;4590.609798167126;4677.298405239173;10711.571537138427;10883.292585982044;11101.944490277498;11225.60710375133;11226.494807733672;10398.376097434179;11139.777204455866;11145;11194.384308863091;11200.159988000769;8118.431709780259;8519.872201916976;8533.146685331418;8539.23146916768;8561.657533698582;6251.187345645037;6312.179416675803;6313.523380572171;6373.840653983688;6529.347065293433;10439.53022114022;10444.895551044696;10547.683569492621;10583.364998100138;10592.470376480991;10360.222983276435;10420.166386689198;10441.838957009384;10529.947350263199;10589.152867770406;7701.961490192513;8479.321654267767;8637;8718.389712720049;8976.461412315282;8954.462732235826;8955.731328060168;8994.460332380078;9014.954925225333;9043.276537877086;8006.91993080085;8016.478928869605;8082.070561885458;8141.674333026849;8238.134995825592;7882.132965373919;7918.089419716806;7947.245011723877;8020.639071241691;8129.146439623991;7108.537945033556;7143.428525718034;7155.069840920647;7187.8562428752175;7191;5197.350331208599;5336.252924590638;5341.813036543703;5397.271368365377;5480.698561578992;5305.70818604965;5386.326709161355;5434.510894019557;5446.754896029609;5557.972210138923 10:16:39 INFO - PROCESS | 1052 | |4;prototype.html;308.2232773411004;317.6140988698731;323.87530800641747;324.1652744183726;326.05769326646;5391.218273350361;5400.189971504266;5481.671099734019;5487.5609951203905;5514.751836167372;5158.704376552436;5228.555572776309;5324.174752913295;5342.91985620216;5360.544353729928;4180.226658068252;4183.410304084459;4195.748255104703;4197.265478541259;4203.600657937491;4207.621314081732;4220.556841531641;4226.788660566975;4227.7463352198965;4229.6404805591565;3791.7156213283974;3840.1743625120594;4084.8570300039505;4138.97930510347;4189.706720529564;4112;4122.752634841919;4163.771687352239;4165.10450253194;4167.416561681352;3664.4686520454384;3669.889903302905;3675.44868269759;3679.6504332088407;3680.024793429743;5143.434222235588;5154.4587818278915;5180.43015268324;5183.326167598226;5275.235090911796;4745.786439610226;4767.7616119194245;4771.23660214364;4772.856814295576;4777.952220477786;5583.553315734732;5591.189277554732;5602.13166959122;5607.971960140214;5645.379008309083;3960.4653371794725;4032.858849940267;4067.5525692173837;4079.4696689430184;4106.260873042851;5828.708564571754;5833.7374818133285;5842.211301474289;5846.21076154718;5853.941460585383;4151.066010147692;4169.499660040754;4179.97910010448;4186;4191.832326706958;3915.9608403915595;4129.8967525811495;4133.173365326947;4222.746635201836;4229.386738922839;4716.693414928087;4760.857174284777;4772.308015337757;4796.544328288807;4801.0075818535615;5687.146927960839;5725.541956643458;5745.166950792195;5745.741441635137;5745.8563535911935;1331.5872079655337;1333.9666508337368;1396.5112210726368;1418.659521714781;1428.8428272889973;933.8552524358599;956.36401792807;962.6534447598859;970.8058388322222;973.5570315506427;5366.543843773245;5388.838334849961;5427.29445172133;5491.423400542965;5499.772592100206;5659.349174844863;5779.768809247583;5785.652860828363;5797.130430435468;5798.739056742456;5363.659085228693;5412.188171774186;5413.729313534386;5444.863878403072;5470.370907345706;3004.858153901547;3036.802607830484;3049.5120780674984;3054.3127796246113;3076.138681169276;5666.348369937427;5854.326752423441;5866.67733274674;5880.529557635379;5914.881702366015;5831.504322132581;5843.707814609253;5850.444207800252;5853.678047707332;5855;5796.681182534917;5817.447342502455;5846.503047241032;5919;5964.701764911737;5619.286117733966;5822.243108395882;5827.708614569339;5847.38602446737;5890.6760128191645;5785.537157027512;5789.247397838254;5792.21805056312;5793.710314484343;5886.793962211474;5840.737166827588;5982.0727787193055;6009.248843894513;6077.085717998816;6105.382073750548;3985.163115745726;3994.540627827837;4009.7193196477133;4013.097053163015;4031.5162180538523;5922.851928701817;5924.644521328734;5927.288725352985;5935.465808077293;5946.1972633693895;5499.752511136929;5703.857403564944;5726.685032323262;5770.913436298375;5794.159846822272;5625.537360286273;5650.26546548946;5700.686462244616;5717.371089180104;5717.771289148387;5409.729513524387;5497.45025497447;5567;5670.603057785916;5714.314282286152;5690.687012214203;5692.459216374438;5702.173184888251;5708.372079071381;5738.84793202549;5483.533899618417;5609.831705048855;5620.297462817148;5647.491725744702;5663.178839068394 10:16:39 INFO - PROCESS | 1052 | |5;yui.html;719.7732714195025;761.2463660975636;778.4511919097033;809.1665584448019;853.9871901921471;15599.376024959016;15747.842521574796;15826.129562874052;16029.278682459288;16386.09876456796;15105.39578416862;15139.167345795977;15173.54479365618;15210.23948802561;15211.847881521182;807.4267270238138;826.2646244842095;831.6257684042175;832.0805509911552;833.2667252817512;654.3325807676191;792.3265224559136;822.5147163173726;825.0965193113561;833.3916241143969;862.482510493705;864.2222000199807;864.2308345572415;864.9654013839439;865.1607940297932;857.4041041476177;857.4212406625566;857.6355049104105;858.0175698824842;858.0218550852034;496.31260703924966;608.3156448994881;631.9747210111636;632.9841753956142;639.146739103293;14797.852021479863;14851.183184924825;14883.032602880778;14909.701805963929;14912.62718432048;13261.46954121834;13328.400221990034;13488.93255533716;13744.10663306892;14135.081219720789;13234.602961911158;13313.800292995516;13387.598372048757;13391.196528208338;13456.05807593459;4424.734515929054;4433.091216300651;4456.64346852251;4482.753448560328;4593.9310910336035;70298.29701702969;72359.63820180866;72504.63747681228;82566.58716706379;83517.16482835155;11910.821337679941;12309.753804923852;12348.629541113782;12414.193077449936;12647.557335493213;21509.354719358445;21572;21585.352439426842;21617.56764864694;21633.567328653655;8489.108643592457;8522.232999030117;8726.781830454289;8806.779830504289;8871.733847984442;4956.950430495649;5010.473900240495;5038.697678139323;5055.772490237948;5210.869728256748;3525.6474352564537;3630.618785027534;3633.65480279373;3633.9636603633626;3643.9271214576092;646.3762469217133;670.1957650819037;678.4030053552842;683.4190937702913;731;726.7020521586124;731.6634348199781;759.5670467833282;775.6199462263563;781.2656103262915;10040.046195611405;10279.346359502244;10285.588576457008;10376.066154046172;10498.160147188206;621.599068600759;662.6752891083335;724.7390939261861;735.1398863329916;737.0786516853933;4876.853694389174;4902.313676085351;4932.260160975882;4943;4949.529794669501;73820.63089684624;75900.62049689826;131052;134447;135601;87833.56083219544;89067;107999;108121.45939270411;111615;89431;91284.54357728169;91798;92622.07377926135;93822;9782.853257201004;9863.309568330147;9982.60069597237;10147.898521014991;10192.541335639766;55453.16820247619;55721;56092;56856.43143568511;57072;72500.63749681218;78561.4287714231;80896.59551702204;82630.17369826225;83273;13094.345282735634;13248;13498.93250533741;13513.459461621425;13931.58205253844;13408.262545560088;15090.773638395212;15279.236038197823;15706.586407223405;15815.13016784042;12550.937245313715;12603.243805371707;12715.554955576881;13077.607671769862;13447.327633618475;13634.590962271148;13814.516491923136;14878.553643390716;14944.551663450115;15406.38374465009;13265.336733163496;14190.503332383318;14399.712005760035;14428.134311941318;14579.125252484884;11122.555097795997;12047.397630118634;12395.442205100611;12473.189242699196;12488.875111249135;10520.259311247972;11799.17405781587;11896.226745261876;12119.212251203644;12161.574344897886 10:16:39 INFO - PROCESS | 1052 | __end_tp_report 10:16:39 INFO - PROCESS | 1052 | __start_cc_report 10:16:39 INFO - PROCESS | 1052 | _x_x_mozilla_cycle_collect,903 10:16:39 INFO - PROCESS | 1052 | __end_cc_report 10:16:39 INFO - PROCESS | 1052 | __startTimestamp1469466999194__endTimestamp 10:16:39 INFO - PROCESS | 1052 | 10:16:39 INFO - PROCESS | 1052 | ------- Summary: start ------- 10:16:39 INFO - PROCESS | 1052 | Number of tests: 6 10:16:39 INFO - PROCESS | 1052 | 10:16:39 INFO - PROCESS | 1052 | [#0] dojo.html Cycles:165 Average:5391.95 Median:5602.55 stddev:626.79 (11.2%) stddev-sans-first:601.02 10:16:39 INFO - PROCESS | 1052 | Values: 3043.2 3061.1 3068.0 3094.1 3128.5 5244.1 5293.6 5393.6 5475.5 5497.4 5432.7 5451.3 5507.8 5572.6 5588.4 4856.7 4867.7 4884.2 4970.8 4978.0 5022.4 5056.0 5105.3 5110.8 5116.9 4906.4 4957.2 4966.2 4966.2 4967.3 4792.5 4815.3 4855.1 4879.1 4919.7 4814.0 4814.1 4826.2 4829.3 4885.0 5407.0 5433.8 5446.8 5455.8 5466.0 5590.6 5717.1 5798.9 5812.3 5835.9 5901.5 5902.0 5902.6 5922.3 5923.9 5479.9 5491.5 5496.1 5497.7 5498.6 5768.0 5786.0 5834.6 5889.2 5992.0 5714.0 5716.8 5756.4 5767.1 5768.4 5802.3 5850.1 5857.6 5859.0 5865.0 5580.1 5668.3 5699.5 5714.4 5761.7 5735.1 5743.5 5744.0 5749.7 5773.9 4344.8 4354.2 4384.7 4390.5 4433.8 3873.0 3904.7 3935.3 3956.8 3957.0 5543.0 5547.5 5552.5 5554.0 5608.1 5541.8 5898.8 5900.1 5904.3 5944.6 5444.5 5474.9 5502.7 5522.0 5536.9 5002.6 5009.7 5017.5 5017.8 5091.7 5762.0 5989.3 5998.1 6010.7 6016.9 5759.5 5837.6 5839.1 5866.7 5930.0 6001.8 6012.2 6020.2 6023.9 6025.2 5490.8 5710.8 5729.2 5761.6 5763.8 5770.9 5803.8 5817.6 5861.2 5911.6 5655.2 5656.2 5699.5 5703.0 5706.3 5508.0 5670.8 5688.2 5688.5 5694.5 5545.7 5570.7 5602.6 5637.1 5698.2 5731.9 5739.1 5789.0 5793.1 5795.3 5348.1 5613.6 5622.8 5628.8 5630.9 10:16:39 INFO - PROCESS | 1052 | 10:16:39 INFO - PROCESS | 1052 | [#1] ext.html Cycles:180 Average:65984.52 Median:217089.50 stddev:135827.36 (62.6%) stddev-sans-first:136119.64 10:16:39 INFO - PROCESS | 1052 | Values: 587.4 613.3 620.6 640.2 645.0 31748.5 45336.5 46217.1 46324.5 46380.5 46540.0 47049.5 47089.5 47127.0 47174.0 8302.6 9126.2 9278.3 9284.3 10773.2 10671.1 11110.3 11119.3 11127.9 11131.6 11189.8 11207.5 11215.5 11230.1 11236.3 11120.9 11130.6 11141.2 11148.7 11192.0 10935.7 10980.7 10996.9 11000.3 11022.1 44052.6 44529.3 44612.8 44737.6 44764.6 3519.6 3551.9 4000.0 4237.0 4364.1 32209.5 34636.8 34725.3 35059.1 36477.8 4389.4 4487.3 4503.7 4512.8 4562.5 390530.0 392724.0 392941.0 394549.0 394693.0 64565.4 64868.0 64941.7 64949.7 64963.4 37225.3 37440.3 37880.8 39486.0 39580.6 16389.9 16410.2 16489.9 16519.7 16539.9 11149.9 12128.7 12400.9 12437.4 12489.1 20376.5 20409.7 20498.0 20606.1 20618.3 7062.5 7156.9 7172.9 7262.9 7522.2 923.8 970.3 971.3 1034.2 1074.9 34556.3 34587.5 34877.5 34880.7 35040.8 1085.7 1107.0 1120.9 1127.1 1154.5 17466.8 18038.1 18048.9 18111.2 18157.3 652981.0 663955.0 664199.0 665624.0 665649.0 62700.1 63389.7 63510.7 63534.7 63652.0 1237.8 1295.7 1337.7 1344.2 1368.3 34083.3 35626.5 35959.8 36150.8 36304.6 54187.0 54856.7 54919.0 54942.0 54946.7 430128.0 433147.0 433325.0 433743.0 434494.0 29228.3 30478.4 30492.2 30497.2 30501.0 51653.5 52231.7 52390.2 52545.7 53012.2 43318.4 43642.1 44088.3 44133.1 45666.8 43515.1 43620.6 44351.8 45695.5 46077.8 42650.4 42798.6 44105.6 44134.5 44311.6 36582.5 39091.6 39764.8 42845.8 42988.3 29596.7 29890.3 30036.1 30292.4 30377.2 10:16:39 INFO - PROCESS | 1052 | 10:16:39 INFO - PROCESS | 1052 | [#2] jquery.html Cycles:180 Average:28808.18 Median:400.12 stddev:79844.89 (19955.4%) stddev-sans-first:80040.30 10:16:39 INFO - PROCESS | 1052 | Values: 356.3 377.2 382.4 391.9 408.3 14529.9 18222.8 18687.8 19244.2 19856.0 18528.6 19507.2 19724.1 19885.2 19897.6 5565.1 5805.9 5809.2 5812.5 5814.9 5708.3 5718.0 5725.4 5739.6 5771.2 5784.5 5802.3 5805.3 5808.9 5815.6 5337.6 5536.4 5567.4 5665.3 5802.4 5424.8 5480.1 5495.2 5745.3 5783.2 13361.3 13551.4 13660.1 13729.1 13799.0 2152.2 2215.0 2309.3 2328.7 2425.8 9592.5 9927.5 9967.4 10516.4 14580.4 1864.5 1869.3 1912.8 1922.2 1977.2 80698.9 81907.0 83345.6 83562.6 86686.6 10827.5 10931.6 10937.3 11157.8 11402.7 15378.8 15414.8 15433.2 15437.6 15453.6 8017.3 8076.0 8174.0 8238.6 8348.7 7795.4 7895.9 8056.8 8062.4 8082.4 4599.7 4642.2 4663.3 4793.2 4862.1 1811.9 1948.3 1955.9 2030.0 2052.2 882.4 960.6 972.7 980.4 982.5 18168.5 19772.6 19899.3 19930.1 20154.2 962.0 998.4 1013.2 1023.0 1051.8 10429.8 10842.8 10934.7 11093.7 11095.1 439553.0 474741.0 494485.0 500001.0 503252.0 92090.0 94206.1 94648.0 95039.0 95275.0 974.0 998.4 1018.8 1069.0 1071.6 16092.9 16503.8 17717.0 18537.8 18763.7 43444.3 43881.8 44319.3 44447.8 45171.0 56736.7 56785.0 57204.7 65384.1 65855.3 7917.0 8129.8 8449.8 8594.6 8900.6 12512.1 13104.7 13262.7 13877.8 13882.7 11759.6 11944.3 11958.6 12007.2 12015.1 11159.6 11418.8 11425.0 11437.0 11831.3 11587.4 12278.9 12343.8 12507.5 12571.1 8074.5 8090.7 8193.9 8403.4 8598.1 9784.0 11604.9 11719.2 11944.3 12099.8 10:16:39 INFO - PROCESS | 1052 | 10:16:39 INFO - PROCESS | 1052 | [#3] mootools.html Cycles:180 Average:5988.34 Median:4574.43 stddev:3423.50 (74.8%) stddev-sans-first:3415.26 10:16:39 INFO - PROCESS | 1052 | Values: 1336.4 1455.1 1509.0 1622.3 1786.9 8542.1 8671.3 8862.8 9201.8 9228.3 9066.9 9175.2 9177.1 9181.6 9185.4 2387.9 2409.3 2413.6 2414.1 2416.6 2335.9 2393.7 2401.7 2402.3 2404.3 2347.2 2369.5 2393.6 2397.9 2398.7 2311.5 2315.7 2338.8 2339.8 2356.8 2304.0 2314.6 2336.1 2341.8 2345.4 9064.3 9109.8 9111.3 9182.7 9197.0 5244.2 5457.3 5468.2 5469.5 5471.2 3287.0 3337.9 3386.2 3389.4 3400.1 1131.3 1141.2 1157.8 1176.0 1186.4 12913.8 12929.6 13030.9 13033.0 13035.2 4448.7 4551.1 4678.7 4703.5 4707.2 10214.3 10232.8 10256.9 10265.5 10270.6 5281.1 5288.5 5289.7 5290.7 5294.5 4282.9 4744.9 4896.4 4906.8 4919.9 3819.2 3859.7 3901.5 3932.1 3960.5 1132.9 1147.7 1148.4 1149.4 1154.4 807.9 869.4 990.4 998.3 1032.0 6138.4 6155.3 6277.6 6416.5 6445.3 971.0 1015.1 1020.7 1030.3 1032.9 4326.9 4556.4 4558.2 4590.6 4677.3 10711.6 10883.3 11101.9 11225.6 11226.5 10398.4 11139.8 11145.0 11194.4 11200.2 8118.4 8519.9 8533.1 8539.2 8561.7 6251.2 6312.2 6313.5 6373.8 6529.3 10439.5 10444.9 10547.7 10583.4 10592.5 10360.2 10420.2 10441.8 10529.9 10589.2 7702.0 8479.3 8637.0 8718.4 8976.5 8954.5 8955.7 8994.5 9015.0 9043.3 8006.9 8016.5 8082.1 8141.7 8238.1 7882.1 7918.1 7947.2 8020.6 8129.1 7108.5 7143.4 7155.1 7187.9 7191.0 5197.4 5336.3 5341.8 5397.3 5480.7 5305.7 5386.3 5434.5 5446.8 5558.0 10:16:39 INFO - PROCESS | 1052 | 10:16:39 INFO - PROCESS | 1052 | [#4] prototype.html Cycles:180 Average:4748.01 Median:5476.02 stddev:1413.41 (25.8%) stddev-sans-first:1377.53 10:16:39 INFO - PROCESS | 1052 | Values: 308.2 317.6 323.9 324.2 326.1 5391.2 5400.2 5481.7 5487.6 5514.8 5158.7 5228.6 5324.2 5342.9 5360.5 4180.2 4183.4 4195.7 4197.3 4203.6 4207.6 4220.6 4226.8 4227.7 4229.6 3791.7 3840.2 4084.9 4139.0 4189.7 4112.0 4122.8 4163.8 4165.1 4167.4 3664.5 3669.9 3675.4 3679.7 3680.0 5143.4 5154.5 5180.4 5183.3 5275.2 4745.8 4767.8 4771.2 4772.9 4778.0 5583.6 5591.2 5602.1 5608.0 5645.4 3960.5 4032.9 4067.6 4079.5 4106.3 5828.7 5833.7 5842.2 5846.2 5853.9 4151.1 4169.5 4180.0 4186.0 4191.8 3916.0 4129.9 4133.2 4222.7 4229.4 4716.7 4760.9 4772.3 4796.5 4801.0 5687.1 5725.5 5745.2 5745.7 5745.9 1331.6 1334.0 1396.5 1418.7 1428.8 933.9 956.4 962.7 970.8 973.6 5366.5 5388.8 5427.3 5491.4 5499.8 5659.3 5779.8 5785.7 5797.1 5798.7 5363.7 5412.2 5413.7 5444.9 5470.4 3004.9 3036.8 3049.5 3054.3 3076.1 5666.3 5854.3 5866.7 5880.5 5914.9 5831.5 5843.7 5850.4 5853.7 5855.0 5796.7 5817.4 5846.5 5919.0 5964.7 5619.3 5822.2 5827.7 5847.4 5890.7 5785.5 5789.2 5792.2 5793.7 5886.8 5840.7 5982.1 6009.2 6077.1 6105.4 3985.2 3994.5 4009.7 4013.1 4031.5 5922.9 5924.6 5927.3 5935.5 5946.2 5499.8 5703.9 5726.7 5770.9 5794.2 5625.5 5650.3 5700.7 5717.4 5717.8 5409.7 5497.5 5567.0 5670.6 5714.3 5690.7 5692.5 5702.2 5708.4 5738.8 5483.5 5609.8 5620.3 5647.5 5663.2 10:16:39 INFO - PROCESS | 1052 | 10:16:39 INFO - PROCESS | 1052 | [#5] yui.html Cycles:180 Average:21376.68 Median:4469.70 stddev:30781.83 (688.7%) stddev-sans-first:30829.10 10:16:39 INFO - PROCESS | 1052 | Values: 719.8 761.2 778.5 809.2 854.0 15599.4 15747.8 15826.1 16029.3 16386.1 15105.4 15139.2 15173.5 15210.2 15211.8 807.4 826.3 831.6 832.1 833.3 654.3 792.3 822.5 825.1 833.4 862.5 864.2 864.2 865.0 865.2 857.4 857.4 857.6 858.0 858.0 496.3 608.3 632.0 633.0 639.1 14797.9 14851.2 14883.0 14909.7 14912.6 13261.5 13328.4 13488.9 13744.1 14135.1 13234.6 13313.8 13387.6 13391.2 13456.1 4424.7 4433.1 4456.6 4482.8 4593.9 70298.3 72359.6 72504.6 82566.6 83517.2 11910.8 12309.8 12348.6 12414.2 12647.6 21509.4 21572.0 21585.4 21617.6 21633.6 8489.1 8522.2 8726.8 8806.8 8871.7 4957.0 5010.5 5038.7 5055.8 5210.9 3525.6 3630.6 3633.7 3634.0 3643.9 646.4 670.2 678.4 683.4 731.0 726.7 731.7 759.6 775.6 781.3 10040.0 10279.3 10285.6 10376.1 10498.2 621.6 662.7 724.7 735.1 737.1 4876.9 4902.3 4932.3 4943.0 4949.5 73820.6 75900.6 131052.0 134447.0 135601.0 87833.6 89067.0 107999.0 108121.5 111615.0 89431.0 91284.5 91798.0 92622.1 93822.0 9782.9 9863.3 9982.6 10147.9 10192.5 55453.2 55721.0 56092.0 56856.4 57072.0 72500.6 78561.4 80896.6 82630.2 83273.0 13094.3 13248.0 13498.9 13513.5 13931.6 13408.3 15090.8 15279.2 15706.6 15815.1 12550.9 12603.2 12715.6 13077.6 13447.3 13634.6 13814.5 14878.6 14944.6 15406.4 13265.3 14190.5 14399.7 14428.1 14579.1 11122.6 12047.4 12395.4 12473.2 12488.9 10520.3 11799.2 11896.2 12119.2 12161.6 10:16:39 INFO - PROCESS | 1052 | -------- Summary: end -------- 10:16:39 INFO - PROCESS | 1052 | 10:16:39 INFO - TEST-INFO | 1052: exit 0 10:16:39 INFO - TEST-OK | dromaeo_css | took 1113747ms 10:16:39 INFO - TEST-START | kraken 10:16:39 INFO - operating with platform_type : linux_ 10:16:39 INFO - Initialising browser for kraken test... 10:16:39 INFO - TEST-INFO | started process 1318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp96ebGd/profile http://localhost:45213/getInfo.html) 10:16:43 INFO - PROCESS | 1318 | JavaScript error: , line 0: uncaught exception: undefined 10:16:43 INFO - PROCESS | 1318 | __metrics Screen width/height:1600/1200 10:16:43 INFO - PROCESS | 1318 | colorDepth:24 10:16:43 INFO - PROCESS | 1318 | Browser inner width/height: 1024/697 10:16:43 INFO - PROCESS | 1318 | __metrics 10:16:44 INFO - PROCESS | 1318 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:16:44 INFO - PROCESS | 1318 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:45 INFO - TEST-INFO | 1318: exit 0 10:16:45 INFO - Browser initialized. 10:16:45 INFO - Running cycle 1/1 for kraken test... 10:16:45 INFO - TEST-INFO | started process 1402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp96ebGd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:57 INFO - PROCESS | 1402 | RSS: Main: 158150656 10:16:57 INFO - PROCESS | 1402 | 10:17:00 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45213/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:00 INFO - PROCESS | 1402 | RSS: Main: 214261760 10:17:00 INFO - PROCESS | 1402 | 10:17:03 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45213/tests/kraken/driver.html?testName=audio-dft) 10:17:04 INFO - PROCESS | 1402 | RSS: Main: 188194816 10:17:04 INFO - PROCESS | 1402 | 10:17:07 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45213/tests/kraken/driver.html?testName=audio-fft) 10:17:07 INFO - PROCESS | 1402 | RSS: Main: 270839808 10:17:07 INFO - PROCESS | 1402 | 10:17:09 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45213/tests/kraken/driver.html?testName=audio-oscillator) 10:17:10 INFO - PROCESS | 1402 | RSS: Main: 180699136 10:17:10 INFO - PROCESS | 1402 | 10:17:12 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45213/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:13 INFO - PROCESS | 1402 | RSS: Main: 185823232 10:17:13 INFO - PROCESS | 1402 | 10:17:16 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45213/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:16 INFO - PROCESS | 1402 | RSS: Main: 221110272 10:17:16 INFO - PROCESS | 1402 | 10:17:20 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45213/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:20 INFO - PROCESS | 1402 | RSS: Main: 221233152 10:17:20 INFO - PROCESS | 1402 | 10:17:23 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45213/tests/kraken/driver.html?testName=json-parse-financial) 10:17:24 INFO - PROCESS | 1402 | RSS: Main: 221089792 10:17:24 INFO - PROCESS | 1402 | 10:17:25 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45213/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:26 INFO - PROCESS | 1402 | RSS: Main: 185282560 10:17:26 INFO - PROCESS | 1402 | 10:17:28 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45213/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:28 INFO - PROCESS | 1402 | RSS: Main: 190529536 10:17:28 INFO - PROCESS | 1402 | 10:17:30 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45213/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:31 INFO - PROCESS | 1402 | RSS: Main: 195424256 10:17:31 INFO - PROCESS | 1402 | 10:17:33 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:34 INFO - PROCESS | 1402 | RSS: Main: 190693376 10:17:34 INFO - PROCESS | 1402 | 10:17:37 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:37 INFO - PROCESS | 1402 | RSS: Main: 194027520 10:17:37 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | Cycle 1(1): loaded http://localhost:45213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45213/tests/kraken/driver.html?testName=ai-astar) 10:17:39 INFO - PROCESS | 1402 | RSS: Main: 244576256 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | __start_tp_report 10:17:39 INFO - PROCESS | 1402 | _x_x_mozilla_page_load 10:17:39 INFO - PROCESS | 1402 | _x_x_mozilla_page_load_details 10:17:39 INFO - PROCESS | 1402 | |i|pagename|runs| 10:17:39 INFO - PROCESS | 1402 | |0;ai-astar;102;112;113;112;112;112;111;112;112;111 10:17:39 INFO - PROCESS | 1402 | |1;audio-beat-detection;145;118;119;191;117;122;145;121;167;116 10:17:39 INFO - PROCESS | 1402 | |2;audio-dft;160;162;160;161;163;161;162;162;160;162 10:17:39 INFO - PROCESS | 1402 | |3;audio-fft;74;75;73;108;73;75;75;75;102;75 10:17:39 INFO - PROCESS | 1402 | |4;audio-oscillator;84;84;113;83;83;84;111;83;84;134 10:17:39 INFO - PROCESS | 1402 | |5;imaging-gaussian-blur;117;116;116;117;117;116;117;117;117;117 10:17:39 INFO - PROCESS | 1402 | |6;imaging-darkroom;146;145;146;146;146;145;145;145;145;145 10:17:39 INFO - PROCESS | 1402 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 10:17:39 INFO - PROCESS | 1402 | |8;json-parse-financial;51;50;51;52;52;51;52;52;52;51 10:17:39 INFO - PROCESS | 1402 | |9;json-stringify-tinderbox;62;62;61;62;62;62;62;62;63;62 10:17:39 INFO - PROCESS | 1402 | |10;stanford-crypto-aes;76;75;75;75;77;76;76;78;76;76 10:17:39 INFO - PROCESS | 1402 | |11;stanford-crypto-ccm;123;119;121;133;117;125;118;118;165;130 10:17:39 INFO - PROCESS | 1402 | |12;stanford-crypto-pbkdf2;157;156;155;154;155;154;156;163;156;161 10:17:39 INFO - PROCESS | 1402 | |13;stanford-crypto-sha256-iterative;62;63;62;61;64;69;63;61;61;61 10:17:39 INFO - PROCESS | 1402 | __end_tp_report 10:17:39 INFO - PROCESS | 1402 | __start_cc_report 10:17:39 INFO - PROCESS | 1402 | _x_x_mozilla_cycle_collect,1688 10:17:39 INFO - PROCESS | 1402 | __end_cc_report 10:17:39 INFO - PROCESS | 1402 | __startTimestamp1469467059564__endTimestamp 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | ------- Summary: start ------- 10:17:39 INFO - PROCESS | 1402 | Number of tests: 14 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.18 (2.8%) stddev-sans-first:0.60 10:17:39 INFO - PROCESS | 1402 | Values: 102.0 112.0 113.0 112.0 112.0 112.0 111.0 112.0 112.0 111.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:133.50 stddev:25.70 (19.2%) stddev-sans-first:27.05 10:17:39 INFO - PROCESS | 1402 | Values: 145.0 118.0 119.0 191.0 117.0 122.0 145.0 121.0 167.0 116.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 10:17:39 INFO - PROCESS | 1402 | Values: 160.0 162.0 160.0 161.0 163.0 161.0 162.0 162.0 160.0 162.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:13.01 (17.4%) stddev-sans-first:13.59 10:17:39 INFO - PROCESS | 1402 | Values: 74.0 75.0 73.0 108.0 73.0 75.0 75.0 75.0 102.0 75.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:83.50 stddev:18.29 (21.9%) stddev-sans-first:19.02 10:17:39 INFO - PROCESS | 1402 | Values: 84.0 84.0 113.0 83.0 83.0 84.0 111.0 83.0 84.0 134.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:17:39 INFO - PROCESS | 1402 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:17:39 INFO - PROCESS | 1402 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:17:39 INFO - PROCESS | 1402 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 10:17:39 INFO - PROCESS | 1402 | Values: 51.0 50.0 51.0 52.0 52.0 51.0 52.0 52.0 52.0 51.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 10:17:39 INFO - PROCESS | 1402 | Values: 62.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:0.94 (1.2%) stddev-sans-first:1.00 10:17:39 INFO - PROCESS | 1402 | Values: 76.0 75.0 75.0 75.0 77.0 76.0 76.0 78.0 76.0 76.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:124.00 stddev:14.42 (11.6%) stddev-sans-first:15.22 10:17:39 INFO - PROCESS | 1402 | Values: 123.0 119.0 121.0 133.0 117.0 125.0 118.0 118.0 165.0 130.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:156.00 stddev:2.98 (1.9%) stddev-sans-first:3.16 10:17:39 INFO - PROCESS | 1402 | Values: 157.0 156.0 155.0 154.0 155.0 154.0 156.0 163.0 156.0 161.0 10:17:39 INFO - PROCESS | 1402 | 10:17:39 INFO - PROCESS | 1402 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:2.45 (3.9%) stddev-sans-first:2.59 10:17:39 INFO - PROCESS | 1402 | Values: 62.0 63.0 62.0 61.0 64.0 69.0 63.0 61.0 61.0 61.0 10:17:39 INFO - PROCESS | 1402 | -------- Summary: end -------- 10:17:39 INFO - PROCESS | 1402 | 10:17:40 INFO - TEST-INFO | 1402: exit 0 10:17:40 INFO - TEST-OK | kraken | took 60644ms 10:17:40 INFO - SUITE-END | took 1174s 10:17:40 INFO - Completed test suite (00:19:34) 10:17:40 INFO - javascript benchmark 10:17:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.1935537082677, 3061.051074167008, 3067.9539806902894, 3094.118176319749, 3128.5463607776874, 5244.108501554735, 5293.57651387889, 5393.649412788171, 5475.4524547545225, 5497.367802702685, 5432.674039557629, 5451.291332126818, 5507.752151153198, 5572.58205634578, 5588.441155884409, 4856.708597484162, 4867.683600565952, 4884.19410797218, 4970.751462426882, 4977.950220497785, 5022.4224214215465, 5056.014077254937, 5105.259737338084, 5110.846674599749, 5116.872078198056, 4906.362172917497, 4957.206846904496, 4966.1557535218735, 4966.230234313687, 4967.304577359155, 4792.496787837296, 4815.301781241736, 4855.126077306083, 4879.1461494238365, 4919.72941488218, 4814.037192561502, 4814.085323788469, 4826.203676393391, 4829.2997515360075, 4885.022995400898, 5407.0, 5433.782648694048, 5446.836594902159, 5455.8363249102595, 5466.0, 5590.580706446992, 5717.085266357363, 5798.9130163047585, 5812.331581868097, 5835.883282334372, 5901.468867801876, 5902.026165682657, 5902.557308201859, 5922.289325280951, 5923.881522369528, 5479.917801232985, 5491.450854914477, 5496.148097044925, 5497.725113744297, 5498.5876059295315, 5767.971160144172, 5786.016377215883, 5834.5624078194305, 5889.204957330791, 5992.0, 5714.028615135437, 5716.79991200306, 5756.424357564294, 5767.134929760569, 5768.3654797972185, 5802.3037235531165, 5850.093235548412, 5857.6192547485125, 5858.970705146447, 5865.032269675541, 5580.051391263414, 5668.348139963874, 5699.458551437607, 5714.371419143891, 5761.740721667535, 5735.053716136791, 5743.483086522233, 5744.0, 5749.68376739275, 5773.88452230953, 4344.826206951687, 4354.238008348526, 4384.7369157850635, 4390.517043125254, 4433.844815431445, 3873.0317420644838, 3904.668103211202, 3935.2523020626563, 3956.7625942443547, 3956.9604303957167, 5542.97228513863, 5547.528460080857, 5552.4531312325325, 5554.0, 5608.10270356741, 5541.806036788693, 5898.764049437975, 5900.114982752536, 5904.321003084614, 5944.583879128506, 5444.509994100471, 5474.863128421821, 5502.669839809624, 5522.0, 5536.889262214733, 5002.59979201663, 5009.674371165863, 5017.523335283142, 5017.8243761468175, 5091.66904151229, 5762.049261871828, 5989.341172471025, 5998.130271110665, 6010.66941318223, 6016.909746353808, 5759.539236861125, 5837.591368604157, 5839.065749480233, 5866.67733274674, 5929.970350148222, 6001.7599296027665, 6012.188354572252, 6020.157177995172, 6023.879522409439, 6025.18659980897, 5490.780368785204, 5710.800121995876, 5729.2265544151005, 5761.625494342854, 5763.7982670606325, 5770.913436298543, 5803.767849285981, 5817.621854579439, 5861.238039055066, 5911.645301281937, 5655.1517272409465, 5656.236408084856, 5699.544036477155, 5702.971485142548, 5706.343770466449, 5508.0, 5670.773169073191, 5688.232088668143, 5688.544916406595, 5694.487496125369, 5545.667259964415, 5570.693611851225, 5602.5517958562405, 5637.126245431965, 5698.202251684685, 5731.885362292647, 5739.139129130664, 5789.044807606698, 5793.131030345314, 5795.33353664334, 5348.117560602457, 5613.578981576316, 5622.7750889963945, 5628.774849005994, 5630.943690563042], "value": 5348.240408911256, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.4125874125874, 613.2977740487142, 620.5780069552706, 640.154995406064, 644.9519530762511, 31748.523772143435, 45336.546634533646, 46217.07565848681, 46324.53675463244, 46380.53619463804, 46540.0, 47049.529504704944, 47089.52910470894, 47127.0, 47174.0, 8302.626381812803, 9126.224270936962, 9278.304127190453, 9284.25725941923, 10773.245872788908, 10671.146308295356, 11110.277831940897, 11119.332840029583, 11127.944360278187, 11131.554737810518, 11189.776204475946, 11207.495662695157, 11215.495302711397, 11230.101591872672, 11236.325820450798, 11120.944395278053, 11130.554777808878, 11141.164412669, 11148.665540033853, 11192.0, 10935.671929842038, 10980.725481863017, 10996.890031099747, 11000.284981476178, 11022.118230541617, 44052.55947440548, 44529.33206001913, 44612.776936115435, 44737.55262447399, 44764.552354476364, 3519.63043880394, 3551.8579256829694, 3999.960000399988, 4237.0, 4364.10535840152, 32209.51685724716, 34636.82681586576, 34725.30549388998, 35059.12352191216, 36477.81761091204, 4389.429374181368, 4487.259602165639, 4503.707259028185, 4512.774361281956, 4562.498125206224, 390530.0, 392724.0, 392941.0, 394549.0, 394693.0, 64565.35434645687, 64868.0, 64941.675291623236, 64949.67525162344, 64963.35036649573, 37225.25549488995, 37440.251194976496, 37880.810595946845, 39486.0, 39580.604193958265, 16389.918050409673, 16410.1794910254, 16489.91755041241, 16519.6696066078, 16539.91730041342, 11149.944250278697, 12128.696782580506, 12400.875991239973, 12437.440315185839, 12489.12576119681, 20376.490587735425, 20409.652889917554, 20497.95020497938, 20606.14544690985, 20618.27836025762, 7062.540934839219, 7156.856862862818, 7172.892406613905, 7262.854742905112, 7522.201288349458, 923.787528868364, 970.3207754571828, 971.3394891473865, 1034.162328513891, 1074.8602681651491, 34556.30887382238, 34587.48118778221, 34877.476837847455, 34880.65119348825, 35040.82479587637, 1085.7394225386008, 1107.0, 1120.9495572699248, 1127.1039523578775, 1154.5151036564664, 17466.7599720086, 18038.098095095193, 18048.9097554514, 18111.18499667518, 18157.307410014946, 652981.0, 663955.0, 664199.0, 665624.0, 665649.0, 62700.05949910755, 63389.68305158537, 63510.6824465884, 63534.682326588074, 63652.0, 1237.7586370657634, 1295.747329270802, 1337.732453509302, 1344.2069179184327, 1368.3090039529973, 34083.31833363369, 35626.46560301546, 35959.82020089883, 36150.8192459036, 36304.63695363118, 54187.0, 54856.72571637116, 54919.0, 54942.0, 54946.72526637341, 430128.0, 433147.0, 433325.0, 433743.0, 434494.0, 29228.26929326784, 30478.390432190787, 30492.237694057825, 30497.237569060064, 30501.0, 51653.48346516487, 52231.73884130555, 52390.21414678859, 52545.737271313395, 53012.20481692855, 43318.350224747286, 43642.12715745604, 44088.338674920546, 44133.117337652424, 45666.771666142784, 43515.129697406504, 43620.56379436165, 44351.77824110859, 45695.543044570455, 46077.76961115173, 42650.360244596974, 42798.57201427946, 44105.55894441014, 44134.4831896013, 44311.55688443203, 36582.451263231604, 39091.6090839088, 39764.80117599393, 42845.78577107094, 42988.31385642708, 29596.704032960257, 29890.252743681584, 30036.05316851899, 30292.394152117275, 30377.24056898595], "value": 21378.54966360255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.2803137661925, 377.2266852951449, 382.388178913738, 391.90398352403656, 408.3282999465879, 14529.854701452996, 18222.817771822294, 18687.81312186876, 19244.230230790752, 19856.0, 18528.629427411444, 19507.21971121157, 19724.112414941326, 19885.204591816346, 19897.602047959033, 5565.053940830058, 5805.883882322351, 5809.244798176232, 5812.505936995361, 5814.854628634275, 5708.257926469574, 5718.027935250997, 5725.370209276976, 5739.569532285074, 5771.220885180489, 5784.479396854283, 5802.274715660543, 5805.332386775512, 5808.854778630526, 5815.5638327125425, 5337.572994160458, 5536.363318218416, 5567.359753628344, 5665.320161580596, 5802.361740208574, 5424.810131645413, 5480.123180291174, 5495.203195536625, 5745.310562732457, 5783.190353350535, 13361.265130417823, 13551.39018744159, 13660.112092713942, 13729.107608005448, 13799.034067615272, 2152.214441728773, 2214.9557008859892, 2309.2725791375665, 2328.697269354973, 2425.7695518925675, 9592.520373981342, 9927.51087336898, 9967.352122112039, 10516.421596812172, 14580.416783328654, 1864.4872660018468, 1869.3457289948544, 1912.8469722422174, 1922.1830721943259, 1977.238763076226, 80698.93091159887, 81907.0, 83345.58327208385, 83562.58218708928, 86686.56656716739, 10827.47798622708, 10931.617393391192, 10937.343759374464, 11157.832632510519, 11402.657920262405, 15378.769318460232, 15414.845851541566, 15433.151176685391, 15437.614059648598, 15453.613659658598, 8017.278444939983, 8076.0, 8173.95913020443, 8238.629261683238, 8348.749537513884, 7795.376369890395, 7895.881561776578, 8056.83886322282, 8062.355011599058, 8082.353411727047, 4599.747013914267, 4642.187617166982, 4663.253879379283, 4793.209120495149, 4862.149123903303, 1811.9275228990957, 1948.279136719423, 1955.9315423960093, 2029.979700202979, 2052.230413594902, 882.3779235638859, 960.6109525642127, 972.6741541583507, 980.4068538534084, 982.5087456271864, 18168.45494635163, 19772.604547908963, 19899.303524376577, 19930.103145358495, 20154.193832246838, 961.990380096204, 998.3859926145368, 1013.1793247469574, 1023.048564834696, 1051.831706926888, 10429.791404171874, 10842.837357439645, 10934.726631834108, 11093.722656933642, 11095.1123910087, 439553.0, 474741.0, 494485.0, 500001.0, 503252.0, 92090.0, 94206.0579394211, 94648.0, 95039.0, 95275.0, 973.9610415583297, 998.3560603410759, 1018.8013337399136, 1068.9946550267198, 1071.5660157636325, 16092.919535402716, 16503.83496165071, 17717.0, 18537.81462185361, 18763.718544221574, 43444.348334775634, 43881.78059109684, 44319.33520997252, 44447.777761110985, 45171.0, 56736.716316418155, 56785.0, 57204.713976431514, 65384.05771740378, 65855.34144658492, 7916.960415197887, 8129.79675508117, 8449.83100338002, 8594.570271486526, 8900.554972251492, 12512.061595380565, 13104.737905242033, 13262.668433289246, 13877.79183312231, 13882.722345552831, 11759.588414405454, 11944.343061131722, 11958.64124076279, 12007.159498834997, 12015.09886758514, 11159.553617855196, 11418.828717569077, 11425.0, 11437.0, 11831.34927578957, 11587.420628968686, 12278.938605306916, 12343.814842777187, 12507.499700011898, 12571.108645011516, 8074.515529068275, 8090.7168249111, 8193.877091843746, 8403.411761176903, 8598.097199794182, 9784.0, 11604.88395116038, 11719.179657423898, 11944.283342999448, 12099.758004839678], "value": 9117.627103961082, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.4119787293596, 1455.1196526101708, 1509.034218100416, 1622.2537632688961, 1786.9106544672763, 8542.103079176683, 8671.349648776344, 8862.77843053924, 9201.815963680723, 9228.261739060876, 9066.863997040049, 9175.220106290973, 9177.08229177082, 9181.586828592712, 9185.357025008252, 2387.904483820645, 2409.313345696477, 2413.5776239158076, 2414.130912871365, 2416.55293770653, 2335.871527066011, 2393.6768536247646, 2401.6757737705448, 2402.25530085674, 2404.3147702904675, 2347.1550241912896, 2369.490559529701, 2393.617021276596, 2397.928062158138, 2398.6761787158684, 2311.456807650209, 2315.7452680205165, 2338.8362814602983, 2339.836211465198, 2356.752540983198, 2303.9654405183937, 2314.6065168921155, 2336.112277334602, 2341.7541158178315, 2345.425370784169, 9064.274858011344, 9109.772255693595, 9111.316651251183, 9182.67860624875, 9197.034311397274, 5244.160934250502, 5457.290552228224, 5468.207109969032, 5469.453054694539, 5471.206675032098, 3286.9835650821833, 3337.8664853405835, 3386.221169131089, 3389.389909816232, 3400.1499625093725, 1131.3155540897721, 1141.2353723005606, 1157.7915975124474, 1175.9647210583696, 1186.3712232516693, 12913.806292905614, 12929.612111636667, 13030.869691303154, 13033.0, 13035.15271507349, 4448.666350023761, 4551.135284295973, 4678.69588476748, 4703.506131856174, 4707.152712511781, 10214.336068155546, 10232.846507302396, 10256.948715256525, 10265.486725663686, 10270.589176432859, 5281.128613778684, 5288.497592728685, 5289.68261904287, 5290.709011004355, 5294.54996325309, 4282.850100246476, 4744.881377965578, 4896.436909755424, 4906.803727850917, 4919.852404427873, 3819.217060502646, 3859.6526312632, 3901.4733011043713, 3932.075962148893, 3960.4653371795016, 1132.9263597866113, 1147.73602071524, 1148.3807830958308, 1149.3908228638834, 1154.3997121496775, 807.8788181772782, 869.4044579463088, 990.4107056301489, 998.286225348879, 1031.9587216511256, 6138.355472675394, 6155.261368635793, 6277.591956522811, 6416.533423375956, 6445.258795238514, 970.9514524273758, 1015.1422048369117, 1020.6529779874878, 1030.2742905633036, 1032.87605487342, 4326.918270432392, 4556.384888040138, 4558.247889098328, 4590.609798167126, 4677.298405239173, 10711.571537138427, 10883.292585982044, 11101.944490277498, 11225.60710375133, 11226.494807733672, 10398.376097434179, 11139.777204455866, 11145.0, 11194.384308863091, 11200.159988000769, 8118.431709780259, 8519.872201916976, 8533.146685331418, 8539.23146916768, 8561.657533698582, 6251.187345645037, 6312.179416675803, 6313.523380572171, 6373.840653983688, 6529.347065293433, 10439.53022114022, 10444.895551044696, 10547.683569492621, 10583.364998100138, 10592.470376480991, 10360.222983276435, 10420.166386689198, 10441.838957009384, 10529.947350263199, 10589.152867770406, 7701.961490192513, 8479.321654267767, 8637.0, 8718.389712720049, 8976.461412315282, 8954.462732235826, 8955.731328060168, 8994.460332380078, 9014.954925225333, 9043.276537877086, 8006.91993080085, 8016.478928869605, 8082.070561885458, 8141.674333026849, 8238.134995825592, 7882.132965373919, 7918.089419716806, 7947.245011723877, 8020.639071241691, 8129.146439623991, 7108.537945033556, 7143.428525718034, 7155.069840920647, 7187.8562428752175, 7191.0, 5197.350331208599, 5336.252924590638, 5341.813036543703, 5397.271368365377, 5480.698561578992, 5305.70818604965, 5386.326709161355, 5434.510894019557, 5446.754896029609, 5557.972210138923], "value": 4761.360906244805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.2232773411004, 317.6140988698731, 323.87530800641747, 324.1652744183726, 326.05769326646, 5391.218273350361, 5400.189971504266, 5481.671099734019, 5487.5609951203905, 5514.751836167372, 5158.704376552436, 5228.555572776309, 5324.174752913295, 5342.91985620216, 5360.544353729928, 4180.226658068252, 4183.410304084459, 4195.748255104703, 4197.265478541259, 4203.600657937491, 4207.621314081732, 4220.556841531641, 4226.788660566975, 4227.7463352198965, 4229.6404805591565, 3791.7156213283974, 3840.1743625120594, 4084.8570300039505, 4138.97930510347, 4189.706720529564, 4112.0, 4122.752634841919, 4163.771687352239, 4165.10450253194, 4167.416561681352, 3664.4686520454384, 3669.889903302905, 3675.44868269759, 3679.6504332088407, 3680.024793429743, 5143.434222235588, 5154.4587818278915, 5180.43015268324, 5183.326167598226, 5275.235090911796, 4745.786439610226, 4767.7616119194245, 4771.23660214364, 4772.856814295576, 4777.952220477786, 5583.553315734732, 5591.189277554732, 5602.13166959122, 5607.971960140214, 5645.379008309083, 3960.4653371794725, 4032.858849940267, 4067.5525692173837, 4079.4696689430184, 4106.260873042851, 5828.708564571754, 5833.7374818133285, 5842.211301474289, 5846.21076154718, 5853.941460585383, 4151.066010147692, 4169.499660040754, 4179.97910010448, 4186.0, 4191.832326706958, 3915.9608403915595, 4129.8967525811495, 4133.173365326947, 4222.746635201836, 4229.386738922839, 4716.693414928087, 4760.857174284777, 4772.308015337757, 4796.544328288807, 4801.0075818535615, 5687.146927960839, 5725.541956643458, 5745.166950792195, 5745.741441635137, 5745.8563535911935, 1331.5872079655337, 1333.9666508337368, 1396.5112210726368, 1418.659521714781, 1428.8428272889973, 933.8552524358599, 956.36401792807, 962.6534447598859, 970.8058388322222, 973.5570315506427, 5366.543843773245, 5388.838334849961, 5427.29445172133, 5491.423400542965, 5499.772592100206, 5659.349174844863, 5779.768809247583, 5785.652860828363, 5797.130430435468, 5798.739056742456, 5363.659085228693, 5412.188171774186, 5413.729313534386, 5444.863878403072, 5470.370907345706, 3004.858153901547, 3036.802607830484, 3049.5120780674984, 3054.3127796246113, 3076.138681169276, 5666.348369937427, 5854.326752423441, 5866.67733274674, 5880.529557635379, 5914.881702366015, 5831.504322132581, 5843.707814609253, 5850.444207800252, 5853.678047707332, 5855.0, 5796.681182534917, 5817.447342502455, 5846.503047241032, 5919.0, 5964.701764911737, 5619.286117733966, 5822.243108395882, 5827.708614569339, 5847.38602446737, 5890.6760128191645, 5785.537157027512, 5789.247397838254, 5792.21805056312, 5793.710314484343, 5886.793962211474, 5840.737166827588, 5982.0727787193055, 6009.248843894513, 6077.085717998816, 6105.382073750548, 3985.163115745726, 3994.540627827837, 4009.7193196477133, 4013.097053163015, 4031.5162180538523, 5922.851928701817, 5924.644521328734, 5927.288725352985, 5935.465808077293, 5946.1972633693895, 5499.752511136929, 5703.857403564944, 5726.685032323262, 5770.913436298375, 5794.159846822272, 5625.537360286273, 5650.26546548946, 5700.686462244616, 5717.371089180104, 5717.771289148387, 5409.729513524387, 5497.45025497447, 5567.0, 5670.603057785916, 5714.314282286152, 5690.687012214203, 5692.459216374438, 5702.173184888251, 5708.372079071381, 5738.84793202549, 5483.533899618417, 5609.831705048855, 5620.297462817148, 5647.491725744702, 5663.178839068394], "value": 4290.283725295691, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.7732714195025, 761.2463660975636, 778.4511919097033, 809.1665584448019, 853.9871901921471, 15599.376024959016, 15747.842521574796, 15826.129562874052, 16029.278682459288, 16386.09876456796, 15105.39578416862, 15139.167345795977, 15173.54479365618, 15210.23948802561, 15211.847881521182, 807.4267270238138, 826.2646244842095, 831.6257684042175, 832.0805509911552, 833.2667252817512, 654.3325807676191, 792.3265224559136, 822.5147163173726, 825.0965193113561, 833.3916241143969, 862.482510493705, 864.2222000199807, 864.2308345572415, 864.9654013839439, 865.1607940297932, 857.4041041476177, 857.4212406625566, 857.6355049104105, 858.0175698824842, 858.0218550852034, 496.31260703924966, 608.3156448994881, 631.9747210111636, 632.9841753956142, 639.146739103293, 14797.852021479863, 14851.183184924825, 14883.032602880778, 14909.701805963929, 14912.62718432048, 13261.46954121834, 13328.400221990034, 13488.93255533716, 13744.10663306892, 14135.081219720789, 13234.602961911158, 13313.800292995516, 13387.598372048757, 13391.196528208338, 13456.05807593459, 4424.734515929054, 4433.091216300651, 4456.64346852251, 4482.753448560328, 4593.9310910336035, 70298.29701702969, 72359.63820180866, 72504.63747681228, 82566.58716706379, 83517.16482835155, 11910.821337679941, 12309.753804923852, 12348.629541113782, 12414.193077449936, 12647.557335493213, 21509.354719358445, 21572.0, 21585.352439426842, 21617.56764864694, 21633.567328653655, 8489.108643592457, 8522.232999030117, 8726.781830454289, 8806.779830504289, 8871.733847984442, 4956.950430495649, 5010.473900240495, 5038.697678139323, 5055.772490237948, 5210.869728256748, 3525.6474352564537, 3630.618785027534, 3633.65480279373, 3633.9636603633626, 3643.9271214576092, 646.3762469217133, 670.1957650819037, 678.4030053552842, 683.4190937702913, 731.0, 726.7020521586124, 731.6634348199781, 759.5670467833282, 775.6199462263563, 781.2656103262915, 10040.046195611405, 10279.346359502244, 10285.588576457008, 10376.066154046172, 10498.160147188206, 621.599068600759, 662.6752891083335, 724.7390939261861, 735.1398863329916, 737.0786516853933, 4876.853694389174, 4902.313676085351, 4932.260160975882, 4943.0, 4949.529794669501, 73820.63089684624, 75900.62049689826, 131052.0, 134447.0, 135601.0, 87833.56083219544, 89067.0, 107999.0, 108121.45939270411, 111615.0, 89431.0, 91284.54357728169, 91798.0, 92622.07377926135, 93822.0, 9782.853257201004, 9863.309568330147, 9982.60069597237, 10147.898521014991, 10192.541335639766, 55453.16820247619, 55721.0, 56092.0, 56856.43143568511, 57072.0, 72500.63749681218, 78561.4287714231, 80896.59551702204, 82630.17369826225, 83273.0, 13094.345282735634, 13248.0, 13498.93250533741, 13513.459461621425, 13931.58205253844, 13408.262545560088, 15090.773638395212, 15279.236038197823, 15706.586407223405, 15815.13016784042, 12550.937245313715, 12603.243805371707, 12715.554955576881, 13077.607671769862, 13447.327633618475, 13634.590962271148, 13814.516491923136, 14878.553643390716, 14944.551663450115, 15406.38374465009, 13265.336733163496, 14190.503332383318, 14399.712005760035, 14428.134311941318, 14579.125252484884, 11122.555097795997, 12047.397630118634, 12395.442205100611, 12473.189242699196, 12488.875111249135, 10520.259311247972, 11799.17405781587, 11896.226745261876, 12119.212251203644, 12161.574344897886], "value": 7808.909848347525, "unit": "score"}], "name": "dromaeo_css", "value": 7415.732463759121, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 119.0, 191.0, 117.0, 122.0, 145.0, 121.0, 167.0, 116.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 163.0, 161.0, 162.0, 162.0, 160.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 108.0, 73.0, 75.0, 75.0, 75.0, 102.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 83.0, 83.0, 84.0, 111.0, 83.0, 84.0, 134.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 52.0, 52.0, 51.0, 52.0, 52.0, 52.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 75.0, 77.0, 76.0, 76.0, 78.0, 76.0, 76.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 119.0, 121.0, 133.0, 117.0, 125.0, 118.0, 118.0, 165.0, 130.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 155.0, 154.0, 155.0, 154.0, 156.0, 163.0, 156.0, 161.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 64.0, 69.0, 63.0, 61.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1475.8000000000002, "alertThreshold": 2.0}]} 10:17:40 INFO - Return code: 0 10:17:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:17:40 INFO - # TBPL SUCCESS # 10:17:40 INFO - Running post-action listener: _resource_record_post_action 10:17:40 INFO - [mozharness: 2016-07-25 17:17:40.849013Z] Finished run-tests step (success) 10:17:40 INFO - Running post-run listener: _resource_record_post_run 10:17:40 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 554098688; Read time: 60; Write time: 487672 10:17:40 INFO - TinderboxPrint: CPU usage
13.0% 10:17:40 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 60 10:17:40 INFO - TinderboxPrint: I/O write bytes / time
554,098,688 / 487,672 10:17:40 INFO - TinderboxPrint: CPU idle
8,280.7 (87.0%) 10:17:40 INFO - TinderboxPrint: CPU user
1,188.4 (12.5%) 10:17:40 INFO - TinderboxPrint: Swap in / out
0 / 0 10:17:40 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 257482752; Read time: 0; Write time: 244988 10:17:40 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296615936; Read time: 28; Write time: 242684 10:17:41 INFO - Running post-run listener: _upload_blobber_files 10:17:41 INFO - Blob upload gear active. 10:17:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:17:41 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 10:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:17:41 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:17:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:17:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:42 INFO - (blobuploader) - INFO - Done attempting. 10:17:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:17:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:00 INFO - (blobuploader) - INFO - Done attempting. 10:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:01 INFO - (blobuploader) - INFO - Done attempting. 10:18:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:01 INFO - Return code: 0 10:18:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25bead746494300d059bb6dac8c7731def306b82bf764bd5bf603eca5665c7274a20021525698e3f2ebf4b13485913cc2dda9213e5a78f16b5ed9157bc32a5d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fcf0b9bc692b9a15147813d6a1fe537b2fc46634106bd4b4f330f8097832668a601bd94c147a5a5788bc7e30bcbfdd6fe38aa8c9657f34f2c5d229e6cdd3974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56679b2a24dcf3a1bf8cfb554e68ab75398ddce2b92e9007671bcd7590b91ade3774be214971de656c431f02b5d697888c5423dc9a965109db12335ee437ab0b"} 10:18:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:01 INFO - Contents: 10:18:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25bead746494300d059bb6dac8c7731def306b82bf764bd5bf603eca5665c7274a20021525698e3f2ebf4b13485913cc2dda9213e5a78f16b5ed9157bc32a5d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fcf0b9bc692b9a15147813d6a1fe537b2fc46634106bd4b4f330f8097832668a601bd94c147a5a5788bc7e30bcbfdd6fe38aa8c9657f34f2c5d229e6cdd3974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56679b2a24dcf3a1bf8cfb554e68ab75398ddce2b92e9007671bcd7590b91ade3774be214971de656c431f02b5d697888c5423dc9a965109db12335ee437ab0b"} 10:18:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:01 INFO - Copying logs to upload dir... 10:18:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.562340 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-25 10:18:01.755408) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 10:18:01.758775) ========= 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=920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25bead746494300d059bb6dac8c7731def306b82bf764bd5bf603eca5665c7274a20021525698e3f2ebf4b13485913cc2dda9213e5a78f16b5ed9157bc32a5d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fcf0b9bc692b9a15147813d6a1fe537b2fc46634106bd4b4f330f8097832668a601bd94c147a5a5788bc7e30bcbfdd6fe38aa8c9657f34f2c5d229e6cdd3974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56679b2a24dcf3a1bf8cfb554e68ab75398ddce2b92e9007671bcd7590b91ade3774be214971de656c431f02b5d697888c5423dc9a965109db12335ee437ab0b"} build_url:https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011491 build_url: 'https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25bead746494300d059bb6dac8c7731def306b82bf764bd5bf603eca5665c7274a20021525698e3f2ebf4b13485913cc2dda9213e5a78f16b5ed9157bc32a5d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fcf0b9bc692b9a15147813d6a1fe537b2fc46634106bd4b4f330f8097832668a601bd94c147a5a5788bc7e30bcbfdd6fe38aa8c9657f34f2c5d229e6cdd3974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56679b2a24dcf3a1bf8cfb554e68ab75398ddce2b92e9007671bcd7590b91ade3774be214971de656c431f02b5d697888c5423dc9a965109db12335ee437ab0b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 10:18:01.784163) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:18:01.784519) ========= 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=920470bf432669ad7e3a5387000001ca-1469465835.460089-102635386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:18:01.868457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 10:18:01.868807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 10:18:01.869135) ========= ========= Total master_lag: 0.17 =========