builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1468257497.94 results: success (0) buildid: 20160711073027 builduid: b9b62b40f8204814ba2092de745cb99e revision: 214884d507ee369c1cf14edb26527c4f9a97bf48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:17.945304) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:17.945705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:17.945995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:17.985225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:17.985534) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 10:18:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 115M=0s 2016-07-11 10:18:18 (115 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166356 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:18.169590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:18.169876) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018426 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:18.225079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:18.226532) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 214884d507ee369c1cf14edb26527c4f9a97bf48 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 214884d507ee369c1cf14edb26527c4f9a97bf48 --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=7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 10:18:18,359 truncating revision to first 12 chars 2016-07-11 10:18:18,359 Setting DEBUG logging. 2016-07-11 10:18:18,359 attempt 1/10 2016-07-11 10:18:18,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/214884d507ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 10:18:18,666 unpacking tar archive at: mozilla-central-214884d507ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:18.974845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:18.975434) ========= script_repo_revision: 214884d507ee369c1cf14edb26527c4f9a97bf48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:18.976165) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:18.976718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 10:18:19.008061) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-11 10:18:19.008382) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:18:19 INFO - MultiFileLogger online at 20160711 10:18:19 in /builds/slave/test 10:18:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:18:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:18:19 INFO - {'append_to_log': False, 10:18:19 INFO - 'base_work_dir': '/builds/slave/test', 10:18:19 INFO - 'blob_upload_branch': 'Firefox', 10:18:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:18:19 INFO - 'branch': 'Firefox', 10:18:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:18:19 INFO - 'config_files': ('talos/linux_config.py',), 10:18:19 INFO - 'default_actions': ('clobber', 10:18:19 INFO - 'read-buildbot-config', 10:18:19 INFO - 'download-and-extract', 10:18:19 INFO - 'populate-webroot', 10:18:19 INFO - 'create-virtualenv', 10:18:19 INFO - 'install', 10:18:19 INFO - 'run-tests'), 10:18:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:18:19 INFO - 'download_minidump_stackwalk': True, 10:18:19 INFO - 'download_symbols': 'ondemand', 10:18:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:18:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:18:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:18:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:18:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:18:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:18:19 INFO - 'installer_path': 'installer.exe', 10:18:19 INFO - 'log_level': 'info', 10:18:19 INFO - 'log_name': 'talos', 10:18:19 INFO - 'log_to_console': True, 10:18:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:18:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:18:19 INFO - 'opt_config_files': (), 10:18:19 INFO - 'pip_index': False, 10:18:19 INFO - 'sps_profile': False, 10:18:19 INFO - 'sps_profile_interval': 0, 10:18:19 INFO - 'suite': 'dromaeojs', 10:18:19 INFO - 'system_bits': '32', 10:18:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:18:19 INFO - 'title': 'talos-linux64-ix-005', 10:18:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:18:19 INFO - 'use_talos_json': True, 10:18:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:18:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:18:19 INFO - 'work_dir': 'build'} 10:18:19 INFO - ##### 10:18:19 INFO - ##### Running clobber step. 10:18:19 INFO - ##### 10:18:19 INFO - Running pre-action listener: _resource_record_pre_action 10:18:19 INFO - Running main action method: clobber 10:18:19 INFO - rmtree: /builds/slave/test/build 10:18:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:18:20 INFO - Running post-action listener: _resource_record_post_action 10:18:20 INFO - ##### 10:18:20 INFO - ##### Finished clobber step (success) 10:18:20 INFO - ##### 10:18:20 INFO - ##### 10:18:20 INFO - ##### Running read-buildbot-config step. 10:18:20 INFO - ##### 10:18:20 INFO - Running pre-action listener: _resource_record_pre_action 10:18:20 INFO - Running main action method: read_buildbot_config 10:18:20 INFO - Using buildbot properties: 10:18:20 INFO - { 10:18:20 INFO - "project": "", 10:18:20 INFO - "product": "firefox", 10:18:20 INFO - "script_repo_revision": "production", 10:18:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:18:20 INFO - "repository": "", 10:18:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:18:20 INFO - "buildid": "20160711073027", 10:18:20 INFO - "pgo_build": "True", 10:18:20 INFO - "basedir": "/builds/slave/test", 10:18:20 INFO - "buildnumber": 498, 10:18:20 INFO - "slavename": "talos-linux64-ix-005", 10:18:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:18:20 INFO - "platform": "ubuntu64_hw", 10:18:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:18:20 INFO - "branch": "mozilla-central", 10:18:20 INFO - "repo_path": "mozilla-central", 10:18:20 INFO - "revision": "214884d507ee369c1cf14edb26527c4f9a97bf48", 10:18:20 INFO - "stage_platform": "linux64-pgo", 10:18:20 INFO - "builduid": "b9b62b40f8204814ba2092de745cb99e", 10:18:20 INFO - "slavebuilddir": "test" 10:18:20 INFO - } 10:18:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:18:20 INFO - Running post-action listener: _resource_record_post_action 10:18:20 INFO - ##### 10:18:20 INFO - ##### Finished read-buildbot-config step (success) 10:18:20 INFO - ##### 10:18:20 INFO - ##### 10:18:20 INFO - ##### Running download-and-extract step. 10:18:20 INFO - ##### 10:18:20 INFO - Running pre-action listener: _resource_record_pre_action 10:18:20 INFO - Running main action method: download_and_extract 10:18:20 INFO - mkdir: /builds/slave/test/build/tests 10:18: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')]} 10:18:20 INFO - https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:18:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:18:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:18:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:24 INFO - Downloaded 1361 bytes. 10:18:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:18:24 INFO - Using the following test package requirements: 10:18:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:18:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:18:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:24 INFO - u'jsshell-linux-x86_64.zip'], 10:18:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:18:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:18:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:18:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:18:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:18:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:18: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')]} 10:18:24 INFO - https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:40 INFO - Downloaded 24307509 bytes. 10:18:40 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'] 10:18:40 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 10:18:42 INFO - Return code: 0 10:18:42 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 10:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:42 INFO - https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:43 INFO - Downloaded 24307509 bytes. 10:18:43 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'] 10:18:43 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 10:18:44 INFO - Return code: 0 10:18: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')]} 10:18:44 INFO - https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:18:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:18:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:18:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:45 INFO - Downloaded 14403333 bytes. 10:18:45 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'] 10:18:45 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 10:18:45 INFO - Return code: 0 10:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:18:45 INFO - https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:18:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:18:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:18:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MPlb5F_rRtOmeU24TgdY2A/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 10:18:47 INFO - Downloaded 60487481 bytes. 10:18:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:18:47 INFO - mkdir: /builds/slave/test/properties 10:18:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:18:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:18:47 INFO - Contents: 10:18:47 INFO - build_url:https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:18:48 INFO - Running post-action listener: _resource_record_post_action 10:18:48 INFO - Running post-action listener: set_extra_try_arguments 10:18:48 INFO - ##### 10:18:48 INFO - ##### Finished download-and-extract step (success) 10:18:48 INFO - ##### 10:18:48 INFO - ##### 10:18:48 INFO - ##### Running populate-webroot step. 10:18:48 INFO - ##### 10:18:48 INFO - Running pre-action listener: _resource_record_pre_action 10:18:48 INFO - Running main action method: populate_webroot 10:18:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:18:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:18:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:18:48 INFO - '--tppagecycles', 10:18:48 INFO - '7'], 10:18:48 INFO - 'tests': ['tsvgm']}}, 10:18:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:18:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:18:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:18:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:18:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:48 INFO - 'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:18:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:18:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:48 INFO - 'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['damp', 'tps']}, 10:18:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:48 INFO - 'tests': ['damp', 'tps']}, 10:18:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['dromaeo_dom']}, 10:18:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:18:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['basic_compositor_video']}, 10:18:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:18:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['a11yr', 10:18:48 INFO - 'ts_paint', 10:18:48 INFO - 'tpaint', 10:18:48 INFO - 'sessionrestore', 10:18:48 INFO - 'sessionrestore_no_auto_restore', 10:18:48 INFO - 'tabpaint']}, 10:18:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:18:48 INFO - 'ts_paint', 10:18:48 INFO - 'tpaint', 10:18:48 INFO - 'sessionrestore', 10:18:48 INFO - 'sessionrestore_no_auto_restore', 10:18:48 INFO - 'tabpaint']}, 10:18:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:18:48 INFO - 'ts_paint', 10:18:48 INFO - 'tpaint', 10:18:48 INFO - 'sessionrestore', 10:18:48 INFO - 'sessionrestore_no_auto_restore', 10:18:48 INFO - 'tabpaint']}, 10:18:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:18:48 INFO - 'ts_paint', 10:18:48 INFO - 'tpaint', 10:18:48 INFO - 'sessionrestore', 10:18:48 INFO - 'sessionrestore_no_auto_restore', 10:18:48 INFO - 'tabpaint']}, 10:18:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['a11yr', 10:18:48 INFO - 'ts_paint', 10:18:48 INFO - 'tpaint', 10:18:48 INFO - 'sessionrestore', 10:18:48 INFO - 'sessionrestore_no_auto_restore', 10:18:48 INFO - 'tabpaint']}, 10:18:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['a11yr', 10:18:48 INFO - 'ts_paint', 10:18:48 INFO - 'tpaint', 10:18:48 INFO - 'sessionrestore', 10:18:48 INFO - 'sessionrestore_no_auto_restore', 10:18:48 INFO - 'tabpaint']}, 10:18:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['tsvgx', 10:18:48 INFO - 'tsvgr_opacity', 10:18:48 INFO - 'tart', 10:18:48 INFO - 'tscrollx', 10:18:48 INFO - 'cart']}, 10:18:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:18:48 INFO - 'tsvgr_opacity', 10:18:48 INFO - 'tart', 10:18:48 INFO - 'tscrollx', 10:18:48 INFO - 'cart']}, 10:18:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:48 INFO - 'talos_options': ['--disable-e10s'], 10:18:48 INFO - 'tests': ['tp5o']}, 10:18:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:48 INFO - 'tests': ['tp5o']}, 10:18:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:48 INFO - 'talos_options': ['--disable-e10s', 10:18:48 INFO - '--xperf_path', 10:18:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:18:48 INFO - 'tests': ['tp5n']}, 10:18:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:48 INFO - 'talos_options': ['--xperf_path', 10:18:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:18:48 INFO - 'tests': ['tp5n']}}, 10:18:48 INFO - 'talos.zip': {'path': '', 10:18:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:18:48 INFO - Running post-action listener: _resource_record_post_action 10:18:48 INFO - ##### 10:18:48 INFO - ##### Finished populate-webroot step (success) 10:18:48 INFO - ##### 10:18:48 INFO - ##### 10:18:48 INFO - ##### Running create-virtualenv step. 10:18:48 INFO - ##### 10:18:48 INFO - Running pre-action listener: _resource_record_pre_action 10:18:48 INFO - Running main action method: create_virtualenv 10:18:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:18:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:18:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:18:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:18:48 INFO - Using real prefix '/usr' 10:18:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:18:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:18:50 INFO - Installing pip.................done. 10:18:50 INFO - Return code: 0 10:18:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:18:50 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')]} 10:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:50 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')]} 10:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:50 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 0x1e2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:18:50 INFO - Using env: {'DISPLAY': ':0', 10:18:50 INFO - 'HOME': '/home/cltbld', 10:18:50 INFO - 'LANG': 'en_US.UTF-8', 10:18:50 INFO - 'LANGUAGE': 'en_US:en', 10:18:50 INFO - 'LOGNAME': 'cltbld', 10:18:50 INFO - 'MAIL': '/var/mail/cltbld', 10:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:50 INFO - 'MOZ_NO_REMOTE': '1', 10:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:50 INFO - 'NO_EM_RESTART': '1', 10:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:50 INFO - 'PWD': '/builds/slave/test', 10:18:50 INFO - 'SHELL': '/bin/bash', 10:18:50 INFO - 'SHLVL': '1', 10:18:50 INFO - 'TERM': 'linux', 10:18:50 INFO - 'TMOUT': '86400', 10:18:50 INFO - 'USER': 'cltbld', 10:18:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:50 INFO - '_': '/tools/buildbot/bin/python'} 10:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:18:51 INFO - Cleaning up... 10:18:51 INFO - Return code: 0 10:18:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:18:51 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')]} 10:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:51 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')]} 10:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:51 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 0x1e2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:18:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:18:51 INFO - Using env: {'DISPLAY': ':0', 10:18:51 INFO - 'HOME': '/home/cltbld', 10:18:51 INFO - 'LANG': 'en_US.UTF-8', 10:18:51 INFO - 'LANGUAGE': 'en_US:en', 10:18:51 INFO - 'LOGNAME': 'cltbld', 10:18:51 INFO - 'MAIL': '/var/mail/cltbld', 10:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:51 INFO - 'MOZ_NO_REMOTE': '1', 10:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:51 INFO - 'NO_EM_RESTART': '1', 10:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:51 INFO - 'PWD': '/builds/slave/test', 10:18:51 INFO - 'SHELL': '/bin/bash', 10:18:51 INFO - 'SHLVL': '1', 10:18:51 INFO - 'TERM': 'linux', 10:18:51 INFO - 'TMOUT': '86400', 10:18:51 INFO - 'USER': 'cltbld', 10:18:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:51 INFO - '_': '/tools/buildbot/bin/python'} 10:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:51 INFO - Downloading/unpacking psutil>=3.1.1 10:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:18:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:18:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:18:53 INFO - Installing collected packages: psutil 10:18:53 INFO - Running setup.py install for psutil 10:18:53 INFO - building 'psutil._psutil_linux' extension 10:18:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:18:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:18:54 INFO - building 'psutil._psutil_posix' extension 10:18:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:18:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:18:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:18:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:18:55 INFO - Successfully installed psutil 10:18:55 INFO - Cleaning up... 10:18:55 INFO - Return code: 0 10:18:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:55 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 0x1e2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:18:55 INFO - Using env: {'DISPLAY': ':0', 10:18:55 INFO - 'HOME': '/home/cltbld', 10:18:55 INFO - 'LANG': 'en_US.UTF-8', 10:18:55 INFO - 'LANGUAGE': 'en_US:en', 10:18:55 INFO - 'LOGNAME': 'cltbld', 10:18:55 INFO - 'MAIL': '/var/mail/cltbld', 10:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:55 INFO - 'MOZ_NO_REMOTE': '1', 10:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:55 INFO - 'NO_EM_RESTART': '1', 10:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:55 INFO - 'PWD': '/builds/slave/test', 10:18:55 INFO - 'SHELL': '/bin/bash', 10:18:55 INFO - 'SHLVL': '1', 10:18:55 INFO - 'TERM': 'linux', 10:18:55 INFO - 'TMOUT': '86400', 10:18:55 INFO - 'USER': 'cltbld', 10:18:55 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:55 INFO - '_': '/tools/buildbot/bin/python'} 10:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:18:57 INFO - Installing collected packages: mozsystemmonitor 10:18:57 INFO - Running setup.py install for mozsystemmonitor 10:18:57 INFO - Successfully installed mozsystemmonitor 10:18:57 INFO - Cleaning up... 10:18:57 INFO - Return code: 0 10:18:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:18:57 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')]} 10:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:57 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')]} 10:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:57 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 0x1e2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:18:57 INFO - Using env: {'DISPLAY': ':0', 10:18:57 INFO - 'HOME': '/home/cltbld', 10:18:57 INFO - 'LANG': 'en_US.UTF-8', 10:18:57 INFO - 'LANGUAGE': 'en_US:en', 10:18:57 INFO - 'LOGNAME': 'cltbld', 10:18:57 INFO - 'MAIL': '/var/mail/cltbld', 10:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:57 INFO - 'MOZ_NO_REMOTE': '1', 10:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:57 INFO - 'NO_EM_RESTART': '1', 10:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:57 INFO - 'PWD': '/builds/slave/test', 10:18:57 INFO - 'SHELL': '/bin/bash', 10:18:57 INFO - 'SHLVL': '1', 10:18:57 INFO - 'TERM': 'linux', 10:18:57 INFO - 'TMOUT': '86400', 10:18:57 INFO - 'USER': 'cltbld', 10:18:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:57 INFO - '_': '/tools/buildbot/bin/python'} 10:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:57 INFO - Downloading/unpacking jsonschema==2.5.1 10:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:18:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:00 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:00 INFO - warning: no files found matching '*.txt' 10:19:00 INFO - no previously-included directories found matching 'build' 10:19:00 INFO - no previously-included directories found matching 'dist' 10:19:00 INFO - no previously-included directories found matching '.git*' 10:19:00 INFO - Installing collected packages: jsonschema, functools32 10:19:00 INFO - Running setup.py install for functools32 10:19:00 INFO - warning: no files found matching '*.txt' 10:19:00 INFO - no previously-included directories found matching 'build' 10:19:00 INFO - no previously-included directories found matching 'dist' 10:19:00 INFO - no previously-included directories found matching '.git*' 10:19:00 INFO - Successfully installed jsonschema functools32 10:19:00 INFO - Cleaning up... 10:19:00 INFO - Return code: 0 10:19:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19:00 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')]} 10:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:00 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')]} 10:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:00 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 0x1e2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:19:00 INFO - Using env: {'DISPLAY': ':0', 10:19:00 INFO - 'HOME': '/home/cltbld', 10:19:00 INFO - 'LANG': 'en_US.UTF-8', 10:19:00 INFO - 'LANGUAGE': 'en_US:en', 10:19:00 INFO - 'LOGNAME': 'cltbld', 10:19:00 INFO - 'MAIL': '/var/mail/cltbld', 10:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:00 INFO - 'MOZ_NO_REMOTE': '1', 10:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:00 INFO - 'NO_EM_RESTART': '1', 10:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:00 INFO - 'PWD': '/builds/slave/test', 10:19:00 INFO - 'SHELL': '/bin/bash', 10:19:00 INFO - 'SHLVL': '1', 10:19:00 INFO - 'TERM': 'linux', 10:19:00 INFO - 'TMOUT': '86400', 10:19:00 INFO - 'USER': 'cltbld', 10:19:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:00 INFO - '_': '/tools/buildbot/bin/python'} 10:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:03 INFO - Downloading docopt-0.6.1.tar.gz 10:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:03 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:03 INFO - Running setup.py install for blobuploader 10:19:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:03 INFO - Running setup.py install for requests 10:19:03 INFO - Running setup.py install for docopt 10:19:03 INFO - Successfully installed blobuploader requests docopt 10:19:03 INFO - Cleaning up... 10:19:03 INFO - Return code: 0 10:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:03 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')]} 10:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:03 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')]} 10:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:03 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 0x1e2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:03 INFO - Using env: {'DISPLAY': ':0', 10:19:03 INFO - 'HOME': '/home/cltbld', 10:19:03 INFO - 'LANG': 'en_US.UTF-8', 10:19:03 INFO - 'LANGUAGE': 'en_US:en', 10:19:03 INFO - 'LOGNAME': 'cltbld', 10:19:03 INFO - 'MAIL': '/var/mail/cltbld', 10:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:03 INFO - 'MOZ_NO_REMOTE': '1', 10:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:03 INFO - 'NO_EM_RESTART': '1', 10:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:03 INFO - 'PWD': '/builds/slave/test', 10:19:03 INFO - 'SHELL': '/bin/bash', 10:19:03 INFO - 'SHLVL': '1', 10:19:03 INFO - 'TERM': 'linux', 10:19:03 INFO - 'TMOUT': '86400', 10:19:03 INFO - 'USER': 'cltbld', 10:19:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:03 INFO - '_': '/tools/buildbot/bin/python'} 10:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:04 INFO - Running setup.py (path:/tmp/pip-BosNnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:04 INFO - Running setup.py (path:/tmp/pip-VxlVWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:04 INFO - Running setup.py (path:/tmp/pip-04l_UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:04 INFO - Running setup.py (path:/tmp/pip-eCqRKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:04 INFO - Running setup.py (path:/tmp/pip-YgC49e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:04 INFO - Running setup.py (path:/tmp/pip-HAU9E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:04 INFO - Running setup.py (path:/tmp/pip-OPZLkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:04 INFO - Running setup.py (path:/tmp/pip-e5Pqcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:04 INFO - Running setup.py (path:/tmp/pip-CMtPKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:04 INFO - Running setup.py (path:/tmp/pip-3kM0vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:04 INFO - Running setup.py (path:/tmp/pip-kW3cMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:04 INFO - Running setup.py (path:/tmp/pip-BjpuOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:04 INFO - Running setup.py (path:/tmp/pip-MIakSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:04 INFO - Running setup.py (path:/tmp/pip-yFYX5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:05 INFO - Running setup.py (path:/tmp/pip-qo_hG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:05 INFO - Running setup.py (path:/tmp/pip-CIaAfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:05 INFO - Running setup.py (path:/tmp/pip-VIplNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:05 INFO - Running setup.py install for manifestparser 10:19:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:05 INFO - Running setup.py install for mozcrash 10:19:05 INFO - Running setup.py install for mozdebug 10:19:05 INFO - Running setup.py install for mozdevice 10:19:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:05 INFO - Running setup.py install for mozfile 10:19:05 INFO - Running setup.py install for mozhttpd 10:19:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:05 INFO - Running setup.py install for mozinfo 10:19:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:05 INFO - Running setup.py install for mozInstall 10:19:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Running setup.py install for mozleak 10:19:06 INFO - Running setup.py install for mozlog 10:19:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Running setup.py install for moznetwork 10:19:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Running setup.py install for mozprocess 10:19:06 INFO - Running setup.py install for mozprofile 10:19:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Running setup.py install for mozrunner 10:19:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:06 INFO - Running setup.py install for mozscreenshot 10:19:06 INFO - Running setup.py install for moztest 10:19:06 INFO - Running setup.py install for mozversion 10:19:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:07 INFO - Cleaning up... 10:19:07 INFO - Return code: 0 10:19:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:07 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 0x1e2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:07 INFO - Using env: {'DISPLAY': ':0', 10:19:07 INFO - 'HOME': '/home/cltbld', 10:19:07 INFO - 'LANG': 'en_US.UTF-8', 10:19:07 INFO - 'LANGUAGE': 'en_US:en', 10:19:07 INFO - 'LOGNAME': 'cltbld', 10:19:07 INFO - 'MAIL': '/var/mail/cltbld', 10:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:07 INFO - 'MOZ_NO_REMOTE': '1', 10:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:07 INFO - 'NO_EM_RESTART': '1', 10:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:07 INFO - 'PWD': '/builds/slave/test', 10:19:07 INFO - 'SHELL': '/bin/bash', 10:19:07 INFO - 'SHLVL': '1', 10:19:07 INFO - 'TERM': 'linux', 10:19:07 INFO - 'TMOUT': '86400', 10:19:07 INFO - 'USER': 'cltbld', 10:19:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:07 INFO - '_': '/tools/buildbot/bin/python'} 10:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:07 INFO - Running setup.py (path:/tmp/pip-rtq7du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:07 INFO - Running setup.py (path:/tmp/pip-nU0HYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:07 INFO - Running setup.py (path:/tmp/pip-3t3Rly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:07 INFO - Running setup.py (path:/tmp/pip-qE3HZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:07 INFO - Running setup.py (path:/tmp/pip-GDugAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:07 INFO - Running setup.py (path:/tmp/pip-BDVRgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:07 INFO - Running setup.py (path:/tmp/pip-l4zzoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:07 INFO - Running setup.py (path:/tmp/pip-Mw1jA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:07 INFO - Running setup.py (path:/tmp/pip-UXOJUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:07 INFO - Running setup.py (path:/tmp/pip-HALUrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:07 INFO - Running setup.py (path:/tmp/pip-iZHj9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:08 INFO - Running setup.py (path:/tmp/pip-2CaYvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:08 INFO - Running setup.py (path:/tmp/pip-tpCrQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:08 INFO - Running setup.py (path:/tmp/pip-RqcNB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:08 INFO - Running setup.py (path:/tmp/pip-bOrWU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:08 INFO - Running setup.py (path:/tmp/pip-ZzoN7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:08 INFO - Running setup.py (path:/tmp/pip-bKieuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:10 INFO - Downloading blessings-1.6.tar.gz 10:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:10 INFO - Installing collected packages: blessings 10:19:10 INFO - Running setup.py install for blessings 10:19:10 INFO - Successfully installed blessings 10:19:10 INFO - Cleaning up... 10:19:10 INFO - Return code: 0 10:19:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:10 INFO - Reading from file tmpfile_stdout 10:19:10 INFO - Current package versions: 10:19:10 INFO - argparse == 1.2.1 10:19:10 INFO - blessings == 1.6 10:19:10 INFO - blobuploader == 1.2.4 10:19:10 INFO - docopt == 0.6.1 10:19:10 INFO - functools32 == 3.2.3-2 10:19:10 INFO - jsonschema == 2.5.1 10:19:10 INFO - manifestparser == 1.1 10:19:10 INFO - mozInstall == 1.12 10:19:10 INFO - mozcrash == 0.17 10:19:10 INFO - mozdebug == 0.1 10:19:10 INFO - mozdevice == 0.48 10:19:10 INFO - mozfile == 1.2 10:19:10 INFO - mozhttpd == 0.7 10:19:10 INFO - mozinfo == 0.9 10:19:10 INFO - mozleak == 0.1 10:19:10 INFO - mozlog == 3.2 10:19:10 INFO - moznetwork == 0.27 10:19:10 INFO - mozprocess == 0.23 10:19:10 INFO - mozprofile == 0.28 10:19:10 INFO - mozrunner == 6.12 10:19:10 INFO - mozscreenshot == 0.1 10:19:10 INFO - mozsystemmonitor == 0.3 10:19:10 INFO - moztest == 0.7 10:19:10 INFO - mozversion == 1.4 10:19:10 INFO - psutil == 3.1.1 10:19:10 INFO - requests == 1.2.3 10:19:10 INFO - wsgiref == 0.1.2 10:19:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:10 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 0x1e2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:10 INFO - Using env: {'DISPLAY': ':0', 10:19:10 INFO - 'HOME': '/home/cltbld', 10:19:10 INFO - 'LANG': 'en_US.UTF-8', 10:19:10 INFO - 'LANGUAGE': 'en_US:en', 10:19:10 INFO - 'LOGNAME': 'cltbld', 10:19:10 INFO - 'MAIL': '/var/mail/cltbld', 10:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:10 INFO - 'MOZ_NO_REMOTE': '1', 10:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:10 INFO - 'NO_EM_RESTART': '1', 10:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:10 INFO - 'PWD': '/builds/slave/test', 10:19:10 INFO - 'SHELL': '/bin/bash', 10:19:10 INFO - 'SHLVL': '1', 10:19:10 INFO - 'TERM': 'linux', 10:19:10 INFO - 'TMOUT': '86400', 10:19:10 INFO - 'USER': 'cltbld', 10:19:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:10 INFO - '_': '/tools/buildbot/bin/python'} 10:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:19:11 INFO - Cleaning up... 10:19:11 INFO - Return code: 0 10:19:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:19:11 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')]} 10:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:11 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')]} 10:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:11 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 0x1e2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:19:11 INFO - Using env: {'DISPLAY': ':0', 10:19:11 INFO - 'HOME': '/home/cltbld', 10:19:11 INFO - 'LANG': 'en_US.UTF-8', 10:19:11 INFO - 'LANGUAGE': 'en_US:en', 10:19:11 INFO - 'LOGNAME': 'cltbld', 10:19:11 INFO - 'MAIL': '/var/mail/cltbld', 10:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:11 INFO - 'MOZ_NO_REMOTE': '1', 10:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:11 INFO - 'NO_EM_RESTART': '1', 10:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:11 INFO - 'PWD': '/builds/slave/test', 10:19:11 INFO - 'SHELL': '/bin/bash', 10:19:11 INFO - 'SHLVL': '1', 10:19:11 INFO - 'TERM': 'linux', 10:19:11 INFO - 'TMOUT': '86400', 10:19:11 INFO - 'USER': 'cltbld', 10:19:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:11 INFO - '_': '/tools/buildbot/bin/python'} 10:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:19:11 INFO - Cleaning up... 10:19:11 INFO - Return code: 0 10:19:11 INFO - Running post-action listener: _resource_record_post_action 10:19:11 INFO - Running post-action listener: _start_resource_monitoring 10:19:11 INFO - Starting resource monitoring. 10:19:11 INFO - ##### 10:19:11 INFO - ##### Finished create-virtualenv step (success) 10:19:11 INFO - ##### 10:19:11 INFO - ##### 10:19:11 INFO - ##### Running install step. 10:19:11 INFO - ##### 10:19:11 INFO - Running pre-action listener: _resource_record_pre_action 10:19:11 INFO - Running main action method: install 10:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:11 INFO - Reading from file tmpfile_stdout 10:19:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:19:11 INFO - Reading from file tmpfile_stdout 10:19:11 INFO - Output received: 10:19:11 INFO - Usage: mozinstall [options] installer 10:19:11 INFO - Options: 10:19:11 INFO - -h, --help show this help message and exit 10:19:11 INFO - -d DEST, --destination=DEST 10:19:11 INFO - Directory to install application into. [default: 10:19:11 INFO - "/builds/slave/test"] 10:19:11 INFO - --app=APP Application being installed. [default: firefox] 10:19:11 INFO - mkdir: /builds/slave/test/build/application 10:19:11 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'] 10:19:11 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 10:19:28 INFO - Reading from file tmpfile_stdout 10:19:28 INFO - Output received: 10:19:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:19:28 INFO - Running post-action listener: _resource_record_post_action 10:19:28 INFO - ##### 10:19:28 INFO - ##### Finished install step (success) 10:19:28 INFO - ##### 10:19:28 INFO - ##### 10:19:28 INFO - ##### Running run-tests step. 10:19:28 INFO - ##### 10:19:28 INFO - Running pre-action listener: _resource_record_pre_action 10:19:28 INFO - Running main action method: run_tests 10:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:19:28 INFO - Python 2.7.3 10:19:28 INFO - Return code: 0 10:19:28 INFO - grabbing minidump binary from tooltool 10:19:28 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')]} 10:19:28 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 0x20ea3b0>, '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 0x20eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:19:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:19:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:19:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:19:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:19:28 INFO - Return code: 0 10:19:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:19:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:19:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:19:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:19:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 10:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 10:19:28 INFO - Using env: {'DISPLAY': ':0', 10:19:28 INFO - 'HOME': '/home/cltbld', 10:19:28 INFO - 'LANG': 'en_US.UTF-8', 10:19:28 INFO - 'LANGUAGE': 'en_US:en', 10:19:28 INFO - 'LOGNAME': 'cltbld', 10:19:28 INFO - 'MAIL': '/var/mail/cltbld', 10:19:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:19:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:28 INFO - 'MOZ_NO_REMOTE': '1', 10:19:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:28 INFO - 'NO_EM_RESTART': '1', 10:19:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:28 INFO - 'PWD': '/builds/slave/test', 10:19:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:19:28 INFO - 'SHELL': '/bin/bash', 10:19:28 INFO - 'SHLVL': '1', 10:19:28 INFO - 'TERM': 'linux', 10:19:28 INFO - 'TMOUT': '86400', 10:19:28 INFO - 'USER': 'cltbld', 10:19:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400', 10:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:28 INFO - '_': '/tools/buildbot/bin/python'} 10:19:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 10:19:29 INFO - mozversion application_buildid: 20160711073027 10:19:29 INFO - mozversion application_changeset: 214884d507ee369c1cf14edb26527c4f9a97bf48 10:19:29 INFO - mozversion application_display_name: Nightly 10:19:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:19:29 INFO - mozversion application_name: Firefox 10:19:29 INFO - mozversion application_remotingname: firefox 10:19:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:19:29 INFO - mozversion application_vendor: Mozilla 10:19:29 INFO - mozversion application_version: 50.0a1 10:19:29 INFO - mozversion platform_buildid: 20160711073027 10:19:29 INFO - mozversion platform_changeset: 214884d507ee369c1cf14edb26527c4f9a97bf48 10:19:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:19:29 INFO - mozversion platform_version: 50.0a1 10:19:29 INFO - using testdate: 1468257569 10:19:29 INFO - actual date: 1468257569 10:19:29 INFO - starting webserver on 'localhost:55124' 10:19:29 INFO - SUITE-START | Running 2 tests 10:19:29 INFO - TEST-START | dromaeo_css 10:19:29 INFO - operating with platform_type : linux_ 10:19:29 INFO - Initialising browser for dromaeo_css test... 10:19:29 INFO - TEST-INFO | started process 3291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcXQpMw/profile http://localhost:55124/getInfo.html) 10:19:34 INFO - PROCESS | 3291 | __metrics Screen width/height:1600/1200 10:19:34 INFO - PROCESS | 3291 | colorDepth:24 10:19:34 INFO - PROCESS | 3291 | Browser inner width/height: 1024/697 10:19:34 INFO - PROCESS | 3291 | __metrics 10:19:35 INFO - PROCESS | 3291 | 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:19:35 INFO - PROCESS | 3291 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:36 INFO - PROCESS | 3291 | console.error: PushService: 10:19:36 INFO - PROCESS | 3291 | stateChangeProcessEnqueue: Error transitioning state 10:19:36 INFO - PROCESS | 3291 | UnknownError 10:19:37 INFO - TEST-INFO | 3291: exit 0 10:19:37 INFO - Browser initialized. 10:19:37 INFO - Running cycle 1/1 for dromaeo_css test... 10:19:37 INFO - TEST-INFO | started process 3376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcXQpMw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:48 INFO - PROCESS | 3376 | RSS: Main: 157073408 10:19:48 INFO - PROCESS | 3376 | 10:20:40 INFO - PROCESS | 3376 | 1468257640166 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:22:48 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:55124/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55124/tests/dromaeo/cssquery-ext.html) 10:22:49 INFO - PROCESS | 3376 | RSS: Main: 262332416 10:22:49 INFO - PROCESS | 3376 | 10:25:52 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:55124/tests/dromaeo/cssquery-ext.html (next: http://localhost:55124/tests/dromaeo/cssquery-jquery.html) 10:25:52 INFO - PROCESS | 3376 | RSS: Main: 232095744 10:25:52 INFO - PROCESS | 3376 | 10:28:54 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:55124/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55124/tests/dromaeo/cssquery-mootools.html) 10:28:55 INFO - PROCESS | 3376 | RSS: Main: 235192320 10:28:55 INFO - PROCESS | 3376 | 10:31:57 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:55124/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55124/tests/dromaeo/cssquery-prototype.html) 10:31:57 INFO - PROCESS | 3376 | RSS: Main: 229339136 10:31:57 INFO - PROCESS | 3376 | 10:35:00 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:55124/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55124/tests/dromaeo/cssquery-yui.html) 10:35:01 INFO - PROCESS | 3376 | RSS: Main: 209162240 10:35:01 INFO - PROCESS | 3376 | 10:38:03 INFO - PROCESS | 3376 | Cycle 1(1): loaded http://localhost:55124/tests/dromaeo/cssquery-yui.html (next: http://localhost:55124/tests/dromaeo/cssquery-dojo.html) 10:38:04 INFO - PROCESS | 3376 | RSS: Main: 307974144 10:38:04 INFO - PROCESS | 3376 | 10:38:04 INFO - PROCESS | 3376 | __start_tp_report 10:38:04 INFO - PROCESS | 3376 | _x_x_mozilla_page_load 10:38:04 INFO - PROCESS | 3376 | _x_x_mozilla_page_load_details 10:38:04 INFO - PROCESS | 3376 | |i|pagename|runs| 10:38:04 INFO - PROCESS | 3376 | |0;dojo.html;2998.7900846940715;3011.713887180717;3049.878004879805;3057.098156043968;3069.309405383789;5196.948030519694;5256.500632439912;5275.788968441262;5329.573634109267;5348.14429691249;5310.468953104688;5327.946720532794;5340.679559226449;5358.169483730018;5390.973045134769;4794.184988551937;4851.102546028978;4854.417469903617;4872;5057.26669632903;4948.257761335793;4955.331030310916;4975.427825800025;5030.874228144307;5041.546260836524;4809.27860820878;4852.587530059932;4856.732879691615;4920.3111564381015;4923.704577725348;4917.065757506062;4921.384826896638;4923.040007198598;4932.432770231398;4933.136701077333;4848.0788650156355;4849.442314133885;4861.124997500448;4872.488388719169;4882.09681208974;5320.148776195829;5365.436629153922;5384.40771515133;5397.190421436777;5462.016836969344;5779.364269930346;5783.8554036149435;5809.157672137517;5821.3014438267255;5832.329282132524;5597.104463285855;5688.288963879515;5802.187693722883;5857.472827445507;5876.324222714357;5321.973390133025;5330.360356757214;5405.918911216335;5406.945930540684;5409.24270602116;5829.387914268941;5831.4168583141345;5883.382244864228;5888.087346461305;5898.94101058984;5421.322334708161;5474.753636086386;5546.528545073633;5672.347680016851;5683.886322273532;5619.8595035123635;5642.23829782974;5680.488756011979;5680.715964201773;5688.317401911714;5621;5628.690422026746;5630.943690563124;5637.46444087811;5670.5747068969995;5485.369182543979;5621.297337832771;5633.126865335797;5695.572832037531;5697.743601537858;4385.386045953569;4389.539098394686;4390.7585082820115;4391.934120988188;4424.933625995613;3904.2191561687778;3914.6085391461197;3925.9214815703526;3957.3866050762176;3969.861054863066;5289.841304760864;5303.628745987744;5321.36143662763;5344.171653393731;5346.8395948121615;5670.773169073191;5687.51656109227;5699.430056994351;5701.600887937804;5754.7985820496915;5218.425973142951;5352.678839269656;5366.087765079946;5366.704831234241;5369.892602147936;4774.331593576902;4777.928331075037;4793.760311984456;4811.879703007453;4814.061258054716;5861.912071318934;5900.586958912835;5900.704964751745;5900.967330717107;5903.114532820111;5587.245721827501;5691.032524470933;5700.458456446631;5705.115707065412;5751.166080918327;5943.346231914399;5979.850503737442;5997.55018373615;6006.729697163725;6022.759089636365;5639.238702775237;5643.633163844337;5653.971730141323;5654.802081927113;5655.971720141538;5605.990921633982;5660.122680984454;5759;5792.884142317046;5797.623154494944;5594.384617692132;5597.244372009726;5604.439556044363;5605.635633683797;5638.323401191883;5615.2700148980375;5616.213730077874;5619.129034999582;5625.915611265917;5628.746706398304;5365.865853353541;5547.0570003098765;5553.111502159635;5622.578306626938;5629.549636029026;5618.6628802272;5656.236408084856;5665.405132461032;5713.200151978644;5723.227364305765;5480.561555075664;5540.113581826889;5543.584231182758;5543.6396634218645;5545.833624991256 10:38:04 INFO - PROCESS | 3376 | |1;ext.html;595.8986972214723;614.483833579793;616.1866336435907;634.3022675057438;640.8461969127408;33339.833300833496;36066.09834754132;36180.27639447213;36184.457233141526;43573;41100.58899411013;44460.2215911364;44756.77621611887;44792;44999.32501012488;9047.909520904805;9185.357025008252;9185.586648600796;9201.815963680723;9205.493697846616;8894.644214231423;8941.239994600466;8969.147930946583;9009.819803603925;9026.458412495238;9050.86423703645;9112.635494580209;9120.76869622599;9123.498207598579;9123.863142052842;9064.818703625957;9106;9108.8633670495;9110.772230694285;9114.043025482328;8800.207981281716;8832.69085582008;8875.979262384844;8889.333300002525;8910.420822646507;42771.57228427707;43035.35446968298;43169.136617267795;43234.78382608067;43321.35017974733;3510.2628448025944;3633.818309084535;3656.7257455690665;3690.612485688991;4161.812718427648;32708.509372359433;33433.48647932522;33615.327693445994;33701;33840.83079584611;4276.700630955803;4280.33654783506;4314.741115533078;4318.287482565404;4351.0862718829085;357201;358988;359247;359959.20020399994;360889;33471.16322091918;59500;60248.39751602428;60307;60365.69817150974;34071.829640852135;35795;35802.820985894905;35838;35863.4620480693;14292.85707142936;14435.422583096768;14436.278186090654;14458.927705361617;14485.92757036208;11772.117091218193;11829.88170118305;11830.112741544419;11842.526298947945;11883.70290742721;8070.273675369245;8084.636191371403;8093.635786389509;8117.837643247102;8145.877811832827;3153.8265395403014;3197.424463596575;3248.82131482766;3288.605367355885;3295.2915123248617;999.480270259461;1019.6023550815188;1028.9485525723685;1088.2382332367374;1153.6654370232707;29820.552691709643;30073;30239.546406803474;30385.24036899051;30972.535411968838;973.6251543155936;1082.53992053377;1096.0573906440454;1147.540983606564;1190.0360707826687;16079.517614471351;16168.353265869233;16338.428155014517;16446.588835278973;16489.587760306087;545177;600983;607014;608268;905059;56724.432755671914;56940;57292.42707572871;57406.42593574095;57430.69269804782;1226.576830993306;1346.6969931765275;1378.8552202018843;1398.6503374156462;1416.1078520531998;29103.272418189714;31176.171028587938;33534.832325838215;33734.662653373154;34228.144296391794;52769.736151319;53325;53527.73236133794;53583.71330293645;53823;517005;524743;527614;527671;529066;36936.44595331018;44607.77696111629;46857.531424685316;47319.763401182776;47797;47862.52137478581;48081;49118.75440622774;49925.50074499209;49990.75004624954;39400.605993939695;39434;39669.404958926214;40098.39852402158;40616.79691601523;39669.80165099156;39944;40172.39741403823;40213.798931005156;40599.1880162401;39295.80352098221;39399.80300098481;40737.79631101825;40771.796141019106;41005.589944100175;35092;36608;36929.63070369262;37033;37375;26927.730722693304;27168;27207.183784486497;27269.31826704269;27314.5902811454 10:38:04 INFO - PROCESS | 3376 | |2;jquery.html;394.7966797099493;397.88859119446545;404.33688750449267;404.749055585537;418.3306709265176;19150.329738459157;20488;20779.064942077606;20806.47983800406;21665.891670541627;19608.215671373164;19777.901110494462;20230.39308820734;20321.187152513918;20563.485912852186;5468.234447177399;5873.500752436048;5874.441928016853;5878.059510478324;5894.646321220719;5681.602287839853;5791.362950075489;5880.470757631812;5895.88208235835;5912.5861189716525;5833;5835.708214589275;5852.356240813507;5862.765489380441;5865.736041878125;5620.91568626471;5795.681237531934;5808.041673123929;5808.390119037483;5811.389804070575;5189.584833213334;5196.558292545138;5203.869903252449;5212.895742085175;5233.895322093536;23605;23730;24092.759072409226;24143.396415089588;24294;2309.6304591265484;2331.160782118436;2360.1267531013464;2609.6216048672836;2915.489789286866;14738;15237.466688665954;15499.302531386114;15659.608509787233;15893.364265429369;1997.4906398868195;2064.8244899183587;2081.2819577245828;2102.5479521902867;2109.4937215068426;59840.700796496174;75181.24818751797;76744.23255767427;84302.57848710779;86474.56762716209;10260.127889129359;10438.895611043945;11007.394593297286;11009.339439633488;11158.274712143684;12118.878811211951;12877.613671589866;12949.611511654666;12993.740125197442;13377.264250466123;8210.178982101743;8339.166083391612;8627.309815214769;8670.566471676391;8673.04596494385;8254.876176857351;8291.419600627898;8450.408471406943;8623.094575069528;8660.956695216484;6553.246376666744;6702.530822842452;6704.698288577026;6713.56361836479;6832.726690932406;1772.9202185901665;1779.7241427578747;1782.27817733818;1817.8545716342926;1898.3260942365537;957.9568919398644;980.3823591137538;986.7286496213599;1019.3883669798211;1033.194108595297;19462.124204410837;20500.282490113073;20628;20864.26975055866;20877.164913403598;996.6412091647002;1016.1515134862325;1035.5857656937135;1093.753905371285;1095.8191898336845;11254.49354779037;11741.279732126133;11855.703607409883;11908.285502869856;11925.88074119265;502962;507123;507263;509227;513682;81715.5914220437;85805.57097214473;85912;85988.57005715056;86140.56929715436;994.5673631969971;1013.7060252526832;1015.7866847961863;1020.1991436722137;1022.4683164754287;17571;17588.29646814164;17991.460256192335;17995.64008719792;18066.548336291697;30360.089197324116;36371.27257454889;45508.77245613751;45823.77088114538;46804.29793553168;56247;60619.69690151521;60850.391496086246;61113.69443152756;61306;5741;6667.8666426670225;8492.363072769444;8815;8997.685081022133;9775.80448391014;11035.668929932115;14324.212168330841;14365.066270692372;14431.42274309016;12102.515899363927;12441.564545240873;12530.74938501243;12573.685657858627;12584.622461326175;6821.624810635264;8044.4771089881315;12317.876821231674;12346.938265308616;12440.626781196579;11932;11953.462094205956;12174.817377739164;12232.449539770554;12351;7492.288232617892;7911.564863932539;9144.588493517675;9218.354715169873;9230.261579073524;12708.237505749685;12776.488940442277;13021.283829389475;13094.803577946528;13135.802962955373 10:38:04 INFO - PROCESS | 3376 | |3;mootools.html;1430.5279257844911;1505.8268299145598;1567.623770295129;1794.9012804295776;1826.707726763718;8600.91399086009;9144.542772861347;9190.172884440399;9203.585838637253;9209.53952302384;7518.96240518798;8409.411341206118;8602.741917742462;8635.222829945304;9052.954735226314;2339.157903154863;2369.3247424484025;2370.300761275419;2370.312609343297;2373.2998765364173;2037.623039737646;2338.7895089441945;2357;2357.57563638545;2361.456864921069;2273.9658905116435;2339.5671800716837;2348.9060437582475;2373.0389192377115;2374.169040835711;2323.523677646087;2338.6608941703444;2356.069352605711;2399.4481269308158;2402.279316205149;2326.592846251899;2341.0869760793303;2345.3784747042046;2346.8239882008916;2349.283468542094;9150.03924587922;9168.587413566405;9192.908070919271;9197.264218862474;9219.078092190794;5135.537801597837;5228.581713462914;5235.921461178085;5264.578833693296;5270.367555893317;3457.187560923206;3520.894373168809;3541.6354463260004;3608.6932610728118;3609.224016836393;1087.8205096159124;1105.6959336182533;1112.3270421395102;1137.3346592243547;1137.8862113788637;12849.48602055926;12865.871341286562;12876.613701588967;12892.80660790089;12894.742105157844;4404.141192467502;4445.955540444619;4581.106684196617;4600.033992861537;4659;10793.83809242862;10821.67534973952;10828.296160749525;10835.783284334428;10838.891611083945;5374.865628359323;5377.032134215879;5382.865428364322;5382.892342153135;5387.595930305243;4836.298736683161;4945.085159245551;4948.480409557017;4962.082014827269;4999.10016197088;3820.8471661133244;3850.8844734658005;3922.5881282465502;3936.0946982194255;3967.781772002568;1056.2183983851894;1142.954281828734;1154.4574050196395;1192.7077865922904;1251.8247445357658;960.9711708648751;1000.1598657127902;1001.5793366785822;1011.959521619127;1021.341234903483;6020.367861374581;6096.237970253718;6121.296050954108;6132.816015519542;6218;990.3166814897697;1004.382304882492;1007.6825799873017;1014.5333146752429;1042.9113525350278;4227.619514243733;4319.092990472036;4322.654187664979;4350.151720414488;4382;11107.944460277648;11291.3789741565;11308.604198853001;11423.714407139889;11436.828447573293;10146.594136234467;11267.605633802777;11362.375069371099;11374.374409407397;11377.715557111138;8130.75607731769;8424.28393586552;8428.78928026792;8608.698695545625;8614.095519970313;6119.541034422347;6322.0516922462;6364.140840986408;6414.679266036586;6476.6114033158165;10330.638427654996;10485.37087774736;10497.370157790558;10511.474426278808;10542.10392116648;10392.844107338246;10615.946920265349;10713.035826775627;10737.731556711145;10805.459727013775;8039.678412863654;8073.798155046171;8113.959430202811;8115.066767321833;8140.959295203486;8753.431026983226;8768.079351667982;8844.336674749291;8907.599158037774;8922.018577956549;6467.41793238592;7664.233576642514;7774.416918731231;8131.512109273463;8190.631421585924;7661.425393095652;7796.688132474637;7892.447528672938;7916.08964969036;8199.836003279781;7030.753923612649;7034;7141.428685705235;7145.285471452813;7155.570665760071;5123.87190320245;5166.483351664803;5174.353205849269;5175.948240517547;5226.033183860998;5105.463926287686;5121.641485096007;5144.871378215425;5174.7153906535505;5253.028189784902 10:38:04 INFO - PROCESS | 3376 | |4;prototype.html;316.64160750380853;327.09231881528757;328.1091835666166;329.90471634174537;334.6452760074321;5163.302954101196;5253.763580638871;5310.256564081027;5363.436839131893;5376.112941364675;5298.258243845865;5305.549028332596;5344.91982620261;5372.973135134329;5376.946230537694;4259.467566554188;4264.616184543391;4265.78671066447;4273.465816772903;4288.592583704543;3957.267905437489;4039.697022723293;4072.9796351018354;4259.957400425987;4279.331060886257;4146.170765846828;4167.354060120686;4177.430880008788;4185.434966279559;4188.392683060954;4163.875083747493;4168.645665118469;4178.498580170399;4180.352045432963;4180.456540649727;3621.764585301947;3663.780173189617;3710.4805327254207;3716.2939041582013;3718.8140592970512;5155.510226528474;5168.4314725380555;5191.870203244911;5196.2465442511;5207.323048003773;4757.66785300113;4789.544993225638;4791.7124972501415;4812.831550895737;4819.2530157825595;5234.8691282717855;5521.199426083235;5533.806316778893;5561.221428999943;5583.804566840141;4009.518857737061;4013.959860401417;4027.617376349242;4055.9797201013807;4063.6342729154517;5753.82738517841;5774.5091667208335;5786.392428795;5792.913106303409;5812.808374283261;3877.3990031545154;4161.83352665896;4165.896037550052;4167.354060120686;4171.311733563989;4149.668026557868;4153.276390298053;4157.272477316457;4159.417681524589;4159.83360665576;4777.590610769831;4787.760611969457;4792.2811578262845;4804.567588917014;4808.08646357191;5511.200875873056;5705.144228365778;5716.599838011382;5719.142128680648;5725.370209276976;1411.8517555656713;1431.498975358637;1431.9761370620056;1432.477145841781;1440.7406666799866;912.9360944733805;920.9217216536535;929.702495201529;944.5182956692137;952.4190243951184;4812.807487700523;4815.470298267188;4818.4217893852965;4832.51674832521;4855.344528488608;5096.719680417538;5098.011775407594;5155.7314781496025;5179.352580927384;5194.4026436959475;4622.445306563234;4758.904821903542;4824.467154743787;4840.685355451955;4850.490698476679;2708.2010806812036;2718.932026699348;2726.005008172003;2736.9325962874495;2744.3962328287744;5261.579073674096;5265.763040663102;5279.208118782137;5310.628256022042;5330.92003619946;4937.8271760488215;5121.359830021247;5145.761593706749;5214.556762675215;5235.476452354734;5298.483220470246;5318.8990348812;5319.308489896366;5322.361316642027;5323.866903327448;5074.264231686311;5146.948530514647;5183.844484665466;5198.974005130101;5199.324087868553;4822.6978715747255;5112.3865136183895;5131.358580177478;5142.948570514247;5168.276441298146;5152.871178220425;5177.715225662474;5248.326171679763;5313.628046036741;5327.440618734977;3779.6976241900034;3871.1289959759956;3874.3994680824517;3889.455476233386;4005.599440055971;5672.319321681424;5713.8285851424525;5718.228039214653;5727.68497732612;5739.483446489836;5370.865728356666;5588.608797384144;5593.776248949996;5594.244776955059;5612.158176273591;5515.255440515479;5537.972310138423;5551.555875530029;5562.527185189142;5571.05292100352;5509.641873278224;5534.1975413564005;5557.277553917965;5583.776648933997;5596.440355964371;5424.186372044225;5592.273004509388;5605.859853503695;5624.790670005968;5624.859378515406;5488.9725551371985;5495.313085864267;5511.255980442589;5521.834344969658;5542.334919809648 10:38:04 INFO - PROCESS | 3376 | |5;yui.html;751.7331347371683;756.8637645223861;793.8372633610111;833.6082041440521;870.4603146049449;14148.50480233192;15055.247237638128;15069.171195584238;15104.546863594096;15132;14808.25958702066;14863.10821350717;14865.777013344808;14874.628134296621;15015.174165420898;655.439599142732;664.0404615330849;673.9595624262536;674.7739507265072;770.9961450192741;803.3573141486817;816.2408959667507;816.657004058294;819.635262308273;821.2116368286452;862.6764963138822;864.148813418782;865.3336930563462;866.5970323799432;870.4516154822453;694.7603076938448;838.7777239031661;863.8315528471951;865.3077537969631;865.8441480533502;629.6631302253272;631.7251995381978;632.2665707778955;632.6362341653521;633.0883527720068;14371.71256574873;14399.856001440061;14402.639934001734;14477.78283325751;14483.275836208148;14692.779608305884;15127.621809454742;15130.697386052218;15140.318685659171;15151.090934543963;14051.859481405158;14060.08609440383;14086.366113524813;14193;14214.076085054437;4606.677532572721;4636.142313671981;4678.485366609671;4762.166620841339;4771.16504611695;65402.67298663476;67624;68405.65797171032;69092.654536728;85679.57160214221;11821.468033938494;12026.759464810655;12113.091518136174;12288.815667764991;12294.385280736105;19764.50588735293;19982.70025949612;20105.39683809488;20123.59752804965;20392;8984.371094023487;9171.35800493959;9172.312076594282;9337.71986840396;9467.479288639192;4959.603231741524;5013.24801279811;5028.622853285945;5077.136886729265;5194.4026436959475;3757.1734218471893;3792.50697409335;3890.4747859039235;3891.5524714658177;3893.4354518594646;673.8955461903315;678.8947713104477;693.0989713372595;693.143967200507;695.1137299942512;575.8330084275597;621.6798348850346;672.3243140643622;721.6391804097951;729.2925861913935;9956.900430995742;10104.179678716837;10144.69565913009;10240.283180177465;10263.966236295862;644.2687549631203;699.2309457073612;729.3982464466836;737.5242968285426;738.2801768275888;5018.974905125451;5116.872078198075;5137.614678899097;5223.92164117531;5225.399079105876;66081.66959165173;68021.31978680249;110066;119115;119783;65078.67460662761;72844.27155728375;86207.5689621548;97128;98750;90918.54540727254;92097;92725;94149.5292523533;94594.52702736443;9217.170454659114;9479.905200947902;9586.472743999147;9604;9674.274429417681;50885.745571273386;51559;53133;53150.20274695805;53426.198607020146;46977.53022469868;56549.71725141348;76594.23405765872;76627.23372766201;76851.61574192093;11657.825132623188;11724.296542207494;11878.406079696153;12139.696507587381;12769;13837.515686950908;13880.305984700926;14605.415783368546;15248.542543723706;16075.437359692354;14171.291435428393;14535.709285814013;14756.704865902408;14890.627734306296;14903.925480372529;14193.432262709375;14387.496437624633;14639.341229644479;14811.185384803939;14972.775408368665;14136.293185340897;14576.489822856149;14849.40602375893;14951.028183168059;15536.689266214838;11270.267432616854;11585;11664.708382290171;11783.293002419883;11830;10804.945975270073;10861.945690271497;11716.648500544998;11776.470058847544;11980.520779169085 10:38:04 INFO - PROCESS | 3376 | __end_tp_report 10:38:04 INFO - PROCESS | 3376 | __start_cc_report 10:38:04 INFO - PROCESS | 3376 | _x_x_mozilla_cycle_collect,878 10:38:04 INFO - PROCESS | 3376 | __end_cc_report 10:38:04 INFO - PROCESS | 3376 | __startTimestamp1468258684142__endTimestamp 10:38:04 INFO - PROCESS | 3376 | 10:38:04 INFO - PROCESS | 3376 | ------- Summary: start ------- 10:38:04 INFO - PROCESS | 3376 | Number of tests: 6 10:38:04 INFO - PROCESS | 3376 | 10:38:04 INFO - PROCESS | 3376 | [#0] dojo.html Cycles:165 Average:5311.82 Median:5543.64 stddev:605.66 (10.9%) stddev-sans-first:579.70 10:38:04 INFO - PROCESS | 3376 | Values: 2998.8 3011.7 3049.9 3057.1 3069.3 5196.9 5256.5 5275.8 5329.6 5348.1 5310.5 5327.9 5340.7 5358.2 5391.0 4794.2 4851.1 4854.4 4872.0 5057.3 4948.3 4955.3 4975.4 5030.9 5041.5 4809.3 4852.6 4856.7 4920.3 4923.7 4917.1 4921.4 4923.0 4932.4 4933.1 4848.1 4849.4 4861.1 4872.5 4882.1 5320.1 5365.4 5384.4 5397.2 5462.0 5779.4 5783.9 5809.2 5821.3 5832.3 5597.1 5688.3 5802.2 5857.5 5876.3 5322.0 5330.4 5405.9 5406.9 5409.2 5829.4 5831.4 5883.4 5888.1 5898.9 5421.3 5474.8 5546.5 5672.3 5683.9 5619.9 5642.2 5680.5 5680.7 5688.3 5621.0 5628.7 5630.9 5637.5 5670.6 5485.4 5621.3 5633.1 5695.6 5697.7 4385.4 4389.5 4390.8 4391.9 4424.9 3904.2 3914.6 3925.9 3957.4 3969.9 5289.8 5303.6 5321.4 5344.2 5346.8 5670.8 5687.5 5699.4 5701.6 5754.8 5218.4 5352.7 5366.1 5366.7 5369.9 4774.3 4777.9 4793.8 4811.9 4814.1 5861.9 5900.6 5900.7 5901.0 5903.1 5587.2 5691.0 5700.5 5705.1 5751.2 5943.3 5979.9 5997.6 6006.7 6022.8 5639.2 5643.6 5654.0 5654.8 5656.0 5606.0 5660.1 5759.0 5792.9 5797.6 5594.4 5597.2 5604.4 5605.6 5638.3 5615.3 5616.2 5619.1 5625.9 5628.7 5365.9 5547.1 5553.1 5622.6 5629.5 5618.7 5656.2 5665.4 5713.2 5723.2 5480.6 5540.1 5543.6 5543.6 5545.8 10:38:04 INFO - PROCESS | 3376 | 10:38:04 INFO - PROCESS | 3376 | [#1] ext.html Cycles:180 Average:65218.42 Median:40754.80 stddev:142427.97 (349.5%) stddev-sans-first:142744.87 10:38:04 INFO - PROCESS | 3376 | Values: 595.9 614.5 616.2 634.3 640.8 33339.8 36066.1 36180.3 36184.5 43573.0 41100.6 44460.2 44756.8 44792.0 44999.3 9047.9 9185.4 9185.6 9201.8 9205.5 8894.6 8941.2 8969.1 9009.8 9026.5 9050.9 9112.6 9120.8 9123.5 9123.9 9064.8 9106.0 9108.9 9110.8 9114.0 8800.2 8832.7 8876.0 8889.3 8910.4 42771.6 43035.4 43169.1 43234.8 43321.4 3510.3 3633.8 3656.7 3690.6 4161.8 32708.5 33433.5 33615.3 33701.0 33840.8 4276.7 4280.3 4314.7 4318.3 4351.1 357201.0 358988.0 359247.0 359959.2 360889.0 33471.2 59500.0 60248.4 60307.0 60365.7 34071.8 35795.0 35802.8 35838.0 35863.5 14292.9 14435.4 14436.3 14458.9 14485.9 11772.1 11829.9 11830.1 11842.5 11883.7 8070.3 8084.6 8093.6 8117.8 8145.9 3153.8 3197.4 3248.8 3288.6 3295.3 999.5 1019.6 1028.9 1088.2 1153.7 29820.6 30073.0 30239.5 30385.2 30972.5 973.6 1082.5 1096.1 1147.5 1190.0 16079.5 16168.4 16338.4 16446.6 16489.6 545177.0 600983.0 607014.0 608268.0 905059.0 56724.4 56940.0 57292.4 57406.4 57430.7 1226.6 1346.7 1378.9 1398.7 1416.1 29103.3 31176.2 33534.8 33734.7 34228.1 52769.7 53325.0 53527.7 53583.7 53823.0 517005.0 524743.0 527614.0 527671.0 529066.0 36936.4 44607.8 46857.5 47319.8 47797.0 47862.5 48081.0 49118.8 49925.5 49990.8 39400.6 39434.0 39669.4 40098.4 40616.8 39669.8 39944.0 40172.4 40213.8 40599.2 39295.8 39399.8 40737.8 40771.8 41005.6 35092.0 36608.0 36929.6 37033.0 37375.0 26927.7 27168.0 27207.2 27269.3 27314.6 10:38:04 INFO - PROCESS | 3376 | 10:38:04 INFO - PROCESS | 3376 | [#2] jquery.html Cycles:180 Average:29539.59 Median:2762.56 stddev:83446.24 (3020.6%) stddev-sans-first:83651.63 10:38:04 INFO - PROCESS | 3376 | Values: 394.8 397.9 404.3 404.7 418.3 19150.3 20488.0 20779.1 20806.5 21665.9 19608.2 19777.9 20230.4 20321.2 20563.5 5468.2 5873.5 5874.4 5878.1 5894.6 5681.6 5791.4 5880.5 5895.9 5912.6 5833.0 5835.7 5852.4 5862.8 5865.7 5620.9 5795.7 5808.0 5808.4 5811.4 5189.6 5196.6 5203.9 5212.9 5233.9 23605.0 23730.0 24092.8 24143.4 24294.0 2309.6 2331.2 2360.1 2609.6 2915.5 14738.0 15237.5 15499.3 15659.6 15893.4 1997.5 2064.8 2081.3 2102.5 2109.5 59840.7 75181.2 76744.2 84302.6 86474.6 10260.1 10438.9 11007.4 11009.3 11158.3 12118.9 12877.6 12949.6 12993.7 13377.3 8210.2 8339.2 8627.3 8670.6 8673.0 8254.9 8291.4 8450.4 8623.1 8661.0 6553.2 6702.5 6704.7 6713.6 6832.7 1772.9 1779.7 1782.3 1817.9 1898.3 958.0 980.4 986.7 1019.4 1033.2 19462.1 20500.3 20628.0 20864.3 20877.2 996.6 1016.2 1035.6 1093.8 1095.8 11254.5 11741.3 11855.7 11908.3 11925.9 502962.0 507123.0 507263.0 509227.0 513682.0 81715.6 85805.6 85912.0 85988.6 86140.6 994.6 1013.7 1015.8 1020.2 1022.5 17571.0 17588.3 17991.5 17995.6 18066.5 30360.1 36371.3 45508.8 45823.8 46804.3 56247.0 60619.7 60850.4 61113.7 61306.0 5741.0 6667.9 8492.4 8815.0 8997.7 9775.8 11035.7 14324.2 14365.1 14431.4 12102.5 12441.6 12530.7 12573.7 12584.6 6821.6 8044.5 12317.9 12346.9 12440.6 11932.0 11953.5 12174.8 12232.4 12351.0 7492.3 7911.6 9144.6 9218.4 9230.3 12708.2 12776.5 13021.3 13094.8 13135.8 10:38:04 INFO - PROCESS | 3376 | 10:38:04 INFO - PROCESS | 3376 | [#3] mootools.html Cycles:180 Average:5950.53 Median:4336.40 stddev:3430.52 (79.1%) stddev-sans-first:3423.33 10:38:04 INFO - PROCESS | 3376 | Values: 1430.5 1505.8 1567.6 1794.9 1826.7 8600.9 9144.5 9190.2 9203.6 9209.5 7519.0 8409.4 8602.7 8635.2 9053.0 2339.2 2369.3 2370.3 2370.3 2373.3 2037.6 2338.8 2357.0 2357.6 2361.5 2274.0 2339.6 2348.9 2373.0 2374.2 2323.5 2338.7 2356.1 2399.4 2402.3 2326.6 2341.1 2345.4 2346.8 2349.3 9150.0 9168.6 9192.9 9197.3 9219.1 5135.5 5228.6 5235.9 5264.6 5270.4 3457.2 3520.9 3541.6 3608.7 3609.2 1087.8 1105.7 1112.3 1137.3 1137.9 12849.5 12865.9 12876.6 12892.8 12894.7 4404.1 4446.0 4581.1 4600.0 4659.0 10793.8 10821.7 10828.3 10835.8 10838.9 5374.9 5377.0 5382.9 5382.9 5387.6 4836.3 4945.1 4948.5 4962.1 4999.1 3820.8 3850.9 3922.6 3936.1 3967.8 1056.2 1143.0 1154.5 1192.7 1251.8 961.0 1000.2 1001.6 1012.0 1021.3 6020.4 6096.2 6121.3 6132.8 6218.0 990.3 1004.4 1007.7 1014.5 1042.9 4227.6 4319.1 4322.7 4350.2 4382.0 11107.9 11291.4 11308.6 11423.7 11436.8 10146.6 11267.6 11362.4 11374.4 11377.7 8130.8 8424.3 8428.8 8608.7 8614.1 6119.5 6322.1 6364.1 6414.7 6476.6 10330.6 10485.4 10497.4 10511.5 10542.1 10392.8 10615.9 10713.0 10737.7 10805.5 8039.7 8073.8 8114.0 8115.1 8141.0 8753.4 8768.1 8844.3 8907.6 8922.0 6467.4 7664.2 7774.4 8131.5 8190.6 7661.4 7796.7 7892.4 7916.1 8199.8 7030.8 7034.0 7141.4 7145.3 7155.6 5123.9 5166.5 5174.4 5175.9 5226.0 5105.5 5121.6 5144.9 5174.7 5253.0 10:38:04 INFO - PROCESS | 3376 | 10:38:04 INFO - PROCESS | 3376 | [#4] prototype.html Cycles:180 Average:4550.04 Median:5149.91 stddev:1308.05 (25.4%) stddev-sans-first:1272.55 10:38:04 INFO - PROCESS | 3376 | Values: 316.6 327.1 328.1 329.9 334.6 5163.3 5253.8 5310.3 5363.4 5376.1 5298.3 5305.5 5344.9 5373.0 5376.9 4259.5 4264.6 4265.8 4273.5 4288.6 3957.3 4039.7 4073.0 4260.0 4279.3 4146.2 4167.4 4177.4 4185.4 4188.4 4163.9 4168.6 4178.5 4180.4 4180.5 3621.8 3663.8 3710.5 3716.3 3718.8 5155.5 5168.4 5191.9 5196.2 5207.3 4757.7 4789.5 4791.7 4812.8 4819.3 5234.9 5521.2 5533.8 5561.2 5583.8 4009.5 4014.0 4027.6 4056.0 4063.6 5753.8 5774.5 5786.4 5792.9 5812.8 3877.4 4161.8 4165.9 4167.4 4171.3 4149.7 4153.3 4157.3 4159.4 4159.8 4777.6 4787.8 4792.3 4804.6 4808.1 5511.2 5705.1 5716.6 5719.1 5725.4 1411.9 1431.5 1432.0 1432.5 1440.7 912.9 920.9 929.7 944.5 952.4 4812.8 4815.5 4818.4 4832.5 4855.3 5096.7 5098.0 5155.7 5179.4 5194.4 4622.4 4758.9 4824.5 4840.7 4850.5 2708.2 2718.9 2726.0 2736.9 2744.4 5261.6 5265.8 5279.2 5310.6 5330.9 4937.8 5121.4 5145.8 5214.6 5235.5 5298.5 5318.9 5319.3 5322.4 5323.9 5074.3 5146.9 5183.8 5199.0 5199.3 4822.7 5112.4 5131.4 5142.9 5168.3 5152.9 5177.7 5248.3 5313.6 5327.4 3779.7 3871.1 3874.4 3889.5 4005.6 5672.3 5713.8 5718.2 5727.7 5739.5 5370.9 5588.6 5593.8 5594.2 5612.2 5515.3 5538.0 5551.6 5562.5 5571.1 5509.6 5534.2 5557.3 5583.8 5596.4 5424.2 5592.3 5605.9 5624.8 5624.9 5489.0 5495.3 5511.3 5521.8 5542.3 10:38:04 INFO - PROCESS | 3376 | 10:38:04 INFO - PROCESS | 3376 | [#5] yui.html Cycles:180 Average:19934.88 Median:5023.80 stddev:27589.82 (549.2%) stddev-sans-first:27629.61 10:38:04 INFO - PROCESS | 3376 | Values: 751.7 756.9 793.8 833.6 870.5 14148.5 15055.2 15069.2 15104.5 15132.0 14808.3 14863.1 14865.8 14874.6 15015.2 655.4 664.0 674.0 674.8 771.0 803.4 816.2 816.7 819.6 821.2 862.7 864.1 865.3 866.6 870.5 694.8 838.8 863.8 865.3 865.8 629.7 631.7 632.3 632.6 633.1 14371.7 14399.9 14402.6 14477.8 14483.3 14692.8 15127.6 15130.7 15140.3 15151.1 14051.9 14060.1 14086.4 14193.0 14214.1 4606.7 4636.1 4678.5 4762.2 4771.2 65402.7 67624.0 68405.7 69092.7 85679.6 11821.5 12026.8 12113.1 12288.8 12294.4 19764.5 19982.7 20105.4 20123.6 20392.0 8984.4 9171.4 9172.3 9337.7 9467.5 4959.6 5013.2 5028.6 5077.1 5194.4 3757.2 3792.5 3890.5 3891.6 3893.4 673.9 678.9 693.1 693.1 695.1 575.8 621.7 672.3 721.6 729.3 9956.9 10104.2 10144.7 10240.3 10264.0 644.3 699.2 729.4 737.5 738.3 5019.0 5116.9 5137.6 5223.9 5225.4 66081.7 68021.3 110066.0 119115.0 119783.0 65078.7 72844.3 86207.6 97128.0 98750.0 90918.5 92097.0 92725.0 94149.5 94594.5 9217.2 9479.9 9586.5 9604.0 9674.3 50885.7 51559.0 53133.0 53150.2 53426.2 46977.5 56549.7 76594.2 76627.2 76851.6 11657.8 11724.3 11878.4 12139.7 12769.0 13837.5 13880.3 14605.4 15248.5 16075.4 14171.3 14535.7 14756.7 14890.6 14903.9 14193.4 14387.5 14639.3 14811.2 14972.8 14136.3 14576.5 14849.4 14951.0 15536.7 11270.3 11585.0 11664.7 11783.3 11830.0 10804.9 10861.9 11716.6 11776.5 11980.5 10:38:04 INFO - PROCESS | 3376 | -------- Summary: end -------- 10:38:04 INFO - PROCESS | 3376 | 10:38:04 INFO - TEST-INFO | 3376: exit 0 10:38:04 INFO - TEST-OK | dromaeo_css | took 1115815ms 10:38:04 INFO - TEST-START | kraken 10:38:04 INFO - operating with platform_type : linux_ 10:38:04 INFO - Initialising browser for kraken test... 10:38:04 INFO - TEST-INFO | started process 3565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZMV93/profile http://localhost:55124/getInfo.html) 10:38:08 INFO - PROCESS | 3565 | __metrics Screen width/height:1600/1200 10:38:08 INFO - PROCESS | 3565 | colorDepth:24 10:38:08 INFO - PROCESS | 3565 | Browser inner width/height: 1024/697 10:38:08 INFO - PROCESS | 3565 | __metrics 10:38:09 INFO - PROCESS | 3565 | 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:38:09 INFO - PROCESS | 3565 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:38:10 INFO - TEST-INFO | 3565: exit 0 10:38:10 INFO - Browser initialized. 10:38:10 INFO - Running cycle 1/1 for kraken test... 10:38:10 INFO - TEST-INFO | started process 3645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZMV93/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:22 INFO - PROCESS | 3645 | RSS: Main: 157102080 10:38:22 INFO - PROCESS | 3645 | 10:38:24 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55124/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:25 INFO - PROCESS | 3645 | RSS: Main: 215908352 10:38:25 INFO - PROCESS | 3645 | 10:38:28 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55124/tests/kraken/driver.html?testName=audio-dft) 10:38:28 INFO - PROCESS | 3645 | RSS: Main: 203513856 10:38:28 INFO - PROCESS | 3645 | 10:38:32 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55124/tests/kraken/driver.html?testName=audio-fft) 10:38:32 INFO - PROCESS | 3645 | RSS: Main: 268820480 10:38:32 INFO - PROCESS | 3645 | 10:38:34 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55124/tests/kraken/driver.html?testName=audio-oscillator) 10:38:35 INFO - PROCESS | 3645 | RSS: Main: 179965952 10:38:35 INFO - PROCESS | 3645 | 10:38:37 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55124/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:38:38 INFO - PROCESS | 3645 | RSS: Main: 184532992 10:38:38 INFO - PROCESS | 3645 | 10:38:41 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55124/tests/kraken/driver.html?testName=imaging-darkroom) 10:38:41 INFO - PROCESS | 3645 | RSS: Main: 219426816 10:38:41 INFO - PROCESS | 3645 | 10:38:45 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55124/tests/kraken/driver.html?testName=imaging-desaturate) 10:38:45 INFO - PROCESS | 3645 | RSS: Main: 221204480 10:38:45 INFO - PROCESS | 3645 | 10:38:48 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55124/tests/kraken/driver.html?testName=json-parse-financial) 10:38:49 INFO - PROCESS | 3645 | RSS: Main: 221290496 10:38:49 INFO - PROCESS | 3645 | 10:38:50 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55124/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:38:51 INFO - PROCESS | 3645 | RSS: Main: 208490496 10:38:51 INFO - PROCESS | 3645 | 10:38:53 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55124/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:38:53 INFO - PROCESS | 3645 | RSS: Main: 210993152 10:38:53 INFO - PROCESS | 3645 | 10:38:55 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55124/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:38:56 INFO - PROCESS | 3645 | RSS: Main: 209469440 10:38:56 INFO - PROCESS | 3645 | 10:38:58 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:38:59 INFO - PROCESS | 3645 | RSS: Main: 226869248 10:38:59 INFO - PROCESS | 3645 | 10:39:02 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:02 INFO - PROCESS | 3645 | RSS: Main: 224989184 10:39:02 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:55124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55124/tests/kraken/driver.html?testName=ai-astar) 10:39:04 INFO - PROCESS | 3645 | RSS: Main: 268763136 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | __start_tp_report 10:39:04 INFO - PROCESS | 3645 | _x_x_mozilla_page_load 10:39:04 INFO - PROCESS | 3645 | _x_x_mozilla_page_load_details 10:39:04 INFO - PROCESS | 3645 | |i|pagename|runs| 10:39:04 INFO - PROCESS | 3645 | |0;ai-astar;101;111;112;108;110;109;110;111;110;110 10:39:04 INFO - PROCESS | 3645 | |1;audio-beat-detection;146;123;119;178;119;117;148;117;166;116 10:39:04 INFO - PROCESS | 3645 | |2;audio-dft;162;160;160;162;160;159;159;161;160;160 10:39:04 INFO - PROCESS | 3645 | |3;audio-fft;74;86;75;125;76;75;75;74;98;73 10:39:04 INFO - PROCESS | 3645 | |4;audio-oscillator;85;84;113;83;85;84;117;83;84;140 10:39:04 INFO - PROCESS | 3645 | |5;imaging-gaussian-blur;117;117;116;116;117;117;118;117;117;117 10:39:04 INFO - PROCESS | 3645 | |6;imaging-darkroom;146;145;147;146;145;145;145;145;146;145 10:39:04 INFO - PROCESS | 3645 | |7;imaging-desaturate;95;96;95;95;94;95;95;95;95;95 10:39:04 INFO - PROCESS | 3645 | |8;json-parse-financial;53;54;53;54;54;54;54;54;54;54 10:39:04 INFO - PROCESS | 3645 | |9;json-stringify-tinderbox;60;61;61;61;60;61;61;61;61;61 10:39:04 INFO - PROCESS | 3645 | |10;stanford-crypto-aes;76;75;75;74;74;74;75;74;74;79 10:39:04 INFO - PROCESS | 3645 | |11;stanford-crypto-ccm;130;118;118;119;119;128;120;128;161;121 10:39:04 INFO - PROCESS | 3645 | |12;stanford-crypto-pbkdf2;163;157;158;157;157;157;156;156;154;155 10:39:04 INFO - PROCESS | 3645 | |13;stanford-crypto-sha256-iterative;64;63;63;62;62;74;61;63;62;70 10:39:04 INFO - PROCESS | 3645 | __end_tp_report 10:39:04 INFO - PROCESS | 3645 | __start_cc_report 10:39:04 INFO - PROCESS | 3645 | _x_x_mozilla_cycle_collect,1661 10:39:04 INFO - PROCESS | 3645 | __end_cc_report 10:39:04 INFO - PROCESS | 3645 | __startTimestamp1468258744745__endTimestamp 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | ------- Summary: start ------- 10:39:04 INFO - PROCESS | 3645 | Number of tests: 14 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:3.08 (2.8%) stddev-sans-first:1.17 10:39:04 INFO - PROCESS | 3645 | Values: 101.0 111.0 112.0 108.0 110.0 109.0 110.0 111.0 110.0 110.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:134.50 stddev:23.01 (17.1%) stddev-sans-first:24.05 10:39:04 INFO - PROCESS | 3645 | Values: 146.0 123.0 119.0 178.0 119.0 117.0 148.0 117.0 166.0 116.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 10:39:04 INFO - PROCESS | 3645 | Values: 162.0 160.0 160.0 162.0 160.0 159.0 159.0 161.0 160.0 160.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.00 stddev:16.67 (22.2%) stddev-sans-first:17.35 10:39:04 INFO - PROCESS | 3645 | Values: 74.0 86.0 75.0 125.0 76.0 75.0 75.0 74.0 98.0 73.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:84.00 stddev:20.21 (24.1%) stddev-sans-first:21.06 10:39:04 INFO - PROCESS | 3645 | Values: 85.0 84.0 113.0 83.0 85.0 84.0 117.0 83.0 84.0 140.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:39:04 INFO - PROCESS | 3645 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 10:39:04 INFO - PROCESS | 3645 | Values: 146.0 145.0 147.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:39:04 INFO - PROCESS | 3645 | Values: 95.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 10:39:04 INFO - PROCESS | 3645 | Values: 53.0 54.0 53.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 10:39:04 INFO - PROCESS | 3645 | Values: 60.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:1.56 (2.1%) stddev-sans-first:1.62 10:39:04 INFO - PROCESS | 3645 | Values: 76.0 75.0 75.0 74.0 74.0 74.0 75.0 74.0 74.0 79.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:124.50 stddev:13.06 (10.5%) stddev-sans-first:13.78 10:39:04 INFO - PROCESS | 3645 | Values: 130.0 118.0 118.0 119.0 119.0 128.0 120.0 128.0 161.0 121.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.00 stddev:2.40 (1.5%) stddev-sans-first:1.22 10:39:04 INFO - PROCESS | 3645 | Values: 163.0 157.0 158.0 157.0 157.0 157.0 156.0 156.0 154.0 155.0 10:39:04 INFO - PROCESS | 3645 | 10:39:04 INFO - PROCESS | 3645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:63.00 stddev:4.20 (6.7%) stddev-sans-first:4.45 10:39:04 INFO - PROCESS | 3645 | Values: 64.0 63.0 63.0 62.0 62.0 74.0 61.0 63.0 62.0 70.0 10:39:04 INFO - PROCESS | 3645 | -------- Summary: end -------- 10:39:04 INFO - PROCESS | 3645 | 10:39:05 INFO - TEST-INFO | 3645: exit 0 10:39:05 INFO - TEST-OK | kraken | took 60830ms 10:39:05 INFO - SUITE-END | took 1176s 10:39:05 INFO - Completed test suite (00:19:36) 10:39:05 INFO - javascript benchmark 10:39:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2998.7900846940715, 3011.713887180717, 3049.878004879805, 3057.098156043968, 3069.309405383789, 5196.948030519694, 5256.500632439912, 5275.788968441262, 5329.573634109267, 5348.14429691249, 5310.468953104688, 5327.946720532794, 5340.679559226449, 5358.169483730018, 5390.973045134769, 4794.184988551937, 4851.102546028978, 4854.417469903617, 4872.0, 5057.26669632903, 4948.257761335793, 4955.331030310916, 4975.427825800025, 5030.874228144307, 5041.546260836524, 4809.27860820878, 4852.587530059932, 4856.732879691615, 4920.3111564381015, 4923.704577725348, 4917.065757506062, 4921.384826896638, 4923.040007198598, 4932.432770231398, 4933.136701077333, 4848.0788650156355, 4849.442314133885, 4861.124997500448, 4872.488388719169, 4882.09681208974, 5320.148776195829, 5365.436629153922, 5384.40771515133, 5397.190421436777, 5462.016836969344, 5779.364269930346, 5783.8554036149435, 5809.157672137517, 5821.3014438267255, 5832.329282132524, 5597.104463285855, 5688.288963879515, 5802.187693722883, 5857.472827445507, 5876.324222714357, 5321.973390133025, 5330.360356757214, 5405.918911216335, 5406.945930540684, 5409.24270602116, 5829.387914268941, 5831.4168583141345, 5883.382244864228, 5888.087346461305, 5898.94101058984, 5421.322334708161, 5474.753636086386, 5546.528545073633, 5672.347680016851, 5683.886322273532, 5619.8595035123635, 5642.23829782974, 5680.488756011979, 5680.715964201773, 5688.317401911714, 5621.0, 5628.690422026746, 5630.943690563124, 5637.46444087811, 5670.5747068969995, 5485.369182543979, 5621.297337832771, 5633.126865335797, 5695.572832037531, 5697.743601537858, 4385.386045953569, 4389.539098394686, 4390.7585082820115, 4391.934120988188, 4424.933625995613, 3904.2191561687778, 3914.6085391461197, 3925.9214815703526, 3957.3866050762176, 3969.861054863066, 5289.841304760864, 5303.628745987744, 5321.36143662763, 5344.171653393731, 5346.8395948121615, 5670.773169073191, 5687.51656109227, 5699.430056994351, 5701.600887937804, 5754.7985820496915, 5218.425973142951, 5352.678839269656, 5366.087765079946, 5366.704831234241, 5369.892602147936, 4774.331593576902, 4777.928331075037, 4793.760311984456, 4811.879703007453, 4814.061258054716, 5861.912071318934, 5900.586958912835, 5900.704964751745, 5900.967330717107, 5903.114532820111, 5587.245721827501, 5691.032524470933, 5700.458456446631, 5705.115707065412, 5751.166080918327, 5943.346231914399, 5979.850503737442, 5997.55018373615, 6006.729697163725, 6022.759089636365, 5639.238702775237, 5643.633163844337, 5653.971730141323, 5654.802081927113, 5655.971720141538, 5605.990921633982, 5660.122680984454, 5759.0, 5792.884142317046, 5797.623154494944, 5594.384617692132, 5597.244372009726, 5604.439556044363, 5605.635633683797, 5638.323401191883, 5615.2700148980375, 5616.213730077874, 5619.129034999582, 5625.915611265917, 5628.746706398304, 5365.865853353541, 5547.0570003098765, 5553.111502159635, 5622.578306626938, 5629.549636029026, 5618.6628802272, 5656.236408084856, 5665.405132461032, 5713.200151978644, 5723.227364305765, 5480.561555075664, 5540.113581826889, 5543.584231182758, 5543.6396634218645, 5545.833624991256], "value": 5270.388725519368, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.8986972214723, 614.483833579793, 616.1866336435907, 634.3022675057438, 640.8461969127408, 33339.833300833496, 36066.09834754132, 36180.27639447213, 36184.457233141526, 43573.0, 41100.58899411013, 44460.2215911364, 44756.77621611887, 44792.0, 44999.32501012488, 9047.909520904805, 9185.357025008252, 9185.586648600796, 9201.815963680723, 9205.493697846616, 8894.644214231423, 8941.239994600466, 8969.147930946583, 9009.819803603925, 9026.458412495238, 9050.86423703645, 9112.635494580209, 9120.76869622599, 9123.498207598579, 9123.863142052842, 9064.818703625957, 9106.0, 9108.8633670495, 9110.772230694285, 9114.043025482328, 8800.207981281716, 8832.69085582008, 8875.979262384844, 8889.333300002525, 8910.420822646507, 42771.57228427707, 43035.35446968298, 43169.136617267795, 43234.78382608067, 43321.35017974733, 3510.2628448025944, 3633.818309084535, 3656.7257455690665, 3690.612485688991, 4161.812718427648, 32708.509372359433, 33433.48647932522, 33615.327693445994, 33701.0, 33840.83079584611, 4276.700630955803, 4280.33654783506, 4314.741115533078, 4318.287482565404, 4351.0862718829085, 357201.0, 358988.0, 359247.0, 359959.20020399994, 360889.0, 33471.16322091918, 59500.0, 60248.39751602428, 60307.0, 60365.69817150974, 34071.829640852135, 35795.0, 35802.820985894905, 35838.0, 35863.4620480693, 14292.85707142936, 14435.422583096768, 14436.278186090654, 14458.927705361617, 14485.92757036208, 11772.117091218193, 11829.88170118305, 11830.112741544419, 11842.526298947945, 11883.70290742721, 8070.273675369245, 8084.636191371403, 8093.635786389509, 8117.837643247102, 8145.877811832827, 3153.8265395403014, 3197.424463596575, 3248.82131482766, 3288.605367355885, 3295.2915123248617, 999.480270259461, 1019.6023550815188, 1028.9485525723685, 1088.2382332367374, 1153.6654370232707, 29820.552691709643, 30073.0, 30239.546406803474, 30385.24036899051, 30972.535411968838, 973.6251543155936, 1082.53992053377, 1096.0573906440454, 1147.540983606564, 1190.0360707826687, 16079.517614471351, 16168.353265869233, 16338.428155014517, 16446.588835278973, 16489.587760306087, 545177.0, 600983.0, 607014.0, 608268.0, 905059.0, 56724.432755671914, 56940.0, 57292.42707572871, 57406.42593574095, 57430.69269804782, 1226.576830993306, 1346.6969931765275, 1378.8552202018843, 1398.6503374156462, 1416.1078520531998, 29103.272418189714, 31176.171028587938, 33534.832325838215, 33734.662653373154, 34228.144296391794, 52769.736151319, 53325.0, 53527.73236133794, 53583.71330293645, 53823.0, 517005.0, 524743.0, 527614.0, 527671.0, 529066.0, 36936.44595331018, 44607.77696111629, 46857.531424685316, 47319.763401182776, 47797.0, 47862.52137478581, 48081.0, 49118.75440622774, 49925.50074499209, 49990.75004624954, 39400.605993939695, 39434.0, 39669.404958926214, 40098.39852402158, 40616.79691601523, 39669.80165099156, 39944.0, 40172.39741403823, 40213.798931005156, 40599.1880162401, 39295.80352098221, 39399.80300098481, 40737.79631101825, 40771.796141019106, 41005.589944100175, 35092.0, 36608.0, 36929.63070369262, 37033.0, 37375.0, 26927.730722693304, 27168.0, 27207.183784486497, 27269.31826704269, 27314.5902811454], "value": 19219.709444172375, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.7966797099493, 397.88859119446545, 404.33688750449267, 404.749055585537, 418.3306709265176, 19150.329738459157, 20488.0, 20779.064942077606, 20806.47983800406, 21665.891670541627, 19608.215671373164, 19777.901110494462, 20230.39308820734, 20321.187152513918, 20563.485912852186, 5468.234447177399, 5873.500752436048, 5874.441928016853, 5878.059510478324, 5894.646321220719, 5681.602287839853, 5791.362950075489, 5880.470757631812, 5895.88208235835, 5912.5861189716525, 5833.0, 5835.708214589275, 5852.356240813507, 5862.765489380441, 5865.736041878125, 5620.91568626471, 5795.681237531934, 5808.041673123929, 5808.390119037483, 5811.389804070575, 5189.584833213334, 5196.558292545138, 5203.869903252449, 5212.895742085175, 5233.895322093536, 23605.0, 23730.0, 24092.759072409226, 24143.396415089588, 24294.0, 2309.6304591265484, 2331.160782118436, 2360.1267531013464, 2609.6216048672836, 2915.489789286866, 14738.0, 15237.466688665954, 15499.302531386114, 15659.608509787233, 15893.364265429369, 1997.4906398868195, 2064.8244899183587, 2081.2819577245828, 2102.5479521902867, 2109.4937215068426, 59840.700796496174, 75181.24818751797, 76744.23255767427, 84302.57848710779, 86474.56762716209, 10260.127889129359, 10438.895611043945, 11007.394593297286, 11009.339439633488, 11158.274712143684, 12118.878811211951, 12877.613671589866, 12949.611511654666, 12993.740125197442, 13377.264250466123, 8210.178982101743, 8339.166083391612, 8627.309815214769, 8670.566471676391, 8673.04596494385, 8254.876176857351, 8291.419600627898, 8450.408471406943, 8623.094575069528, 8660.956695216484, 6553.246376666744, 6702.530822842452, 6704.698288577026, 6713.56361836479, 6832.726690932406, 1772.9202185901665, 1779.7241427578747, 1782.27817733818, 1817.8545716342926, 1898.3260942365537, 957.9568919398644, 980.3823591137538, 986.7286496213599, 1019.3883669798211, 1033.194108595297, 19462.124204410837, 20500.282490113073, 20628.0, 20864.26975055866, 20877.164913403598, 996.6412091647002, 1016.1515134862325, 1035.5857656937135, 1093.753905371285, 1095.8191898336845, 11254.49354779037, 11741.279732126133, 11855.703607409883, 11908.285502869856, 11925.88074119265, 502962.0, 507123.0, 507263.0, 509227.0, 513682.0, 81715.5914220437, 85805.57097214473, 85912.0, 85988.57005715056, 86140.56929715436, 994.5673631969971, 1013.7060252526832, 1015.7866847961863, 1020.1991436722137, 1022.4683164754287, 17571.0, 17588.29646814164, 17991.460256192335, 17995.64008719792, 18066.548336291697, 30360.089197324116, 36371.27257454889, 45508.77245613751, 45823.77088114538, 46804.29793553168, 56247.0, 60619.69690151521, 60850.391496086246, 61113.69443152756, 61306.0, 5741.0, 6667.8666426670225, 8492.363072769444, 8815.0, 8997.685081022133, 9775.80448391014, 11035.668929932115, 14324.212168330841, 14365.066270692372, 14431.42274309016, 12102.515899363927, 12441.564545240873, 12530.74938501243, 12573.685657858627, 12584.622461326175, 6821.624810635264, 8044.4771089881315, 12317.876821231674, 12346.938265308616, 12440.626781196579, 11932.0, 11953.462094205956, 12174.817377739164, 12232.449539770554, 12351.0, 7492.288232617892, 7911.564863932539, 9144.588493517675, 9218.354715169873, 9230.261579073524, 12708.237505749685, 12776.488940442277, 13021.283829389475, 13094.803577946528, 13135.802962955373], "value": 9482.248020017383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.5279257844911, 1505.8268299145598, 1567.623770295129, 1794.9012804295776, 1826.707726763718, 8600.91399086009, 9144.542772861347, 9190.172884440399, 9203.585838637253, 9209.53952302384, 7518.96240518798, 8409.411341206118, 8602.741917742462, 8635.222829945304, 9052.954735226314, 2339.157903154863, 2369.3247424484025, 2370.300761275419, 2370.312609343297, 2373.2998765364173, 2037.623039737646, 2338.7895089441945, 2357.0, 2357.57563638545, 2361.456864921069, 2273.9658905116435, 2339.5671800716837, 2348.9060437582475, 2373.0389192377115, 2374.169040835711, 2323.523677646087, 2338.6608941703444, 2356.069352605711, 2399.4481269308158, 2402.279316205149, 2326.592846251899, 2341.0869760793303, 2345.3784747042046, 2346.8239882008916, 2349.283468542094, 9150.03924587922, 9168.587413566405, 9192.908070919271, 9197.264218862474, 9219.078092190794, 5135.537801597837, 5228.581713462914, 5235.921461178085, 5264.578833693296, 5270.367555893317, 3457.187560923206, 3520.894373168809, 3541.6354463260004, 3608.6932610728118, 3609.224016836393, 1087.8205096159124, 1105.6959336182533, 1112.3270421395102, 1137.3346592243547, 1137.8862113788637, 12849.48602055926, 12865.871341286562, 12876.613701588967, 12892.80660790089, 12894.742105157844, 4404.141192467502, 4445.955540444619, 4581.106684196617, 4600.033992861537, 4659.0, 10793.83809242862, 10821.67534973952, 10828.296160749525, 10835.783284334428, 10838.891611083945, 5374.865628359323, 5377.032134215879, 5382.865428364322, 5382.892342153135, 5387.595930305243, 4836.298736683161, 4945.085159245551, 4948.480409557017, 4962.082014827269, 4999.10016197088, 3820.8471661133244, 3850.8844734658005, 3922.5881282465502, 3936.0946982194255, 3967.781772002568, 1056.2183983851894, 1142.954281828734, 1154.4574050196395, 1192.7077865922904, 1251.8247445357658, 960.9711708648751, 1000.1598657127902, 1001.5793366785822, 1011.959521619127, 1021.341234903483, 6020.367861374581, 6096.237970253718, 6121.296050954108, 6132.816015519542, 6218.0, 990.3166814897697, 1004.382304882492, 1007.6825799873017, 1014.5333146752429, 1042.9113525350278, 4227.619514243733, 4319.092990472036, 4322.654187664979, 4350.151720414488, 4382.0, 11107.944460277648, 11291.3789741565, 11308.604198853001, 11423.714407139889, 11436.828447573293, 10146.594136234467, 11267.605633802777, 11362.375069371099, 11374.374409407397, 11377.715557111138, 8130.75607731769, 8424.28393586552, 8428.78928026792, 8608.698695545625, 8614.095519970313, 6119.541034422347, 6322.0516922462, 6364.140840986408, 6414.679266036586, 6476.6114033158165, 10330.638427654996, 10485.37087774736, 10497.370157790558, 10511.474426278808, 10542.10392116648, 10392.844107338246, 10615.946920265349, 10713.035826775627, 10737.731556711145, 10805.459727013775, 8039.678412863654, 8073.798155046171, 8113.959430202811, 8115.066767321833, 8140.959295203486, 8753.431026983226, 8768.079351667982, 8844.336674749291, 8907.599158037774, 8922.018577956549, 6467.41793238592, 7664.233576642514, 7774.416918731231, 8131.512109273463, 8190.631421585924, 7661.425393095652, 7796.688132474637, 7892.447528672938, 7916.08964969036, 8199.836003279781, 7030.753923612649, 7034.0, 7141.428685705235, 7145.285471452813, 7155.570665760071, 5123.87190320245, 5166.483351664803, 5174.353205849269, 5175.948240517547, 5226.033183860998, 5105.463926287686, 5121.641485096007, 5144.871378215425, 5174.7153906535505, 5253.028189784902], "value": 4736.889478233807, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.64160750380853, 327.09231881528757, 328.1091835666166, 329.90471634174537, 334.6452760074321, 5163.302954101196, 5253.763580638871, 5310.256564081027, 5363.436839131893, 5376.112941364675, 5298.258243845865, 5305.549028332596, 5344.91982620261, 5372.973135134329, 5376.946230537694, 4259.467566554188, 4264.616184543391, 4265.78671066447, 4273.465816772903, 4288.592583704543, 3957.267905437489, 4039.697022723293, 4072.9796351018354, 4259.957400425987, 4279.331060886257, 4146.170765846828, 4167.354060120686, 4177.430880008788, 4185.434966279559, 4188.392683060954, 4163.875083747493, 4168.645665118469, 4178.498580170399, 4180.352045432963, 4180.456540649727, 3621.764585301947, 3663.780173189617, 3710.4805327254207, 3716.2939041582013, 3718.8140592970512, 5155.510226528474, 5168.4314725380555, 5191.870203244911, 5196.2465442511, 5207.323048003773, 4757.66785300113, 4789.544993225638, 4791.7124972501415, 4812.831550895737, 4819.2530157825595, 5234.8691282717855, 5521.199426083235, 5533.806316778893, 5561.221428999943, 5583.804566840141, 4009.518857737061, 4013.959860401417, 4027.617376349242, 4055.9797201013807, 4063.6342729154517, 5753.82738517841, 5774.5091667208335, 5786.392428795, 5792.913106303409, 5812.808374283261, 3877.3990031545154, 4161.83352665896, 4165.896037550052, 4167.354060120686, 4171.311733563989, 4149.668026557868, 4153.276390298053, 4157.272477316457, 4159.417681524589, 4159.83360665576, 4777.590610769831, 4787.760611969457, 4792.2811578262845, 4804.567588917014, 4808.08646357191, 5511.200875873056, 5705.144228365778, 5716.599838011382, 5719.142128680648, 5725.370209276976, 1411.8517555656713, 1431.498975358637, 1431.9761370620056, 1432.477145841781, 1440.7406666799866, 912.9360944733805, 920.9217216536535, 929.702495201529, 944.5182956692137, 952.4190243951184, 4812.807487700523, 4815.470298267188, 4818.4217893852965, 4832.51674832521, 4855.344528488608, 5096.719680417538, 5098.011775407594, 5155.7314781496025, 5179.352580927384, 5194.4026436959475, 4622.445306563234, 4758.904821903542, 4824.467154743787, 4840.685355451955, 4850.490698476679, 2708.2010806812036, 2718.932026699348, 2726.005008172003, 2736.9325962874495, 2744.3962328287744, 5261.579073674096, 5265.763040663102, 5279.208118782137, 5310.628256022042, 5330.92003619946, 4937.8271760488215, 5121.359830021247, 5145.761593706749, 5214.556762675215, 5235.476452354734, 5298.483220470246, 5318.8990348812, 5319.308489896366, 5322.361316642027, 5323.866903327448, 5074.264231686311, 5146.948530514647, 5183.844484665466, 5198.974005130101, 5199.324087868553, 4822.6978715747255, 5112.3865136183895, 5131.358580177478, 5142.948570514247, 5168.276441298146, 5152.871178220425, 5177.715225662474, 5248.326171679763, 5313.628046036741, 5327.440618734977, 3779.6976241900034, 3871.1289959759956, 3874.3994680824517, 3889.455476233386, 4005.599440055971, 5672.319321681424, 5713.8285851424525, 5718.228039214653, 5727.68497732612, 5739.483446489836, 5370.865728356666, 5588.608797384144, 5593.776248949996, 5594.244776955059, 5612.158176273591, 5515.255440515479, 5537.972310138423, 5551.555875530029, 5562.527185189142, 5571.05292100352, 5509.641873278224, 5534.1975413564005, 5557.277553917965, 5583.776648933997, 5596.440355964371, 5424.186372044225, 5592.273004509388, 5605.859853503695, 5624.790670005968, 5624.859378515406, 5488.9725551371985, 5495.313085864267, 5511.255980442589, 5521.834344969658, 5542.334919809648], "value": 4134.02611523368, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.7331347371683, 756.8637645223861, 793.8372633610111, 833.6082041440521, 870.4603146049449, 14148.50480233192, 15055.247237638128, 15069.171195584238, 15104.546863594096, 15132.0, 14808.25958702066, 14863.10821350717, 14865.777013344808, 14874.628134296621, 15015.174165420898, 655.439599142732, 664.0404615330849, 673.9595624262536, 674.7739507265072, 770.9961450192741, 803.3573141486817, 816.2408959667507, 816.657004058294, 819.635262308273, 821.2116368286452, 862.6764963138822, 864.148813418782, 865.3336930563462, 866.5970323799432, 870.4516154822453, 694.7603076938448, 838.7777239031661, 863.8315528471951, 865.3077537969631, 865.8441480533502, 629.6631302253272, 631.7251995381978, 632.2665707778955, 632.6362341653521, 633.0883527720068, 14371.71256574873, 14399.856001440061, 14402.639934001734, 14477.78283325751, 14483.275836208148, 14692.779608305884, 15127.621809454742, 15130.697386052218, 15140.318685659171, 15151.090934543963, 14051.859481405158, 14060.08609440383, 14086.366113524813, 14193.0, 14214.076085054437, 4606.677532572721, 4636.142313671981, 4678.485366609671, 4762.166620841339, 4771.16504611695, 65402.67298663476, 67624.0, 68405.65797171032, 69092.654536728, 85679.57160214221, 11821.468033938494, 12026.759464810655, 12113.091518136174, 12288.815667764991, 12294.385280736105, 19764.50588735293, 19982.70025949612, 20105.39683809488, 20123.59752804965, 20392.0, 8984.371094023487, 9171.35800493959, 9172.312076594282, 9337.71986840396, 9467.479288639192, 4959.603231741524, 5013.24801279811, 5028.622853285945, 5077.136886729265, 5194.4026436959475, 3757.1734218471893, 3792.50697409335, 3890.4747859039235, 3891.5524714658177, 3893.4354518594646, 673.8955461903315, 678.8947713104477, 693.0989713372595, 693.143967200507, 695.1137299942512, 575.8330084275597, 621.6798348850346, 672.3243140643622, 721.6391804097951, 729.2925861913935, 9956.900430995742, 10104.179678716837, 10144.69565913009, 10240.283180177465, 10263.966236295862, 644.2687549631203, 699.2309457073612, 729.3982464466836, 737.5242968285426, 738.2801768275888, 5018.974905125451, 5116.872078198075, 5137.614678899097, 5223.92164117531, 5225.399079105876, 66081.66959165173, 68021.31978680249, 110066.0, 119115.0, 119783.0, 65078.67460662761, 72844.27155728375, 86207.5689621548, 97128.0, 98750.0, 90918.54540727254, 92097.0, 92725.0, 94149.5292523533, 94594.52702736443, 9217.170454659114, 9479.905200947902, 9586.472743999147, 9604.0, 9674.274429417681, 50885.745571273386, 51559.0, 53133.0, 53150.20274695805, 53426.198607020146, 46977.53022469868, 56549.71725141348, 76594.23405765872, 76627.23372766201, 76851.61574192093, 11657.825132623188, 11724.296542207494, 11878.406079696153, 12139.696507587381, 12769.0, 13837.515686950908, 13880.305984700926, 14605.415783368546, 15248.542543723706, 16075.437359692354, 14171.291435428393, 14535.709285814013, 14756.704865902408, 14890.627734306296, 14903.925480372529, 14193.432262709375, 14387.496437624633, 14639.341229644479, 14811.185384803939, 14972.775408368665, 14136.293185340897, 14576.489822856149, 14849.40602375893, 14951.028183168059, 15536.689266214838, 11270.267432616854, 11585.0, 11664.708382290171, 11783.293002419883, 11830.0, 10804.945975270073, 10861.945690271497, 11716.648500544998, 11776.470058847544, 11980.520779169085], "value": 7647.983369574026, "unit": "score"}], "name": "dromaeo_css", "value": 7238.686230193199, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 108.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 119.0, 178.0, 119.0, 117.0, 148.0, 117.0, 166.0, 116.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 162.0, 160.0, 159.0, 159.0, 161.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 86.0, 75.0, 125.0, 76.0, 75.0, 75.0, 74.0, 98.0, 73.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 113.0, 83.0, 85.0, 84.0, 117.0, 83.0, 84.0, 140.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 74.0, 74.0, 74.0, 75.0, 74.0, 74.0, 79.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 118.0, 118.0, 119.0, 119.0, 128.0, 120.0, 128.0, 161.0, 121.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 157.0, 158.0, 157.0, 157.0, 157.0, 156.0, 156.0, 154.0, 155.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 62.0, 74.0, 61.0, 63.0, 62.0, 70.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1477.9, "alertThreshold": 2.0}]} 10:39:05 INFO - Return code: 0 10:39:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:39:06 INFO - # TBPL SUCCESS # 10:39:06 INFO - Running post-action listener: _resource_record_post_action 10:39:06 INFO - ##### 10:39:06 INFO - ##### Finished run-tests step (success) 10:39:06 INFO - ##### 10:39:06 INFO - Running post-run listener: _resource_record_post_run 10:39:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7634944; Write bytes: 431312896; Read time: 932; Write time: 283344 10:39:06 INFO - TinderboxPrint: CPU usage
13.0% 10:39:06 INFO - TinderboxPrint: I/O read bytes / time
7,634,944 / 932 10:39:06 INFO - TinderboxPrint: I/O write bytes / time
431,312,896 / 283,344 10:39:06 INFO - TinderboxPrint: CPU idle
8,289.7 (87.0%) 10:39:06 INFO - TinderboxPrint: CPU user
1,195.7 (12.5%) 10:39:06 INFO - TinderboxPrint: Swap in / out
0 / 0 10:39:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 11051008; Read time: 0; Write time: 3500 10:39:06 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5394432; Write bytes: 420261888; Read time: 760; Write time: 279844 10:39:06 INFO - Running post-run listener: _upload_blobber_files 10:39:06 INFO - Blob upload gear active. 10:39:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:39:06 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:39:06 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:39:06 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:39:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:39:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:39:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:39:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:07 INFO - (blobuploader) - INFO - Done attempting. 10:39:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:39:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:39:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:08 INFO - (blobuploader) - INFO - Done attempting. 10:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:12 INFO - (blobuploader) - INFO - Done attempting. 10:39:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:39:12 INFO - Return code: 0 10:39:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:39:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:39:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44260aaa13ab642ffff40e700bc23fbaa2eba2cf851a26a5b9aeba4d39590ac296e911914b4babc6d1cbdc3cc68ab6b592cc11120998ee229179d93205150d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a36e9eb8f9863bb1ec8d57fbbe4a2d1c4fe1351226cda4ec3cc6c646ffba3e025ec827bc32d72e2088e6b15a8073d6c3015c24d333a99cc8354d020ae17d7bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4df0c7b62ea66f1cf9736193f261e575dca870f6dbb16bb34438d7ab267d7a8d0749ca472a0b164fdce518cc57efbde0f36d3ef4649f09211b3870a79b0996e"} 10:39:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:39:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:39:12 INFO - Contents: 10:39:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44260aaa13ab642ffff40e700bc23fbaa2eba2cf851a26a5b9aeba4d39590ac296e911914b4babc6d1cbdc3cc68ab6b592cc11120998ee229179d93205150d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a36e9eb8f9863bb1ec8d57fbbe4a2d1c4fe1351226cda4ec3cc6c646ffba3e025ec827bc32d72e2088e6b15a8073d6c3015c24d333a99cc8354d020ae17d7bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4df0c7b62ea66f1cf9736193f261e575dca870f6dbb16bb34438d7ab267d7a8d0749ca472a0b164fdce518cc57efbde0f36d3ef4649f09211b3870a79b0996e"} 10:39:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:39:12 INFO - Copying logs to upload dir... 10:39:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:39:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.082131 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-11 10:39:12.115874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 10:39:12.119716) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44260aaa13ab642ffff40e700bc23fbaa2eba2cf851a26a5b9aeba4d39590ac296e911914b4babc6d1cbdc3cc68ab6b592cc11120998ee229179d93205150d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a36e9eb8f9863bb1ec8d57fbbe4a2d1c4fe1351226cda4ec3cc6c646ffba3e025ec827bc32d72e2088e6b15a8073d6c3015c24d333a99cc8354d020ae17d7bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4df0c7b62ea66f1cf9736193f261e575dca870f6dbb16bb34438d7ab267d7a8d0749ca472a0b164fdce518cc57efbde0f36d3ef4649f09211b3870a79b0996e"} build_url:https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/MPlb5F_rRtOmeU24TgdY2A/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/Firefox/sha512/44260aaa13ab642ffff40e700bc23fbaa2eba2cf851a26a5b9aeba4d39590ac296e911914b4babc6d1cbdc3cc68ab6b592cc11120998ee229179d93205150d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a36e9eb8f9863bb1ec8d57fbbe4a2d1c4fe1351226cda4ec3cc6c646ffba3e025ec827bc32d72e2088e6b15a8073d6c3015c24d333a99cc8354d020ae17d7bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4df0c7b62ea66f1cf9736193f261e575dca870f6dbb16bb34438d7ab267d7a8d0749ca472a0b164fdce518cc57efbde0f36d3ef4649f09211b3870a79b0996e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 10:39:12.151421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:39:12.152133) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468256182.137570-1665535400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:39:12.233902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 10:39:12.234471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 10:39:12.234965) ========= ========= Total master_lag: 0.20 =========