builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1467123874.21 results: success (0) buildid: 20160628043018 builduid: 345a7297b3cb4547971e9adcaa7bb4c8 revision: 170e18a9341f79cdebd6cfa5114c1b4a2469c030 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:34.211771) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:34.212227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:34.212609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:34.227406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:34.227690) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 07:24:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.6M=0s 2016-06-28 07:24:34 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137989 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:34.379940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:34.380264) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015002 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:34.429814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:34.430158) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 170e18a9341f79cdebd6cfa5114c1b4a2469c030 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 170e18a9341f79cdebd6cfa5114c1b4a2469c030 --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=a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 07:24:34,595 truncating revision to first 12 chars 2016-06-28 07:24:34,595 Setting DEBUG logging. 2016-06-28 07:24:34,595 attempt 1/10 2016-06-28 07:24:34,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/170e18a9341f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 07:24:34,882 unpacking tar archive at: mozilla-inbound-170e18a9341f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633002 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:35.076183) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:35.076458) ========= script_repo_revision: 170e18a9341f79cdebd6cfa5114c1b4a2469c030 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:35.076851) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:35.077144) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 07:24:35.086748) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-28 07:24:35.087039) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:24:35 INFO - MultiFileLogger online at 20160628 07:24:35 in /builds/slave/test 07:24:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:24:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:24:35 INFO - {'append_to_log': False, 07:24:35 INFO - 'base_work_dir': '/builds/slave/test', 07:24:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:24:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:24:35 INFO - 'branch': 'Mozilla-Inbound', 07:24:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:24:35 INFO - 'config_files': ('talos/linux_config.py',), 07:24:35 INFO - 'default_actions': ('clobber', 07:24:35 INFO - 'read-buildbot-config', 07:24:35 INFO - 'download-and-extract', 07:24:35 INFO - 'populate-webroot', 07:24:35 INFO - 'create-virtualenv', 07:24:35 INFO - 'install', 07:24:35 INFO - 'run-tests'), 07:24:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:24:35 INFO - 'download_minidump_stackwalk': True, 07:24:35 INFO - 'download_symbols': 'ondemand', 07:24:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:24:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:24:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:24:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:24:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:24:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:24:35 INFO - 'installer_path': 'installer.exe', 07:24:35 INFO - 'log_level': 'info', 07:24:35 INFO - 'log_name': 'talos', 07:24:35 INFO - 'log_to_console': True, 07:24:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:24:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:24:35 INFO - 'opt_config_files': (), 07:24:35 INFO - 'pip_index': False, 07:24:35 INFO - 'sps_profile': False, 07:24:35 INFO - 'sps_profile_interval': 0, 07:24:35 INFO - 'suite': 'dromaeojs-e10s', 07:24:35 INFO - 'system_bits': '32', 07:24:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:24:35 INFO - 'title': 'talos-linux64-ix-062', 07:24:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:24:35 INFO - 'use_talos_json': True, 07:24:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:24:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:24:35 INFO - 'work_dir': 'build'} 07:24:35 INFO - ##### 07:24:35 INFO - ##### Running clobber step. 07:24:35 INFO - ##### 07:24:35 INFO - Running pre-action listener: _resource_record_pre_action 07:24:35 INFO - Running main action method: clobber 07:24:35 INFO - rmtree: /builds/slave/test/build 07:24:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:24:35 INFO - Running post-action listener: _resource_record_post_action 07:24:35 INFO - ##### 07:24:35 INFO - ##### Finished clobber step (success) 07:24:35 INFO - ##### 07:24:35 INFO - ##### 07:24:35 INFO - ##### Running read-buildbot-config step. 07:24:35 INFO - ##### 07:24:35 INFO - Running pre-action listener: _resource_record_pre_action 07:24:35 INFO - Running main action method: read_buildbot_config 07:24:35 INFO - Using buildbot properties: 07:24:35 INFO - { 07:24:35 INFO - "project": "", 07:24:35 INFO - "product": "firefox", 07:24:35 INFO - "script_repo_revision": "production", 07:24:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:24:35 INFO - "repository": "", 07:24:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:24:35 INFO - "buildid": "20160628043018", 07:24:35 INFO - "pgo_build": "True", 07:24:35 INFO - "basedir": "/builds/slave/test", 07:24:35 INFO - "buildnumber": 1229, 07:24:35 INFO - "slavename": "talos-linux64-ix-062", 07:24:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:24:35 INFO - "platform": "ubuntu64_hw", 07:24:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:24:35 INFO - "branch": "mozilla-inbound", 07:24:35 INFO - "repo_path": "integration/mozilla-inbound", 07:24:35 INFO - "revision": "170e18a9341f79cdebd6cfa5114c1b4a2469c030", 07:24:35 INFO - "stage_platform": "linux64-pgo", 07:24:35 INFO - "builduid": "345a7297b3cb4547971e9adcaa7bb4c8", 07:24:35 INFO - "slavebuilddir": "test" 07:24:35 INFO - } 07:24:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:24:35 INFO - Running post-action listener: _resource_record_post_action 07:24:35 INFO - ##### 07:24:35 INFO - ##### Finished read-buildbot-config step (success) 07:24:35 INFO - ##### 07:24:35 INFO - ##### 07:24:35 INFO - ##### Running download-and-extract step. 07:24:35 INFO - ##### 07:24:35 INFO - Running pre-action listener: _resource_record_pre_action 07:24:35 INFO - Running main action method: download_and_extract 07:24:35 INFO - mkdir: /builds/slave/test/build/tests 07:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:35 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:36 INFO - Downloaded 1361 bytes. 07:24:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:24:36 INFO - Using the following test package requirements: 07:24:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:24:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:24:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:24:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:36 INFO - u'jsshell-linux-x86_64.zip'], 07:24:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:24:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:24:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:24:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:24:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:24:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:24:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:24:36 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:38 INFO - Downloaded 24266499 bytes. 07:24:38 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'] 07:24:38 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 07:24:39 INFO - Return code: 0 07:24:39 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 07:24:39 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')]} 07:24:39 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:40 INFO - Downloaded 24266499 bytes. 07:24: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'] 07:24: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 07:24:41 INFO - Return code: 0 07:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:41 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:24:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:24:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:24:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:42 INFO - Downloaded 14405240 bytes. 07:24:42 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'] 07:24:42 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 07:24:43 INFO - Return code: 0 07:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:24:43 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/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 07:24:44 INFO - Downloaded 60326127 bytes. 07:24:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:24:44 INFO - mkdir: /builds/slave/test/properties 07:24:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:24:44 INFO - Writing to file /builds/slave/test/properties/build_url 07:24:44 INFO - Contents: 07:24:44 INFO - build_url:https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:24:45 INFO - Running post-action listener: _resource_record_post_action 07:24:45 INFO - Running post-action listener: set_extra_try_arguments 07:24:45 INFO - ##### 07:24:45 INFO - ##### Finished download-and-extract step (success) 07:24:45 INFO - ##### 07:24:45 INFO - ##### 07:24:45 INFO - ##### Running populate-webroot step. 07:24:45 INFO - ##### 07:24:45 INFO - Running pre-action listener: _resource_record_pre_action 07:24:45 INFO - Running main action method: populate_webroot 07:24:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:24:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:24:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:24:45 INFO - '--tppagecycles', 07:24:45 INFO - '7'], 07:24:45 INFO - 'tests': ['tsvgm']}}, 07:24:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:24:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:24:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:24:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:24:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:45 INFO - 'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:45 INFO - 'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['damp', 'tps']}, 07:24:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:45 INFO - 'tests': ['damp', 'tps']}, 07:24:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['dromaeo_dom']}, 07:24:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:24:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['basic_compositor_video']}, 07:24:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:24:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['a11yr', 07:24:45 INFO - 'ts_paint', 07:24:45 INFO - 'tpaint', 07:24:45 INFO - 'sessionrestore', 07:24:45 INFO - 'sessionrestore_no_auto_restore', 07:24:45 INFO - 'tabpaint']}, 07:24:45 INFO - 'other-e10s': {'tests': ['a11yr', 07:24:45 INFO - 'ts_paint', 07:24:45 INFO - 'tpaint', 07:24:45 INFO - 'sessionrestore', 07:24:45 INFO - 'sessionrestore_no_auto_restore', 07:24:45 INFO - 'tabpaint']}, 07:24:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:24:45 INFO - 'ts_paint', 07:24:45 INFO - 'tpaint', 07:24:45 INFO - 'sessionrestore', 07:24:45 INFO - 'sessionrestore_no_auto_restore', 07:24:45 INFO - 'tabpaint']}, 07:24:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:24:45 INFO - 'ts_paint', 07:24:45 INFO - 'tpaint', 07:24:45 INFO - 'sessionrestore', 07:24:45 INFO - 'sessionrestore_no_auto_restore', 07:24:45 INFO - 'tabpaint']}, 07:24:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['a11yr', 07:24:45 INFO - 'ts_paint', 07:24:45 INFO - 'tpaint', 07:24:45 INFO - 'sessionrestore', 07:24:45 INFO - 'sessionrestore_no_auto_restore', 07:24:45 INFO - 'tabpaint']}, 07:24:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['a11yr', 07:24:45 INFO - 'ts_paint', 07:24:45 INFO - 'tpaint', 07:24:45 INFO - 'sessionrestore', 07:24:45 INFO - 'sessionrestore_no_auto_restore', 07:24:45 INFO - 'tabpaint']}, 07:24:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['tsvgx', 07:24:45 INFO - 'tsvgr_opacity', 07:24:45 INFO - 'tart', 07:24:45 INFO - 'tscrollx', 07:24:45 INFO - 'cart']}, 07:24:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:24:45 INFO - 'tsvgr_opacity', 07:24:45 INFO - 'tart', 07:24:45 INFO - 'tscrollx', 07:24:45 INFO - 'cart']}, 07:24:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:45 INFO - 'talos_options': ['--disable-e10s'], 07:24:45 INFO - 'tests': ['tp5o']}, 07:24:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:45 INFO - 'tests': ['tp5o']}, 07:24:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:45 INFO - 'talos_options': ['--disable-e10s', 07:24:45 INFO - '--xperf_path', 07:24:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:45 INFO - 'tests': ['tp5n']}, 07:24:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:45 INFO - 'talos_options': ['--xperf_path', 07:24:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:45 INFO - 'tests': ['tp5n']}}, 07:24:45 INFO - 'talos.zip': {'path': '', 07:24:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:24:45 INFO - Running post-action listener: _resource_record_post_action 07:24:45 INFO - ##### 07:24:45 INFO - ##### Finished populate-webroot step (success) 07:24:45 INFO - ##### 07:24:45 INFO - ##### 07:24:45 INFO - ##### Running create-virtualenv step. 07:24:45 INFO - ##### 07:24:45 INFO - Running pre-action listener: _resource_record_pre_action 07:24:45 INFO - Running main action method: create_virtualenv 07:24:45 INFO - Creating virtualenv /builds/slave/test/build/venv 07:24:45 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 07:24:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:24:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:24:45 INFO - Using real prefix '/usr' 07:24:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:24:45 INFO - Installing distribute.............................................................................................................................................................................................done. 07:24:47 INFO - Installing pip.................done. 07:24:47 INFO - Return code: 0 07:24:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:47 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 0xc21030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe50400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', '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 07:24:47 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 07:24:47 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 07:24:47 INFO - Using env: {'DISPLAY': ':0', 07:24:47 INFO - 'HOME': '/home/cltbld', 07:24:47 INFO - 'LANG': 'en_US.UTF-8', 07:24:47 INFO - 'LANGUAGE': 'en_US:en', 07:24:47 INFO - 'LOGNAME': 'cltbld', 07:24:47 INFO - 'MAIL': '/var/mail/cltbld', 07:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:47 INFO - 'MOZ_NO_REMOTE': '1', 07:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:47 INFO - 'NO_EM_RESTART': '1', 07:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:47 INFO - 'PWD': '/builds/slave/test', 07:24:47 INFO - 'SHELL': '/bin/bash', 07:24:47 INFO - 'SHLVL': '1', 07:24:47 INFO - 'TERM': 'linux', 07:24:47 INFO - 'TMOUT': '86400', 07:24:47 INFO - 'USER': 'cltbld', 07:24:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:47 INFO - '_': '/tools/buildbot/bin/python'} 07:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:47 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 07:24:47 INFO - Cleaning up... 07:24:47 INFO - Return code: 0 07:24:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:47 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 0xc21030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe50400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', '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 07:24:47 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 07:24:47 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 07:24:47 INFO - Using env: {'DISPLAY': ':0', 07:24:47 INFO - 'HOME': '/home/cltbld', 07:24:47 INFO - 'LANG': 'en_US.UTF-8', 07:24:47 INFO - 'LANGUAGE': 'en_US:en', 07:24:47 INFO - 'LOGNAME': 'cltbld', 07:24:47 INFO - 'MAIL': '/var/mail/cltbld', 07:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:47 INFO - 'MOZ_NO_REMOTE': '1', 07:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:47 INFO - 'NO_EM_RESTART': '1', 07:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:47 INFO - 'PWD': '/builds/slave/test', 07:24:47 INFO - 'SHELL': '/bin/bash', 07:24:47 INFO - 'SHLVL': '1', 07:24:47 INFO - 'TERM': 'linux', 07:24:47 INFO - 'TMOUT': '86400', 07:24:47 INFO - 'USER': 'cltbld', 07:24:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:47 INFO - '_': '/tools/buildbot/bin/python'} 07:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:48 INFO - Downloading/unpacking psutil>=3.1.1 07:24:48 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 07:24:48 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 07:24:48 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 07:24:48 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 07:24:48 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 07:24:48 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 07:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:50 INFO - Installing collected packages: psutil 07:24:50 INFO - Running setup.py install for psutil 07:24:50 INFO - building 'psutil._psutil_linux' extension 07:24:50 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 07:24:50 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 07:24:50 INFO - building 'psutil._psutil_posix' extension 07:24:50 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 07:24:50 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 07:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:50 INFO - Successfully installed psutil 07:24:50 INFO - Cleaning up... 07:24:50 INFO - Return code: 0 07:24:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:24: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')]} 07:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24: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')]} 07:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc21030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe50400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', '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 07:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:24: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 mozsystemmonitor==0.3 07:24:50 INFO - Using env: {'DISPLAY': ':0', 07:24:50 INFO - 'HOME': '/home/cltbld', 07:24:50 INFO - 'LANG': 'en_US.UTF-8', 07:24:50 INFO - 'LANGUAGE': 'en_US:en', 07:24:50 INFO - 'LOGNAME': 'cltbld', 07:24:50 INFO - 'MAIL': '/var/mail/cltbld', 07:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:50 INFO - 'MOZ_NO_REMOTE': '1', 07:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:50 INFO - 'NO_EM_RESTART': '1', 07:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:50 INFO - 'PWD': '/builds/slave/test', 07:24:50 INFO - 'SHELL': '/bin/bash', 07:24:50 INFO - 'SHLVL': '1', 07:24:50 INFO - 'TERM': 'linux', 07:24:50 INFO - 'TMOUT': '86400', 07:24:50 INFO - 'USER': 'cltbld', 07:24:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:50 INFO - '_': '/tools/buildbot/bin/python'} 07:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:24:50 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 07:24:50 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 07:24:50 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 07:24:50 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 07:24:50 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 07:24:50 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 07:24:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:24:52 INFO - Installing collected packages: mozsystemmonitor 07:24:52 INFO - Running setup.py install for mozsystemmonitor 07:24:52 INFO - Successfully installed mozsystemmonitor 07:24:52 INFO - Cleaning up... 07:24:53 INFO - Return code: 0 07:24:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:24:53 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')]} 07:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:53 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')]} 07:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:53 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 0xc21030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe50400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', '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 07:24:53 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 07:24:53 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 07:24:53 INFO - Using env: {'DISPLAY': ':0', 07:24:53 INFO - 'HOME': '/home/cltbld', 07:24:53 INFO - 'LANG': 'en_US.UTF-8', 07:24:53 INFO - 'LANGUAGE': 'en_US:en', 07:24:53 INFO - 'LOGNAME': 'cltbld', 07:24:53 INFO - 'MAIL': '/var/mail/cltbld', 07:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:53 INFO - 'MOZ_NO_REMOTE': '1', 07:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:53 INFO - 'NO_EM_RESTART': '1', 07:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:53 INFO - 'PWD': '/builds/slave/test', 07:24:53 INFO - 'SHELL': '/bin/bash', 07:24:53 INFO - 'SHLVL': '1', 07:24:53 INFO - 'TERM': 'linux', 07:24:53 INFO - 'TMOUT': '86400', 07:24:53 INFO - 'USER': 'cltbld', 07:24:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:53 INFO - '_': '/tools/buildbot/bin/python'} 07:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:53 INFO - Downloading/unpacking jsonschema==2.5.1 07:24:53 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 07:24:53 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 07:24:53 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 07:24:53 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 07:24:53 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 07:24:53 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 07:24:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:24:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:24: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 07:24: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 07:24: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 07:24: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 07:24: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 07:24: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 07:24:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:24:55 INFO - warning: no files found matching '*.txt' 07:24:55 INFO - no previously-included directories found matching 'build' 07:24:55 INFO - no previously-included directories found matching 'dist' 07:24:55 INFO - no previously-included directories found matching '.git*' 07:24:55 INFO - Installing collected packages: jsonschema, functools32 07:24:55 INFO - Running setup.py install for functools32 07:24:55 INFO - warning: no files found matching '*.txt' 07:24:55 INFO - no previously-included directories found matching 'build' 07:24:55 INFO - no previously-included directories found matching 'dist' 07:24:55 INFO - no previously-included directories found matching '.git*' 07:24:55 INFO - Successfully installed jsonschema functools32 07:24:55 INFO - Cleaning up... 07:24:55 INFO - Return code: 0 07:24:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:24: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')]} 07:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24: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')]} 07:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24: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', '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 0xc21030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe50400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', '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 07:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:24: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 blobuploader==1.2.4 07:24:55 INFO - Using env: {'DISPLAY': ':0', 07:24:55 INFO - 'HOME': '/home/cltbld', 07:24:55 INFO - 'LANG': 'en_US.UTF-8', 07:24:55 INFO - 'LANGUAGE': 'en_US:en', 07:24:55 INFO - 'LOGNAME': 'cltbld', 07:24:55 INFO - 'MAIL': '/var/mail/cltbld', 07:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:55 INFO - 'MOZ_NO_REMOTE': '1', 07:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:55 INFO - 'NO_EM_RESTART': '1', 07:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:55 INFO - 'PWD': '/builds/slave/test', 07:24:55 INFO - 'SHELL': '/bin/bash', 07:24:55 INFO - 'SHLVL': '1', 07:24:55 INFO - 'TERM': 'linux', 07:24:55 INFO - 'TMOUT': '86400', 07:24:55 INFO - 'USER': 'cltbld', 07:24:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:55 INFO - '_': '/tools/buildbot/bin/python'} 07:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:24: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 07:24: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 07:24: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 07:24: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 07:24: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 07:24: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 07:24:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:24:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:24: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 07:24: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 07:24: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 07:24: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 07:24: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 07:24: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 07:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:24:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:24:58 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 07:24:58 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 07:24:58 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 07:24:58 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 07:24:58 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 07:24:58 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 07:24:58 INFO - Downloading docopt-0.6.1.tar.gz 07:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:24:58 INFO - Installing collected packages: blobuploader, requests, docopt 07:24:58 INFO - Running setup.py install for blobuploader 07:24:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:24:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:24:58 INFO - Running setup.py install for requests 07:24:58 INFO - Running setup.py install for docopt 07:24:59 INFO - Successfully installed blobuploader requests docopt 07:24:59 INFO - Cleaning up... 07:24:59 INFO - Return code: 0 07:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:59 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')]} 07:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:59 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')]} 07:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:59 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 0xc21030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe50400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', '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 07:24:59 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 07:24:59 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 07:24:59 INFO - Using env: {'DISPLAY': ':0', 07:24:59 INFO - 'HOME': '/home/cltbld', 07:24:59 INFO - 'LANG': 'en_US.UTF-8', 07:24:59 INFO - 'LANGUAGE': 'en_US:en', 07:24:59 INFO - 'LOGNAME': 'cltbld', 07:24:59 INFO - 'MAIL': '/var/mail/cltbld', 07:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:59 INFO - 'MOZ_NO_REMOTE': '1', 07:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:59 INFO - 'NO_EM_RESTART': '1', 07:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:59 INFO - 'PWD': '/builds/slave/test', 07:24:59 INFO - 'SHELL': '/bin/bash', 07:24:59 INFO - 'SHLVL': '1', 07:24:59 INFO - 'TERM': 'linux', 07:24:59 INFO - 'TMOUT': '86400', 07:24:59 INFO - 'USER': 'cltbld', 07:24:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:59 INFO - '_': '/tools/buildbot/bin/python'} 07:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:24:59 INFO - Running setup.py (path:/tmp/pip-DbVzfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:24:59 INFO - Running setup.py (path:/tmp/pip-Wq2DUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:24:59 INFO - Running setup.py (path:/tmp/pip-EmydCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:24:59 INFO - Running setup.py (path:/tmp/pip-JpNHSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:24:59 INFO - Running setup.py (path:/tmp/pip-Ktagq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:24:59 INFO - Running setup.py (path:/tmp/pip-zfrySe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:24:59 INFO - Running setup.py (path:/tmp/pip-NIA66a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:24:59 INFO - Running setup.py (path:/tmp/pip-aL6RNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:24:59 INFO - Running setup.py (path:/tmp/pip-fPyMuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:24:59 INFO - Running setup.py (path:/tmp/pip-d6Z52g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:00 INFO - Running setup.py (path:/tmp/pip-3vm67u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:00 INFO - Running setup.py (path:/tmp/pip-2IeSMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:00 INFO - Running setup.py (path:/tmp/pip-2aFQfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:00 INFO - Running setup.py (path:/tmp/pip-t93Dh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:00 INFO - Running setup.py (path:/tmp/pip-6tkgCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:00 INFO - Running setup.py (path:/tmp/pip-5UM64z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:00 INFO - Running setup.py (path:/tmp/pip-t_3TgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:00 INFO - Running setup.py install for manifestparser 07:25:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:00 INFO - Running setup.py install for mozcrash 07:25:00 INFO - Running setup.py install for mozdebug 07:25:00 INFO - Running setup.py install for mozdevice 07:25:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:00 INFO - Running setup.py install for mozfile 07:25:01 INFO - Running setup.py install for mozhttpd 07:25:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Running setup.py install for mozinfo 07:25:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Running setup.py install for mozInstall 07:25:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Running setup.py install for mozleak 07:25:01 INFO - Running setup.py install for mozlog 07:25:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Running setup.py install for moznetwork 07:25:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Running setup.py install for mozprocess 07:25:01 INFO - Running setup.py install for mozprofile 07:25:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:01 INFO - Running setup.py install for mozrunner 07:25:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:02 INFO - Running setup.py install for mozscreenshot 07:25:02 INFO - Running setup.py install for moztest 07:25:02 INFO - Running setup.py install for mozversion 07:25:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:02 INFO - Cleaning up... 07:25:02 INFO - Return code: 0 07:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:02 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')]} 07:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:02 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')]} 07:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:02 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 0xc21030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe50400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', '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 07:25:02 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 07:25:02 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 07:25:02 INFO - Using env: {'DISPLAY': ':0', 07:25:02 INFO - 'HOME': '/home/cltbld', 07:25:02 INFO - 'LANG': 'en_US.UTF-8', 07:25:02 INFO - 'LANGUAGE': 'en_US:en', 07:25:02 INFO - 'LOGNAME': 'cltbld', 07:25:02 INFO - 'MAIL': '/var/mail/cltbld', 07:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:02 INFO - 'MOZ_NO_REMOTE': '1', 07:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:02 INFO - 'NO_EM_RESTART': '1', 07:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:02 INFO - 'PWD': '/builds/slave/test', 07:25:02 INFO - 'SHELL': '/bin/bash', 07:25:02 INFO - 'SHLVL': '1', 07:25:02 INFO - 'TERM': 'linux', 07:25:02 INFO - 'TMOUT': '86400', 07:25:02 INFO - 'USER': 'cltbld', 07:25:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:02 INFO - '_': '/tools/buildbot/bin/python'} 07:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:02 INFO - Running setup.py (path:/tmp/pip-BEaPdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:02 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)) 07:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:02 INFO - Running setup.py (path:/tmp/pip-0j1IKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:02 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)) 07:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:02 INFO - Running setup.py (path:/tmp/pip-v5DEuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:02 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)) 07:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:02 INFO - Running setup.py (path:/tmp/pip-7gJkzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:02 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)) 07:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:02 INFO - Running setup.py (path:/tmp/pip-9zBypC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:02 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)) 07:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:02 INFO - Running setup.py (path:/tmp/pip-sKyBfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:03 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:03 INFO - Running setup.py (path:/tmp/pip-WuuHlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:03 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:03 INFO - Running setup.py (path:/tmp/pip-JS7hI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:03 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:03 INFO - Running setup.py (path:/tmp/pip-ltA8DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:03 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:03 INFO - Running setup.py (path:/tmp/pip-nDj4e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:03 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:03 INFO - Running setup.py (path:/tmp/pip-X5tfVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:03 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:03 INFO - Running setup.py (path:/tmp/pip-H4vmOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:03 INFO - Running setup.py (path:/tmp/pip-7Inlsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:03 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:03 INFO - Running setup.py (path:/tmp/pip-lGGurz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:03 INFO - Running setup.py (path:/tmp/pip-dnfzsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:03 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:03 INFO - Running setup.py (path:/tmp/pip-BT4zHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:03 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)) 07:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:03 INFO - Running setup.py (path:/tmp/pip-FuZc05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:03 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)) 07:25:03 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)) 07:25:03 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)) 07:25:03 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)) 07:25:03 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)) 07:25:03 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)) 07:25:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:03 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 07:25:03 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 07:25:03 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 07:25:03 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 07:25:03 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 07:25:03 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 07:25:05 INFO - Downloading blessings-1.6.tar.gz 07:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:05 INFO - Installing collected packages: blessings 07:25:05 INFO - Running setup.py install for blessings 07:25:05 INFO - Successfully installed blessings 07:25:05 INFO - Cleaning up... 07:25:05 INFO - Return code: 0 07:25:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:06 INFO - Reading from file tmpfile_stdout 07:25:06 INFO - Current package versions: 07:25:06 INFO - argparse == 1.2.1 07:25:06 INFO - blessings == 1.6 07:25:06 INFO - blobuploader == 1.2.4 07:25:06 INFO - docopt == 0.6.1 07:25:06 INFO - functools32 == 3.2.3-2 07:25:06 INFO - jsonschema == 2.5.1 07:25:06 INFO - manifestparser == 1.1 07:25:06 INFO - mozInstall == 1.12 07:25:06 INFO - mozcrash == 0.17 07:25:06 INFO - mozdebug == 0.1 07:25:06 INFO - mozdevice == 0.48 07:25:06 INFO - mozfile == 1.2 07:25:06 INFO - mozhttpd == 0.7 07:25:06 INFO - mozinfo == 0.9 07:25:06 INFO - mozleak == 0.1 07:25:06 INFO - mozlog == 3.2 07:25:06 INFO - moznetwork == 0.27 07:25:06 INFO - mozprocess == 0.22 07:25:06 INFO - mozprofile == 0.28 07:25:06 INFO - mozrunner == 6.11 07:25:06 INFO - mozscreenshot == 0.1 07:25:06 INFO - mozsystemmonitor == 0.3 07:25:06 INFO - moztest == 0.7 07:25:06 INFO - mozversion == 1.4 07:25:06 INFO - psutil == 3.1.1 07:25:06 INFO - requests == 1.2.3 07:25:06 INFO - wsgiref == 0.1.2 07:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:06 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 0xc21030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe50400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', '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 07:25:06 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 07:25:06 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 07:25:06 INFO - Using env: {'DISPLAY': ':0', 07:25:06 INFO - 'HOME': '/home/cltbld', 07:25:06 INFO - 'LANG': 'en_US.UTF-8', 07:25:06 INFO - 'LANGUAGE': 'en_US:en', 07:25:06 INFO - 'LOGNAME': 'cltbld', 07:25:06 INFO - 'MAIL': '/var/mail/cltbld', 07:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:06 INFO - 'MOZ_NO_REMOTE': '1', 07:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:06 INFO - 'NO_EM_RESTART': '1', 07:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:06 INFO - 'PWD': '/builds/slave/test', 07:25:06 INFO - 'SHELL': '/bin/bash', 07:25:06 INFO - 'SHLVL': '1', 07:25:06 INFO - 'TERM': 'linux', 07:25:06 INFO - 'TMOUT': '86400', 07:25:06 INFO - 'USER': 'cltbld', 07:25:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:06 INFO - '_': '/tools/buildbot/bin/python'} 07:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:06 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)) 07:25:06 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)) 07:25:06 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)) 07:25:06 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)) 07:25:06 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)) 07:25:06 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)) 07:25:06 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)) 07:25:06 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)) 07:25:06 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)) 07:25:06 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)) 07:25:06 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)) 07:25:06 INFO - Cleaning up... 07:25:06 INFO - Return code: 0 07:25:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc21030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe50400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', '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 07:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:25:06 INFO - Using env: {'DISPLAY': ':0', 07:25:06 INFO - 'HOME': '/home/cltbld', 07:25:06 INFO - 'LANG': 'en_US.UTF-8', 07:25:06 INFO - 'LANGUAGE': 'en_US:en', 07:25:06 INFO - 'LOGNAME': 'cltbld', 07:25:06 INFO - 'MAIL': '/var/mail/cltbld', 07:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:06 INFO - 'MOZ_NO_REMOTE': '1', 07:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:06 INFO - 'NO_EM_RESTART': '1', 07:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:06 INFO - 'PWD': '/builds/slave/test', 07:25:06 INFO - 'SHELL': '/bin/bash', 07:25:06 INFO - 'SHLVL': '1', 07:25:06 INFO - 'TERM': 'linux', 07:25:06 INFO - 'TMOUT': '86400', 07:25:06 INFO - 'USER': 'cltbld', 07:25:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:06 INFO - '_': '/tools/buildbot/bin/python'} 07:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:25:06 INFO - Cleaning up... 07:25:06 INFO - Return code: 0 07:25:06 INFO - Running post-action listener: _resource_record_post_action 07:25:06 INFO - Running post-action listener: _start_resource_monitoring 07:25:06 INFO - Starting resource monitoring. 07:25:06 INFO - ##### 07:25:06 INFO - ##### Finished create-virtualenv step (success) 07:25:06 INFO - ##### 07:25:06 INFO - ##### 07:25:06 INFO - ##### Running install step. 07:25:06 INFO - ##### 07:25:06 INFO - Running pre-action listener: _resource_record_pre_action 07:25:06 INFO - Running main action method: install 07:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:06 INFO - Reading from file tmpfile_stdout 07:25:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:06 INFO - Reading from file tmpfile_stdout 07:25:06 INFO - Output received: 07:25:06 INFO - Usage: mozinstall [options] installer 07:25:06 INFO - Options: 07:25:06 INFO - -h, --help show this help message and exit 07:25:06 INFO - -d DEST, --destination=DEST 07:25:06 INFO - Directory to install application into. [default: 07:25:06 INFO - "/builds/slave/test"] 07:25:06 INFO - --app=APP Application being installed. [default: firefox] 07:25:06 INFO - mkdir: /builds/slave/test/build/application 07:25:06 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'] 07:25:06 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 07:25:24 INFO - Reading from file tmpfile_stdout 07:25:24 INFO - Output received: 07:25:24 INFO - /builds/slave/test/build/application/firefox/firefox 07:25:24 INFO - Running post-action listener: _resource_record_post_action 07:25:24 INFO - ##### 07:25:24 INFO - ##### Finished install step (success) 07:25:24 INFO - ##### 07:25:24 INFO - ##### 07:25:24 INFO - ##### Running run-tests step. 07:25:24 INFO - ##### 07:25:24 INFO - Running pre-action listener: _resource_record_pre_action 07:25:24 INFO - Running main action method: run_tests 07:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:25:24 INFO - Python 2.7.3 07:25:24 INFO - Return code: 0 07:25:24 INFO - grabbing minidump binary from tooltool 07:25: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')]} 07:25:24 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 0xedf570>, '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 0xee0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:25:24 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 07:25:24 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 07:25:24 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 07:25:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:25:24 INFO - Return code: 0 07:25:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:25:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:25:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:25:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:25:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:25:24 INFO - Using env: {'DISPLAY': ':0', 07:25:24 INFO - 'HOME': '/home/cltbld', 07:25:24 INFO - 'LANG': 'en_US.UTF-8', 07:25:24 INFO - 'LANGUAGE': 'en_US:en', 07:25:24 INFO - 'LOGNAME': 'cltbld', 07:25:24 INFO - 'MAIL': '/var/mail/cltbld', 07:25:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:25:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:24 INFO - 'MOZ_NO_REMOTE': '1', 07:25:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:24 INFO - 'NO_EM_RESTART': '1', 07:25:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:24 INFO - 'PWD': '/builds/slave/test', 07:25:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:25:24 INFO - 'SHELL': '/bin/bash', 07:25:24 INFO - 'SHLVL': '1', 07:25:24 INFO - 'TERM': 'linux', 07:25:24 INFO - 'TMOUT': '86400', 07:25:24 INFO - 'USER': 'cltbld', 07:25:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401', 07:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:24 INFO - '_': '/tools/buildbot/bin/python'} 07:25:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:25:24 INFO - mozversion application_buildid: 20160628043018 07:25:24 INFO - mozversion application_changeset: 170e18a9341f79cdebd6cfa5114c1b4a2469c030 07:25:24 INFO - mozversion application_display_name: Nightly 07:25:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:25:24 INFO - mozversion application_name: Firefox 07:25:24 INFO - mozversion application_remotingname: firefox 07:25:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:25:24 INFO - mozversion application_vendor: Mozilla 07:25:24 INFO - mozversion application_version: 50.0a1 07:25:24 INFO - mozversion platform_buildid: 20160628043018 07:25:24 INFO - mozversion platform_changeset: 170e18a9341f79cdebd6cfa5114c1b4a2469c030 07:25:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:25:24 INFO - mozversion platform_version: 50.0a1 07:25:24 INFO - using testdate: 1467123924 07:25:24 INFO - actual date: 1467123924 07:25:24 INFO - starting webserver on 'localhost:55787' 07:25:24 INFO - SUITE-START | Running 2 tests 07:25:24 INFO - TEST-START | dromaeo_css 07:25:24 INFO - operating with platform_type : linux_ 07:25:24 INFO - Initialising browser for dromaeo_css test... 07:25:24 INFO - TEST-INFO | started process 11713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH5Ayww/profile http://localhost:55787/getInfo.html) 07:25:28 INFO - PROCESS | 11713 | __metrics Screen width/height:1600/1200 07:25:28 INFO - PROCESS | 11713 | colorDepth:24 07:25:28 INFO - PROCESS | 11713 | Browser inner width/height: 1024/697 07:25:28 INFO - PROCESS | 11713 | __metrics 07:25:29 ERROR - PROCESS | 11713 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:25:30 INFO - TEST-INFO | 11713: exit 0 07:25:30 INFO - Browser initialized. 07:25:30 INFO - Running cycle 1/1 for dromaeo_css test... 07:25:30 INFO - TEST-INFO | started process 11833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH5Ayww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:42 INFO - PROCESS | 11833 | RSS: Main: 167923712 07:25:42 INFO - PROCESS | 11833 | 07:26:31 INFO - PROCESS | 11833 | 1467123991634 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] 07:28:39 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:55787/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55787/tests/dromaeo/cssquery-ext.html) 07:28:40 INFO - PROCESS | 11833 | RSS: Main: 171253760 07:28:40 INFO - PROCESS | 11833 | 07:31:42 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:55787/tests/dromaeo/cssquery-ext.html (next: http://localhost:55787/tests/dromaeo/cssquery-jquery.html) 07:31:43 INFO - PROCESS | 11833 | RSS: Main: 170840064 07:31:43 INFO - PROCESS | 11833 | 07:34:44 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:55787/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55787/tests/dromaeo/cssquery-mootools.html) 07:34:45 INFO - PROCESS | 11833 | RSS: Main: 172359680 07:34:45 INFO - PROCESS | 11833 | 07:37:47 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:55787/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55787/tests/dromaeo/cssquery-prototype.html) 07:37:47 INFO - PROCESS | 11833 | RSS: Main: 169566208 07:37:47 INFO - PROCESS | 11833 | 07:40:50 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:55787/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55787/tests/dromaeo/cssquery-yui.html) 07:40:50 INFO - PROCESS | 11833 | RSS: Main: 171675648 07:40:50 INFO - PROCESS | 11833 | 07:43:53 INFO - PROCESS | 11833 | Cycle 1(1): loaded http://localhost:55787/tests/dromaeo/cssquery-yui.html (next: http://localhost:55787/tests/dromaeo/cssquery-dojo.html) 07:43:53 INFO - PROCESS | 11833 | RSS: Main: 172728320 07:43:53 INFO - PROCESS | 11833 | 07:43:53 INFO - PROCESS | 11833 | __start_tp_report 07:43:53 INFO - PROCESS | 11833 | _x_x_mozilla_page_load 07:43:53 INFO - PROCESS | 11833 | _x_x_mozilla_page_load_details 07:43:53 INFO - PROCESS | 11833 | |i|pagename|runs| 07:43:53 INFO - PROCESS | 11833 | |0;dojo.html;3056.694330566943;3087.6140482439696;3109.8648993117517;3111.7977331473444;3114.9688503114976;5261.605379596531;5330.413654498002;5344.866378340544;5384.515393614574;5448.45515448455;5261.631685781997;5309.761060752276;5356.705381204032;5391.946080539194;5419.810306639269;4817.590504807095;4884.072026314989;4998.750062496879;5039.19372900336;5062.0888240116765;477.8955511103833;4792.784324705379;4886.36477257956;4918.655694101414;4964.826231081913;4952.133376659071;4983.152864013108;4994.1260279451135;5002.774875130592;5004.474530174334;4994.800207991676;5011.473795251519;5019.347484826985;5019.47295533971;5031.169856973632;4844.5155484451625;4900.289458028566;4903.828366007173;4920.434150072716;4940.629452791055;5319.148936170232;5364.141737322048;5446.074167391514;5457.263269458612;5463.562914966793;5543.916841247385;5665.915011274834;5713.971430142864;5735.885282294373;5736.340320863071;5859.941400585983;5888.499477544371;5914.260717410324;5916.0534314509905;5925.259342582177;5478.233047373371;5486.259354987065;5489.094299440588;5499.010178167928;5531.751071201806;5745.511631511368;5843.415658434123;5981.461668449861;6006.249218847644;6053.545984051126;5648.519875810603;5685.090385538294;5743.908657355089;5767.36558978512;5799.217105690762;5753.194552762617;5754.798582049608;5765.567582431335;5817.214676018768;5839.386864379264;5568.081266590967;5610.158476228598;5620.100783874561;5722.799702010493;5731.455511726379;5648.830535083954;5661.7735290588735;5667.858303542362;5694.430556944355;5712.742926568231;4329.761863097497;4340.283853164256;4366.235908716026;4371.431713877176;4395.846145384896;3894.0264933766557;3896.4155376693725;3916.8433262669746;3944.5069366329208;3955.861544845917;5417.51242388187;5437;5445.537129343971;5451.236826844245;5486.094794358886;5754.683492407874;5798.478136967608;5804.854878628068;5805.82582522525;5822.82531524055;5308.973455132699;5365.356157261075;5384.165454354503;5385.811496597678;5510.641808282448;4964.478729733398;4968.90062198754;5014.89970200594;5056.292119103328;5057;5945.970270148621;6010.699465026732;6028.824379246005;6029.427204415573;6053.939460605426;5622.044252477171;5680.602357834912;5829.15477255804;5834.766609335579;5850;5952.434518720715;6015.789447369321;6025.1564780931585;6046.667433291212;6081.513478921587;5660.716964151694;5668.546516278605;5672.12082127271;5703.800366987136;5713.914291285717;5594.804181853616;5729.770809167753;5810.854728631818;5826.737796799239;5837.09525023622;5542.63972841764;5611.57913156523;5673.461021202979;5689.487946084872;5709.628874123168;5645.266115404971;5682.062459694104;5688.232088667977;5695.515881150149;5702.287214098238;5344.732763361894;5523.696196709219;5567.4432556744005;5598.692071936082;5622.578306626938;5701.515371193329;5753.683547404933;5776.133579963039;5785.82642520725;5810.970945145416;5596.720163991866;5628.240187574789;5635;5639.266895303748;5664 07:43:53 INFO - PROCESS | 11833 | |1;ext.html;546.6610701365154;597.1013624495135;610.2158726037044;610.8869859076074;616.3897741236175;32441.351172976556;35585;42082.158356832886;43004;43580.782096089555;45907;46245.30632040522;46287;46333.76833115838;46416.303755443696;8931.374803763756;9074.047225041375;9074.455532668027;9079.18287354138;9149.176574108362;8852.8672069919;8980.371374003822;8987.146221108984;8993.415427997159;8996.100389960984;8999.145081217273;9002.144796244347;9040.683576074838;9055.773605659846;9091.727248182566;8976.147266009719;9001.369904106716;9014.774630634221;9061.68284110053;9062.909370906305;8879.378443508956;8899.110088991114;8984.236339911115;9004.549772511415;9023.375792357374;42685.35971960423;42764;42937.78531107356;43218.56781432177;43382;3477.6522347765276;3560.9109772255642;3711.832967516468;4122.6083522065355;4217.683673724483;32471.51292730611;32754.508682369782;32790.83604581986;32924;34178.82910585456;4396.472423309191;4399.450068741407;4407.1185762847235;4446.088551846864;4484.125595508877;350040;350316;350986;352240;354178.99999999744;33336.49995250073;60148.39851601428;60403.69798150981;60523.394766052654;60880.69559652262;34521.82739086288;35763.64236357603;35883.64116358855;36059.4591081134;36193;14840.73853722424;15012.399504019717;15088.24558772057;15093.169875656724;15097;11646.650600481998;11923.880761192451;11968.880311196777;11997.940010299893;12004;8010.158933312035;8074.950256466739;8131.674733010732;8140.308073813792;8195.42632015765;3164.639205141765;3195.8561864716144;3217.147455924135;3250.5124231365485;3257.413665540178;1012.8733908261468;1023.6314926626409;1117.1956191542076;1122.2649164796908;1123.634818683931;31976.840115799274;32289.727534269794;32334.676653233637;32435.675643243267;32880.50679239813;1084.7071290751453;1098.3190421938289;1111.6776134920783;1118.6476259978244;1155.7746239483388;16866.32534698623;16985.15074246283;17079.48761537156;17128.65742685164;17314.567135821704;576043;576451;579154;579701;583071;57199;58191.70904145537;58192;58330.708346458;58474.122888156715;1303.2050449225965;1333.2667033131738;1342.4630147940707;1345.3676771917183;1357.2128165663892;30569.54145687861;30963.535546967265;31108;32002.35995280128;32336.191595210308;51269.487305127965;51983.48016519938;52094.47905520896;52183;52247.21629175489;432540;440008;440628;441392;441858;28571.714282856905;28853.56719649165;28886.711132889242;28890.27774305659;28917.56623650605;49028.75485622549;50143.498565013884;50758.49241507686;50770.74614627051;51365.22952155646;42046.78976605098;42790.786046069574;42800.78599606982;42884.78557607317;43385.566144338154;42271.69125497153;42475.3628695576;42667.3599896008;42715;42855;41750.37374439446;42309.788451058776;42715.57284427116;42981.35527967146;43969.865510149866;34850.30299394049;35907.82046089753;36715.63284367122;37114.25771484609;39336.60663393444;28174.66840000196;28667.273254476786;28697.852085917166;29028;29033.85483072571 07:43:53 INFO - PROCESS | 11833 | |2;jquery.html;383.3330005789925;385.41801879162466;390.0677381059268;399.30812947862614;402.1775469165556;17889.731654025185;18881.905590472063;19651.803481965213;19795.90102049491;19812.10845511952;17732.37936672217;18046.368377106803;18185.27258909642;18880;19019.61960760784;5271.103912334903;5326.680399176043;5493.670379777226;5505.119180931052;5700.572457065716;5641.2384328115795;5672.886542269152;5681.119426488901;5684;5736.426357364272;5593.216949627055;5601.80393686219;5639.436056394369;5676.290463692038;5695.03184458643;5703.914441283363;5703.914441283384;5708.372079071299;5708.543316534668;5714.885702285952;5079.161938280179;5124.948750512522;5148.790034341927;5156.097682905476;5162.380514338303;22349.32952011442;22525.887370563207;23288.301350959497;23442.53114937692;23499.7650023501;2013.5469519358173;2131.4884427737234;2359.752226016261;2657.6810782706198;2944.6319210098736;10058.597656093747;10446.843297350546;10625.521851516623;12354.938225308906;14352.851771858226;1833.7432759413693;1886.5566591850904;1890.7069404242363;1894.2044341376654;1899.164367678217;59388;76279.61860190719;77808.61095694541;82266;83872.58063709704;10201.795964080826;10860.945695271632;10915.56337746497;11068.28056176346;11325.433728313552;15162.393504259706;15236.619084522754;15266.389344426321;15306;15348.386064557293;8112.18878112184;8136.7152149674475;8142.063662678749;8143.144969778088;8208.138145494757;7667.769966901002;7675.385969122457;7823.178566250575;7845.058592968766;7926.207379262143;4561.24739417999;4602.723836569817;4710.905781884411;4795.20879054959;4833.371661683958;1914.502229420333;1976.8517361197967;1980.821726044663;1988.5426351939136;1998.920043198285;942.2568248739776;955.0354142316311;960.279790157382;971.3297824501071;1021.4484178543503;19217.32739354116;19560.217591296474;19695.803041969684;19913.900430498044;19916.402507924784;945.5981207986579;976.4043933200742;976.8095221431753;1005.5022763732;1014.0214692821463;10407.843882341771;10742.892571074346;10818.513166907507;10860.13118950482;10958.068564171976;441803;454184;455708;457076;458313;56543.71728141333;83821;88654;88890.55554722185;92682.53658731663;978.9559469823876;1025.179856115105;1029.248648486609;1033.0960409641564;1044.3211912257093;14624.415023398944;16688.749668754735;17706.055425231458;18115.54711132232;18121.36575219861;41621.58378416177;41694;41823.58176418319;42557.78721106375;43223.56776432195;60275.39724602698;61235.38764612475;61862;62112;62678.37321626725;7602.923970760443;7950.125486196398;8320.583970801315;8447.324214062983;8615.052344242004;13317.134386264861;13366.599002029954;13525.391357389139;13595;13890.305484725925;10810.29733067348;11338.886611134112;11410.372429516125;11577.131715121568;12113.09151813635;11478.311301321948;11557.595484158013;11587;11729.882701172879;11760.882716141952;7752.922470775446;12321.507139714311;12377.690557736129;12423.130380873252;12572.371381430708;8779.517126557845;8910.242629376316;8947.328950328621;8983.191512763882;9023.593938272925;8589.398742087993;10849.837252441062;11719.941400292944;12173.39133043362;12257.325847078497 07:43:53 INFO - PROCESS | 11833 | |3;mootools.html;1418.9787153192703;1460.7224627320809;1530.7933428987083;1634.3625985865508;1678.9664206715859;8133.837323253531;8209.835803283931;8788.78028049299;9434.056594340562;9533.523323833806;8673.262772664331;8807.77980550485;8953.507557084358;9055.683051093212;9105.95447022764;2307.6538519222127;2358;2362.917297894574;2376.061455724988;2379.3456799380224;2302.827287953402;2312.5259321838985;2319.7564255753155;2327.104064935004;2329.2546385156757;2296.7932886040253;2298.8735619540917;2303.9308820735405;2325.476767727265;2336.1356298169703;2243.741969673484;2250.9662355064606;2259.8870056497108;2274.442761523437;2284.8400611957168;2226.565819665166;2235.9217427390126;2239.048404428128;2266.3427605994243;2274.2608652188105;9040.728778136667;9091.63633454661;9094.590743416562;9189.851268591427;9195.448273103635;5203.609729270282;5339.199120131972;5384.542313903323;5399.946000539983;5414.485623865727;3140.1364624728153;3165.446046941799;3287.2439338951935;3306.9503957440656;3325.3016866458074;1113.565709373345;1118.6420345489446;1141.1099342512853;1169.9590514331958;1170.8302296167094;12642.74714505714;12841.229526228362;12881.033922455854;12885.549005784846;12938;4672.883177920511;4683.625309975262;4771.093492236464;4771.6898401603785;4880.487548807395;10940.726481837859;11001.449927503592;11030.393328367018;11073.169512286611;11084.16868734832;5319.122344813062;5414.242006119146;5421.701806400607;5433.2936718227165;5450.945490545123;4188.727732697426;4615.746133962664;4705.247160454311;4758.1673207188605;4805.711657300503;3959.4456776051375;3987.4218238355274;4046.676265898721;4086.6117718816663;4112.239235741337;1253.4422182128865;1266.265565971734;1277.9105462617713;1301.3883474766844;1325.3638253638308;961.8941916389192;974.9171320437842;980.5636491761098;1000.0799264676515;1004.6232662751469;6152.538559608047;6272.843178920472;6354.523410744213;6445.484361251089;6447.871042579216;459.3913065188638;459.88732760473897;462.2649986521447;471.8136336147271;479.6905995632797;4201.159768046342;4278.058827058042;4302.591253830881;4320.697551171388;4332.935005974913;11079.556817727362;11492.195546311677;11538.13463990204;11558.364289963965;11571.6528504145;11030.613928512463;11170.497327620114;11411.087113030937;11465.770684586261;11489.310641361379;8460.534670593177;8499.66001359951;8553.144685531397;8652.52411117382;8656.956715216384;6134.325224225242;6253.96809526423;6258.874822503433;6308.243010838729;6347.746090156342;10027.498625068863;10229.74425639365;10237.846432303373;10242.078212960869;10261.17910567138;10296.3822170667;10388.11701005423;10463.11063559606;10515.947420263155;10597.523111460157;7194.6042967635185;7572.091349038151;7813.335866451188;7993.800154996172;8160.224778646019;8510.74467765968;8613.87079193825;8688.91311086881;8713;8743.344249181464;7492.175860655432;7699.807504812425;7711.730089446843;7766.5728384939375;7829.921700782919;7539.736109236151;7692.499962507258;7705.30652241301;7752.573608451589;7771.533707977539;6807.897881531682;6835.69239384219;6935.861282774215;6948.992396102638;6956.373926346653;5018.573421259234;5057;5155.943031678422;5222.216667499905;5245.580353571781;5179.974100129475;5197.194434862602;5217.06092903281;5225.399079105951;5258.395284542326 07:43:53 INFO - PROCESS | 11833 | |4;prototype.html;307.50184700784735;317.29718673139;321.55625237172706;322.4502223708577;325.7914934441956;5259.263703081571;5593.244911936892;5605.887882242358;5617.662940223589;5675.772969081232;5550.306211723535;5556.527695145907;5558.666480011202;5587.189857470665;5593.216949627055;4353.978230108845;4381.145676593065;4395.758233297167;4395.934060989088;4396.318570621543;4388.934165987513;4399.912001759963;4399.988002759367;4428.535003824601;4433.1577000369825;4331.242032644291;4355.978220108895;4378.408914796493;4390.780460976938;4394.4067550880545;4387.539308372607;4418.248897687401;4426.247537918562;4429.424174857248;4442.2892337225885;3560.2167523145126;3799.2211596622624;3900.3759398496386;3915.686745060417;3928.3697265635014;5342.958123165984;5363.54409875161;5377;5402.162664786964;5433.402325744165;4871.756412179412;4876.926846097312;4884.5603895649565;4908.631852611033;4929.8028078876805;5523.2543606613;5807.535397168216;5828.854278643025;5831.766729330821;5836.241288632493;4066.4713587233764;4084.7957602120073;4101.954001729539;4103.302438585448;4140;5915.881682366372;5937.732802023919;6033.577649564532;6060.818175454743;6081.574289799716;4030.4760381150263;4231.534531201565;4232.132412855357;4247.277962746341;4274.380214868826;4292.420523229386;4296.677749168824;4305.84929527465;4311.741295522279;4334;4922.237053256751;4946.9010619787405;4964.875878103004;4973.676711013773;5002.22465517838;5718.428157184248;5841.561882858802;5918.585699001114;5936.910946335808;5953.732082056318;1438.697873446567;1458.6061763323844;1462.6635873749096;1481.733288008169;1483.970320593582;892.4912799704236;921.7004024325669;926.2127191886977;939.8919124300656;940.229012209995;4959.181735013754;5005.299258103868;5046.62150338726;5051.6716413433005;5072.923906141337;5390.571498552887;5393.649412788234;5402.162664786964;5420.4850539198715;5427.402985671573;5005.849824505198;5063.518965698253;5108.3103780989095;5167.483251674803;5709.942900570941;3183.6657150998813;3202.5836641236956;3206.6312374076815;3227.564278822376;3238.2552013037134;6071.787487437919;6247.469370004378;6260.467860231931;6275.301620303222;6280.277768056732;6123.510119190454;6135.478484328882;6140.324564297924;6171.074338849208;6183.876322473526;6231.594946328474;6260.593061450991;6261.812145635729;6283.3088360280335;6286.49708023357;5730.226419433323;5977.491913187428;5986.161937328865;5993.31076926159;6049.153118563317;5958;5971.880562388815;5988.580799344004;6013.218281623361;6025.849353766191;5602.299712535933;6247.625142491465;6247.968760156352;6259.718312676032;6294.4964402846745;4218.240716671029;4232.280512312976;4236.343366778155;4259.531451540266;4295.82109239167;6031.939680603314;6055.848603784941;6056;6083.600771822417;6087.108623403848;5640.379558248507;5771.220885180447;5862.153421672159;5879.529637629065;5919.881602368015;5824.21373114641;5830.18377427169;5843.094320380348;5859.414058594107;5863.882722345615;5590.832275031756;5659.066254068197;5737.684427356536;5758.3090029196765;5831.504322132666;5848.590598658053;5859.619124756877;5902.6458412495385;5910.847384759931;5941.37615550361;5783.6818974955095;5832.358440571449;5832.387599302012;5863.882722345444;5878.911816322673 07:43:53 INFO - PROCESS | 11833 | |5;yui.html;703.2510376449085;753.6269546574447;757.6211894052974;801.3909428834086;825.8224481736428;14431.278436078193;15228.92385538072;15286.694266114671;15355.616109597251;15682.529524114267;15785.973911695732;16581.751273730875;16647;16699.582510437245;16727.749083763752;765.2194761343426;772.0426670928065;781.0549235425142;783.4829012851491;788.3850596534712;777.3625626985873;782.0498094814799;783.6238605469379;787.2127872127872;787.7676085554775;822.1244374740882;823.9052508961456;824.9175082491763;828.2876726015621;829.1542626520945;805.569020573996;807.4468988742701;810.2626609785126;810.3517186251034;814.9918500815005;597.1520440973827;597.6264834478451;599.6432122886876;599.6761748655721;600.1477901380051;15760.92119539395;15878.9206053969;15887.36450541977;15906.204689765465;15950;13805.378757955816;14309.78535321971;14464.783028254584;14628.268586570628;14695.853041469556;11499.19505634606;11921.701957451047;11973.580924667682;12109.93945030278;12138.211016284002;3918.921621567553;3934.7639141651593;3965.8810235692977;3978;4086.652634526069;77941.61029194875;78266.99999999943;79087.20912790856;79379;80171.5991420045;10586.788264234672;10703.678889633167;10784.622538211124;10905.291156074829;11020.669379918616;20527.28154514585;20609.690854637192;20720.171193152408;20746.06642701082;20965.68551471729;8908.376413651113;8911.287097032222;9132.81734365309;9202.723918282329;9442.952785236168;5002.699838009731;5003.759791642814;5020.2720605511995;5096.745162741848;5312;3321.186309354224;3419.7264218862433;3459.7924124552605;3461.100113970386;3467.913302167466;601.509769537834;615.8952977993752;623.1307326279905;624.2166081567694;637.7225906730587;709.1631874388169;719.9676014579356;726.7819654103748;759.5215014540914;771.699037375424;10126.923980583962;10313.329633573943;10466.21503387249;10620.309679870783;10731.517081731341;585.7656937225144;620.683451439769;650.2424675253277;703.0017375326946;747.1258627405948;4631.374764406762;4787.760611969387;4885.071836351153;4911.189653707098;5107.134130834727;120435;123461;125209;126576;127288.36355818162;83569;97991;98362;98490.5075474618;98952.50523747479;57565.712171439714;83850;85427;86727.13272867317;88465;9725.562349694139;9914.504274786375;9958.751031224278;9961.50192490387;9992.550335234786;49546.50453495419;50082.49917500924;50225;51282.48717512777;51392;66398;75345.24654753382;77114.22885771071;78033.21966780486;78356;12880.871191287968;12890.548830790878;13000.609981700563;13020.47918083304;13286.601401957956;14499.130052196902;14650.413983440543;14788.704225915637;14850.108993460426;14851;12879.871201287868;13860.584182474542;14114.788278176042;14171.787423188454;14770.63073423173;12903;13008.544700935801;13189.472421103432;13252.337383130613;13411.061225714497;13968.092074015156;14010.43958241659;14179.432822686977;14448.133112013313;14948.775768363266;11749.706257343292;12024.098192635762;12030.879691202976;12094.274343539415;12187.329696866758;11839.348835814113;12037.75924481523;12045.397730113635;12166.148369614397;12175.56153288825 07:43:53 INFO - PROCESS | 11833 | __end_tp_report 07:43:53 INFO - PROCESS | 11833 | __start_cc_report 07:43:53 INFO - PROCESS | 11833 | _x_x_mozilla_cycle_collect,359 07:43:53 INFO - PROCESS | 11833 | __end_cc_report 07:43:53 INFO - PROCESS | 11833 | __startTimestamp1467125033694__endTimestamp 07:43:53 INFO - PROCESS | 11833 | 07:43:53 INFO - PROCESS | 11833 | ------- Summary: start ------- 07:43:53 INFO - PROCESS | 11833 | Number of tests: 6 07:43:53 INFO - PROCESS | 11833 | 07:43:53 INFO - PROCESS | 11833 | [#0] dojo.html Cycles:165 Average:5344.23 Median:5596.72 stddev:723.34 (12.9%) stddev-sans-first:702.94 07:43:53 INFO - PROCESS | 11833 | Values: 3056.7 3087.6 3109.9 3111.8 3115.0 5261.6 5330.4 5344.9 5384.5 5448.5 5261.6 5309.8 5356.7 5391.9 5419.8 4817.6 4884.1 4998.8 5039.2 5062.1 477.9 4792.8 4886.4 4918.7 4964.8 4952.1 4983.2 4994.1 5002.8 5004.5 4994.8 5011.5 5019.3 5019.5 5031.2 4844.5 4900.3 4903.8 4920.4 4940.6 5319.1 5364.1 5446.1 5457.3 5463.6 5543.9 5665.9 5714.0 5735.9 5736.3 5859.9 5888.5 5914.3 5916.1 5925.3 5478.2 5486.3 5489.1 5499.0 5531.8 5745.5 5843.4 5981.5 6006.2 6053.5 5648.5 5685.1 5743.9 5767.4 5799.2 5753.2 5754.8 5765.6 5817.2 5839.4 5568.1 5610.2 5620.1 5722.8 5731.5 5648.8 5661.8 5667.9 5694.4 5712.7 4329.8 4340.3 4366.2 4371.4 4395.8 3894.0 3896.4 3916.8 3944.5 3955.9 5417.5 5437.0 5445.5 5451.2 5486.1 5754.7 5798.5 5804.9 5805.8 5822.8 5309.0 5365.4 5384.2 5385.8 5510.6 4964.5 4968.9 5014.9 5056.3 5057.0 5946.0 6010.7 6028.8 6029.4 6053.9 5622.0 5680.6 5829.2 5834.8 5850.0 5952.4 6015.8 6025.2 6046.7 6081.5 5660.7 5668.5 5672.1 5703.8 5713.9 5594.8 5729.8 5810.9 5826.7 5837.1 5542.6 5611.6 5673.5 5689.5 5709.6 5645.3 5682.1 5688.2 5695.5 5702.3 5344.7 5523.7 5567.4 5598.7 5622.6 5701.5 5753.7 5776.1 5785.8 5811.0 5596.7 5628.2 5635.0 5639.3 5664.0 07:43:53 INFO - PROCESS | 11833 | 07:43:53 INFO - PROCESS | 11833 | [#1] ext.html Cycles:180 Average:60597.01 Median:42700.18 stddev:124046.97 (290.5%) stddev-sans-first:124313.02 07:43:53 INFO - PROCESS | 11833 | Values: 546.7 597.1 610.2 610.9 616.4 32441.4 35585.0 42082.2 43004.0 43580.8 45907.0 46245.3 46287.0 46333.8 46416.3 8931.4 9074.0 9074.5 9079.2 9149.2 8852.9 8980.4 8987.1 8993.4 8996.1 8999.1 9002.1 9040.7 9055.8 9091.7 8976.1 9001.4 9014.8 9061.7 9062.9 8879.4 8899.1 8984.2 9004.5 9023.4 42685.4 42764.0 42937.8 43218.6 43382.0 3477.7 3560.9 3711.8 4122.6 4217.7 32471.5 32754.5 32790.8 32924.0 34178.8 4396.5 4399.5 4407.1 4446.1 4484.1 350040.0 350316.0 350986.0 352240.0 354179.0 33336.5 60148.4 60403.7 60523.4 60880.7 34521.8 35763.6 35883.6 36059.5 36193.0 14840.7 15012.4 15088.2 15093.2 15097.0 11646.7 11923.9 11968.9 11997.9 12004.0 8010.2 8075.0 8131.7 8140.3 8195.4 3164.6 3195.9 3217.1 3250.5 3257.4 1012.9 1023.6 1117.2 1122.3 1123.6 31976.8 32289.7 32334.7 32435.7 32880.5 1084.7 1098.3 1111.7 1118.6 1155.8 16866.3 16985.2 17079.5 17128.7 17314.6 576043.0 576451.0 579154.0 579701.0 583071.0 57199.0 58191.7 58192.0 58330.7 58474.1 1303.2 1333.3 1342.5 1345.4 1357.2 30569.5 30963.5 31108.0 32002.4 32336.2 51269.5 51983.5 52094.5 52183.0 52247.2 432540.0 440008.0 440628.0 441392.0 441858.0 28571.7 28853.6 28886.7 28890.3 28917.6 49028.8 50143.5 50758.5 50770.7 51365.2 42046.8 42790.8 42800.8 42884.8 43385.6 42271.7 42475.4 42667.4 42715.0 42855.0 41750.4 42309.8 42715.6 42981.4 43969.9 34850.3 35907.8 36715.6 37114.3 39336.6 28174.7 28667.3 28697.9 29028.0 29033.9 07:43:53 INFO - PROCESS | 11833 | 07:43:53 INFO - PROCESS | 11833 | [#2] jquery.html Cycles:180 Average:27646.96 Median:384.38 stddev:74768.97 (19452.1%) stddev-sans-first:74950.69 07:43:53 INFO - PROCESS | 11833 | Values: 383.3 385.4 390.1 399.3 402.2 17889.7 18881.9 19651.8 19795.9 19812.1 17732.4 18046.4 18185.3 18880.0 19019.6 5271.1 5326.7 5493.7 5505.1 5700.6 5641.2 5672.9 5681.1 5684.0 5736.4 5593.2 5601.8 5639.4 5676.3 5695.0 5703.9 5703.9 5708.4 5708.5 5714.9 5079.2 5124.9 5148.8 5156.1 5162.4 22349.3 22525.9 23288.3 23442.5 23499.8 2013.5 2131.5 2359.8 2657.7 2944.6 10058.6 10446.8 10625.5 12354.9 14352.9 1833.7 1886.6 1890.7 1894.2 1899.2 59388.0 76279.6 77808.6 82266.0 83872.6 10201.8 10860.9 10915.6 11068.3 11325.4 15162.4 15236.6 15266.4 15306.0 15348.4 8112.2 8136.7 8142.1 8143.1 8208.1 7667.8 7675.4 7823.2 7845.1 7926.2 4561.2 4602.7 4710.9 4795.2 4833.4 1914.5 1976.9 1980.8 1988.5 1998.9 942.3 955.0 960.3 971.3 1021.4 19217.3 19560.2 19695.8 19913.9 19916.4 945.6 976.4 976.8 1005.5 1014.0 10407.8 10742.9 10818.5 10860.1 10958.1 441803.0 454184.0 455708.0 457076.0 458313.0 56543.7 83821.0 88654.0 88890.6 92682.5 979.0 1025.2 1029.2 1033.1 1044.3 14624.4 16688.7 17706.1 18115.5 18121.4 41621.6 41694.0 41823.6 42557.8 43223.6 60275.4 61235.4 61862.0 62112.0 62678.4 7602.9 7950.1 8320.6 8447.3 8615.1 13317.1 13366.6 13525.4 13595.0 13890.3 10810.3 11338.9 11410.4 11577.1 12113.1 11478.3 11557.6 11587.0 11729.9 11760.9 7752.9 12321.5 12377.7 12423.1 12572.4 8779.5 8910.2 8947.3 8983.2 9023.6 8589.4 10849.8 11719.9 12173.4 12257.3 07:43:53 INFO - PROCESS | 11833 | 07:43:53 INFO - PROCESS | 11833 | [#3] mootools.html Cycles:180 Average:5915.66 Median:2539.01 stddev:3455.18 (136.1%) stddev-sans-first:3448.35 07:43:53 INFO - PROCESS | 11833 | Values: 1419.0 1460.7 1530.8 1634.4 1679.0 8133.8 8209.8 8788.8 9434.1 9533.5 8673.3 8807.8 8953.5 9055.7 9106.0 2307.7 2358.0 2362.9 2376.1 2379.3 2302.8 2312.5 2319.8 2327.1 2329.3 2296.8 2298.9 2303.9 2325.5 2336.1 2243.7 2251.0 2259.9 2274.4 2284.8 2226.6 2235.9 2239.0 2266.3 2274.3 9040.7 9091.6 9094.6 9189.9 9195.4 5203.6 5339.2 5384.5 5399.9 5414.5 3140.1 3165.4 3287.2 3307.0 3325.3 1113.6 1118.6 1141.1 1170.0 1170.8 12642.7 12841.2 12881.0 12885.5 12938.0 4672.9 4683.6 4771.1 4771.7 4880.5 10940.7 11001.4 11030.4 11073.2 11084.2 5319.1 5414.2 5421.7 5433.3 5450.9 4188.7 4615.7 4705.2 4758.2 4805.7 3959.4 3987.4 4046.7 4086.6 4112.2 1253.4 1266.3 1277.9 1301.4 1325.4 961.9 974.9 980.6 1000.1 1004.6 6152.5 6272.8 6354.5 6445.5 6447.9 459.4 459.9 462.3 471.8 479.7 4201.2 4278.1 4302.6 4320.7 4332.9 11079.6 11492.2 11538.1 11558.4 11571.7 11030.6 11170.5 11411.1 11465.8 11489.3 8460.5 8499.7 8553.1 8652.5 8657.0 6134.3 6254.0 6258.9 6308.2 6347.7 10027.5 10229.7 10237.8 10242.1 10261.2 10296.4 10388.1 10463.1 10515.9 10597.5 7194.6 7572.1 7813.3 7993.8 8160.2 8510.7 8613.9 8688.9 8713.0 8743.3 7492.2 7699.8 7711.7 7766.6 7829.9 7539.7 7692.5 7705.3 7752.6 7771.5 6807.9 6835.7 6935.9 6949.0 6956.4 5018.6 5057.0 5155.9 5222.2 5245.6 5180.0 5197.2 5217.1 5225.4 5258.4 07:43:53 INFO - PROCESS | 11833 | 07:43:53 INFO - PROCESS | 11833 | [#4] prototype.html Cycles:180 Average:4880.98 Median:5536.78 stddev:1445.19 (26.1%) stddev-sans-first:1407.89 07:43:53 INFO - PROCESS | 11833 | Values: 307.5 317.3 321.6 322.5 325.8 5259.3 5593.2 5605.9 5617.7 5675.8 5550.3 5556.5 5558.7 5587.2 5593.2 4354.0 4381.1 4395.8 4395.9 4396.3 4388.9 4399.9 4400.0 4428.5 4433.2 4331.2 4356.0 4378.4 4390.8 4394.4 4387.5 4418.2 4426.2 4429.4 4442.3 3560.2 3799.2 3900.4 3915.7 3928.4 5343.0 5363.5 5377.0 5402.2 5433.4 4871.8 4876.9 4884.6 4908.6 4929.8 5523.3 5807.5 5828.9 5831.8 5836.2 4066.5 4084.8 4102.0 4103.3 4140.0 5915.9 5937.7 6033.6 6060.8 6081.6 4030.5 4231.5 4232.1 4247.3 4274.4 4292.4 4296.7 4305.8 4311.7 4334.0 4922.2 4946.9 4964.9 4973.7 5002.2 5718.4 5841.6 5918.6 5936.9 5953.7 1438.7 1458.6 1462.7 1481.7 1484.0 892.5 921.7 926.2 939.9 940.2 4959.2 5005.3 5046.6 5051.7 5072.9 5390.6 5393.6 5402.2 5420.5 5427.4 5005.8 5063.5 5108.3 5167.5 5709.9 3183.7 3202.6 3206.6 3227.6 3238.3 6071.8 6247.5 6260.5 6275.3 6280.3 6123.5 6135.5 6140.3 6171.1 6183.9 6231.6 6260.6 6261.8 6283.3 6286.5 5730.2 5977.5 5986.2 5993.3 6049.2 5958.0 5971.9 5988.6 6013.2 6025.8 5602.3 6247.6 6248.0 6259.7 6294.5 4218.2 4232.3 4236.3 4259.5 4295.8 6031.9 6055.8 6056.0 6083.6 6087.1 5640.4 5771.2 5862.2 5879.5 5919.9 5824.2 5830.2 5843.1 5859.4 5863.9 5590.8 5659.1 5737.7 5758.3 5831.5 5848.6 5859.6 5902.6 5910.8 5941.4 5783.7 5832.4 5832.4 5863.9 5878.9 07:43:53 INFO - PROCESS | 11833 | 07:43:53 INFO - PROCESS | 11833 | [#5] yui.html Cycles:180 Average:21028.90 Median:4709.57 stddev:30393.65 (645.4%) stddev-sans-first:30440.59 07:43:53 INFO - PROCESS | 11833 | Values: 703.3 753.6 757.6 801.4 825.8 14431.3 15228.9 15286.7 15355.6 15682.5 15786.0 16581.8 16647.0 16699.6 16727.7 765.2 772.0 781.1 783.5 788.4 777.4 782.0 783.6 787.2 787.8 822.1 823.9 824.9 828.3 829.2 805.6 807.4 810.3 810.4 815.0 597.2 597.6 599.6 599.7 600.1 15760.9 15878.9 15887.4 15906.2 15950.0 13805.4 14309.8 14464.8 14628.3 14695.9 11499.2 11921.7 11973.6 12109.9 12138.2 3918.9 3934.8 3965.9 3978.0 4086.7 77941.6 78267.0 79087.2 79379.0 80171.6 10586.8 10703.7 10784.6 10905.3 11020.7 20527.3 20609.7 20720.2 20746.1 20965.7 8908.4 8911.3 9132.8 9202.7 9443.0 5002.7 5003.8 5020.3 5096.7 5312.0 3321.2 3419.7 3459.8 3461.1 3467.9 601.5 615.9 623.1 624.2 637.7 709.2 720.0 726.8 759.5 771.7 10126.9 10313.3 10466.2 10620.3 10731.5 585.8 620.7 650.2 703.0 747.1 4631.4 4787.8 4885.1 4911.2 5107.1 120435.0 123461.0 125209.0 126576.0 127288.4 83569.0 97991.0 98362.0 98490.5 98952.5 57565.7 83850.0 85427.0 86727.1 88465.0 9725.6 9914.5 9958.8 9961.5 9992.6 49546.5 50082.5 50225.0 51282.5 51392.0 66398.0 75345.2 77114.2 78033.2 78356.0 12880.9 12890.5 13000.6 13020.5 13286.6 14499.1 14650.4 14788.7 14850.1 14851.0 12879.9 13860.6 14114.8 14171.8 14770.6 12903.0 13008.5 13189.5 13252.3 13411.1 13968.1 14010.4 14179.4 14448.1 14948.8 11749.7 12024.1 12030.9 12094.3 12187.3 11839.3 12037.8 12045.4 12166.1 12175.6 07:43:53 INFO - PROCESS | 11833 | -------- Summary: end -------- 07:43:53 INFO - PROCESS | 11833 | 07:43:54 INFO - TEST-INFO | 11833: exit 0 07:43:54 INFO - TEST-OK | dromaeo_css | took 1110050ms 07:43:54 INFO - TEST-START | kraken 07:43:54 INFO - operating with platform_type : linux_ 07:43:54 INFO - Initialising browser for kraken test... 07:43:54 INFO - TEST-INFO | started process 12073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNAHBE1/profile http://localhost:55787/getInfo.html) 07:43:58 INFO - PROCESS | 12073 | __metrics Screen width/height:1600/1200 07:43:58 INFO - PROCESS | 12073 | colorDepth:24 07:43:58 INFO - PROCESS | 12073 | Browser inner width/height: 1024/697 07:43:58 INFO - PROCESS | 12073 | __metrics 07:43:59 ERROR - PROCESS | 12073 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:44:00 INFO - TEST-INFO | 12073: exit 0 07:44:00 INFO - Browser initialized. 07:44:00 INFO - Running cycle 1/1 for kraken test... 07:44:00 INFO - TEST-INFO | started process 12194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNAHBE1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:11 INFO - PROCESS | 12194 | RSS: Main: 168091648 07:44:11 INFO - PROCESS | 12194 | 07:44:14 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55787/tests/kraken/driver.html?testName=audio-beat-detection) 07:44:15 INFO - PROCESS | 12194 | RSS: Main: 173895680 07:44:15 INFO - PROCESS | 12194 | 07:44:17 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55787/tests/kraken/driver.html?testName=audio-dft) 07:44:18 INFO - PROCESS | 12194 | RSS: Main: 173240320 07:44:18 INFO - PROCESS | 12194 | 07:44:21 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55787/tests/kraken/driver.html?testName=audio-fft) 07:44:22 INFO - PROCESS | 12194 | RSS: Main: 167485440 07:44:22 INFO - PROCESS | 12194 | 07:44:24 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55787/tests/kraken/driver.html?testName=audio-oscillator) 07:44:24 INFO - PROCESS | 12194 | RSS: Main: 168562688 07:44:24 INFO - PROCESS | 12194 | 07:44:27 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55787/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:44:27 INFO - PROCESS | 12194 | RSS: Main: 169111552 07:44:27 INFO - PROCESS | 12194 | 07:44:30 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55787/tests/kraken/driver.html?testName=imaging-darkroom) 07:44:31 INFO - PROCESS | 12194 | RSS: Main: 168677376 07:44:31 INFO - PROCESS | 12194 | 07:44:34 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55787/tests/kraken/driver.html?testName=imaging-desaturate) 07:44:35 INFO - PROCESS | 12194 | RSS: Main: 166920192 07:44:35 INFO - PROCESS | 12194 | 07:44:38 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55787/tests/kraken/driver.html?testName=json-parse-financial) 07:44:38 INFO - PROCESS | 12194 | RSS: Main: 168312832 07:44:38 INFO - PROCESS | 12194 | 07:44:40 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55787/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:44:41 INFO - PROCESS | 12194 | RSS: Main: 168488960 07:44:41 INFO - PROCESS | 12194 | 07:44:42 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55787/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:44:43 INFO - PROCESS | 12194 | RSS: Main: 169242624 07:44:43 INFO - PROCESS | 12194 | 07:44:45 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55787/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:44:46 INFO - PROCESS | 12194 | RSS: Main: 169160704 07:44:46 INFO - PROCESS | 12194 | 07:44:48 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:44:49 INFO - PROCESS | 12194 | RSS: Main: 169934848 07:44:49 INFO - PROCESS | 12194 | 07:44:52 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:44:52 INFO - PROCESS | 12194 | RSS: Main: 169549824 07:44:52 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | Cycle 1(1): loaded http://localhost:55787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55787/tests/kraken/driver.html?testName=ai-astar) 07:44:54 INFO - PROCESS | 12194 | RSS: Main: 170143744 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | __start_tp_report 07:44:54 INFO - PROCESS | 12194 | _x_x_mozilla_page_load 07:44:54 INFO - PROCESS | 12194 | _x_x_mozilla_page_load_details 07:44:54 INFO - PROCESS | 12194 | |i|pagename|runs| 07:44:54 INFO - PROCESS | 12194 | |0;ai-astar;104;112;105;111;112;114;113;111;111;111 07:44:54 INFO - PROCESS | 12194 | |1;audio-beat-detection;165;132;154;180;125;152;151;128;183;126 07:44:54 INFO - PROCESS | 12194 | |2;audio-dft;162;164;167;164;164;166;169;164;162;163 07:44:54 INFO - PROCESS | 12194 | |3;audio-fft;74;75;75;164;75;75;77;75;166;78 07:44:54 INFO - PROCESS | 12194 | |4;audio-oscillator;86;87;147;85;86;86;143;86;86;137 07:44:54 INFO - PROCESS | 12194 | |5;imaging-gaussian-blur;117;118;118;118;118;119;117;118;118;118 07:44:54 INFO - PROCESS | 12194 | |6;imaging-darkroom;147;149;146;147;147;148;147;148;147;148 07:44:54 INFO - PROCESS | 12194 | |7;imaging-desaturate;95;98;96;96;96;95;96;96;96;96 07:44:54 INFO - PROCESS | 12194 | |8;json-parse-financial;55;55;53;58;54;55;55;55;55;54 07:44:54 INFO - PROCESS | 12194 | |9;json-stringify-tinderbox;64;64;64;64;65;66;65;64;64;65 07:44:54 INFO - PROCESS | 12194 | |10;stanford-crypto-aes;82;78;81;79;91;82;80;81;93;80 07:44:54 INFO - PROCESS | 12194 | |11;stanford-crypto-ccm;126;131;133;127;126;145;133;137;124;122 07:44:54 INFO - PROCESS | 12194 | |12;stanford-crypto-pbkdf2;165;161;161;161;170;171;161;156;163;158 07:44:54 INFO - PROCESS | 12194 | |13;stanford-crypto-sha256-iterative;66;64;65;71;64;64;63;62;63;61 07:44:54 INFO - PROCESS | 12194 | __end_tp_report 07:44:54 INFO - PROCESS | 12194 | __start_cc_report 07:44:54 INFO - PROCESS | 12194 | _x_x_mozilla_cycle_collect,864 07:44:54 INFO - PROCESS | 12194 | __end_cc_report 07:44:54 INFO - PROCESS | 12194 | __startTimestamp1467125094852__endTimestamp 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | ------- Summary: start ------- 07:44:54 INFO - PROCESS | 12194 | Number of tests: 14 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.27 (2.9%) stddev-sans-first:2.52 07:44:54 INFO - PROCESS | 12194 | Values: 104.0 112.0 105.0 111.0 112.0 114.0 113.0 111.0 111.0 111.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:153.00 stddev:21.71 (14.2%) stddev-sans-first:22.30 07:44:54 INFO - PROCESS | 12194 | Values: 165.0 132.0 154.0 180.0 125.0 152.0 151.0 128.0 183.0 126.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.22 (1.4%) stddev-sans-first:2.17 07:44:54 INFO - PROCESS | 12194 | Values: 162.0 164.0 167.0 164.0 164.0 166.0 169.0 164.0 162.0 163.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:37.76 (50.3%) stddev-sans-first:39.39 07:44:54 INFO - PROCESS | 12194 | Values: 74.0 75.0 75.0 164.0 75.0 75.0 77.0 75.0 166.0 78.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:86.00 stddev:27.32 (31.8%) stddev-sans-first:28.28 07:44:54 INFO - PROCESS | 12194 | Values: 86.0 87.0 147.0 85.0 86.0 86.0 143.0 86.0 86.0 137.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 07:44:54 INFO - PROCESS | 12194 | Values: 117.0 118.0 118.0 118.0 118.0 119.0 117.0 118.0 118.0 118.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 07:44:54 INFO - PROCESS | 12194 | Values: 147.0 149.0 146.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 07:44:54 INFO - PROCESS | 12194 | Values: 95.0 98.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.29 (2.3%) stddev-sans-first:1.36 07:44:54 INFO - PROCESS | 12194 | Values: 55.0 55.0 53.0 58.0 54.0 55.0 55.0 55.0 55.0 54.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 07:44:54 INFO - PROCESS | 12194 | Values: 64.0 64.0 64.0 64.0 65.0 66.0 65.0 64.0 64.0 65.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:81.50 stddev:5.08 (6.2%) stddev-sans-first:5.38 07:44:54 INFO - PROCESS | 12194 | Values: 82.0 78.0 81.0 79.0 91.0 82.0 80.0 81.0 93.0 80.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:132.00 stddev:6.93 (5.3%) stddev-sans-first:7.17 07:44:54 INFO - PROCESS | 12194 | Values: 126.0 131.0 133.0 127.0 126.0 145.0 133.0 137.0 124.0 122.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:162.00 stddev:4.79 (3.0%) stddev-sans-first:5.00 07:44:54 INFO - PROCESS | 12194 | Values: 165.0 161.0 161.0 161.0 170.0 171.0 161.0 156.0 163.0 158.0 07:44:54 INFO - PROCESS | 12194 | 07:44:54 INFO - PROCESS | 12194 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:2.75 (4.3%) stddev-sans-first:2.85 07:44:54 INFO - PROCESS | 12194 | Values: 66.0 64.0 65.0 71.0 64.0 64.0 63.0 62.0 63.0 61.0 07:44:54 INFO - PROCESS | 12194 | -------- Summary: end -------- 07:44:54 INFO - PROCESS | 12194 | 07:44:55 INFO - TEST-INFO | 12194: exit 0 07:44:55 INFO - TEST-OK | kraken | took 61377ms 07:44:55 INFO - SUITE-END | took 1171s 07:44:56 INFO - Completed test suite (00:19:31) 07:44:56 INFO - javascript benchmark 07:44:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7233.333750576018, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.694330566943, 3087.6140482439696, 3109.8648993117517, 3111.7977331473444, 3114.9688503114976, 5261.605379596531, 5330.413654498002, 5344.866378340544, 5384.515393614574, 5448.45515448455, 5261.631685781997, 5309.761060752276, 5356.705381204032, 5391.946080539194, 5419.810306639269, 4817.590504807095, 4884.072026314989, 4998.750062496879, 5039.19372900336, 5062.0888240116765, 477.8955511103833, 4792.784324705379, 4886.36477257956, 4918.655694101414, 4964.826231081913, 4952.133376659071, 4983.152864013108, 4994.1260279451135, 5002.774875130592, 5004.474530174334, 4994.800207991676, 5011.473795251519, 5019.347484826985, 5019.47295533971, 5031.169856973632, 4844.5155484451625, 4900.289458028566, 4903.828366007173, 4920.434150072716, 4940.629452791055, 5319.148936170232, 5364.141737322048, 5446.074167391514, 5457.263269458612, 5463.562914966793, 5543.916841247385, 5665.915011274834, 5713.971430142864, 5735.885282294373, 5736.340320863071, 5859.941400585983, 5888.499477544371, 5914.260717410324, 5916.0534314509905, 5925.259342582177, 5478.233047373371, 5486.259354987065, 5489.094299440588, 5499.010178167928, 5531.751071201806, 5745.511631511368, 5843.415658434123, 5981.461668449861, 6006.249218847644, 6053.545984051126, 5648.519875810603, 5685.090385538294, 5743.908657355089, 5767.36558978512, 5799.217105690762, 5753.194552762617, 5754.798582049608, 5765.567582431335, 5817.214676018768, 5839.386864379264, 5568.081266590967, 5610.158476228598, 5620.100783874561, 5722.799702010493, 5731.455511726379, 5648.830535083954, 5661.7735290588735, 5667.858303542362, 5694.430556944355, 5712.742926568231, 4329.761863097497, 4340.283853164256, 4366.235908716026, 4371.431713877176, 4395.846145384896, 3894.0264933766557, 3896.4155376693725, 3916.8433262669746, 3944.5069366329208, 3955.861544845917, 5417.51242388187, 5437.0, 5445.537129343971, 5451.236826844245, 5486.094794358886, 5754.683492407874, 5798.478136967608, 5804.854878628068, 5805.82582522525, 5822.82531524055, 5308.973455132699, 5365.356157261075, 5384.165454354503, 5385.811496597678, 5510.641808282448, 4964.478729733398, 4968.90062198754, 5014.89970200594, 5056.292119103328, 5057.0, 5945.970270148621, 6010.699465026732, 6028.824379246005, 6029.427204415573, 6053.939460605426, 5622.044252477171, 5680.602357834912, 5829.15477255804, 5834.766609335579, 5850.0, 5952.434518720715, 6015.789447369321, 6025.1564780931585, 6046.667433291212, 6081.513478921587, 5660.716964151694, 5668.546516278605, 5672.12082127271, 5703.800366987136, 5713.914291285717, 5594.804181853616, 5729.770809167753, 5810.854728631818, 5826.737796799239, 5837.09525023622, 5542.63972841764, 5611.57913156523, 5673.461021202979, 5689.487946084872, 5709.628874123168, 5645.266115404971, 5682.062459694104, 5688.232088667977, 5695.515881150149, 5702.287214098238, 5344.732763361894, 5523.696196709219, 5567.4432556744005, 5598.692071936082, 5622.578306626938, 5701.515371193329, 5753.683547404933, 5776.133579963039, 5785.82642520725, 5810.970945145416, 5596.720163991866, 5628.240187574789, 5635.0, 5639.266895303748, 5664.0], "value": 5296.710510811372, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.6610701365154, 597.1013624495135, 610.2158726037044, 610.8869859076074, 616.3897741236175, 32441.351172976556, 35585.0, 42082.158356832886, 43004.0, 43580.782096089555, 45907.0, 46245.30632040522, 46287.0, 46333.76833115838, 46416.303755443696, 8931.374803763756, 9074.047225041375, 9074.455532668027, 9079.18287354138, 9149.176574108362, 8852.8672069919, 8980.371374003822, 8987.146221108984, 8993.415427997159, 8996.100389960984, 8999.145081217273, 9002.144796244347, 9040.683576074838, 9055.773605659846, 9091.727248182566, 8976.147266009719, 9001.369904106716, 9014.774630634221, 9061.68284110053, 9062.909370906305, 8879.378443508956, 8899.110088991114, 8984.236339911115, 9004.549772511415, 9023.375792357374, 42685.35971960423, 42764.0, 42937.78531107356, 43218.56781432177, 43382.0, 3477.6522347765276, 3560.9109772255642, 3711.832967516468, 4122.6083522065355, 4217.683673724483, 32471.51292730611, 32754.508682369782, 32790.83604581986, 32924.0, 34178.82910585456, 4396.472423309191, 4399.450068741407, 4407.1185762847235, 4446.088551846864, 4484.125595508877, 350040.0, 350316.0, 350986.0, 352240.0, 354178.99999999744, 33336.49995250073, 60148.39851601428, 60403.69798150981, 60523.394766052654, 60880.69559652262, 34521.82739086288, 35763.64236357603, 35883.64116358855, 36059.4591081134, 36193.0, 14840.73853722424, 15012.399504019717, 15088.24558772057, 15093.169875656724, 15097.0, 11646.650600481998, 11923.880761192451, 11968.880311196777, 11997.940010299893, 12004.0, 8010.158933312035, 8074.950256466739, 8131.674733010732, 8140.308073813792, 8195.42632015765, 3164.639205141765, 3195.8561864716144, 3217.147455924135, 3250.5124231365485, 3257.413665540178, 1012.8733908261468, 1023.6314926626409, 1117.1956191542076, 1122.2649164796908, 1123.634818683931, 31976.840115799274, 32289.727534269794, 32334.676653233637, 32435.675643243267, 32880.50679239813, 1084.7071290751453, 1098.3190421938289, 1111.6776134920783, 1118.6476259978244, 1155.7746239483388, 16866.32534698623, 16985.15074246283, 17079.48761537156, 17128.65742685164, 17314.567135821704, 576043.0, 576451.0, 579154.0, 579701.0, 583071.0, 57199.0, 58191.70904145537, 58192.0, 58330.708346458, 58474.122888156715, 1303.2050449225965, 1333.2667033131738, 1342.4630147940707, 1345.3676771917183, 1357.2128165663892, 30569.54145687861, 30963.535546967265, 31108.0, 32002.35995280128, 32336.191595210308, 51269.487305127965, 51983.48016519938, 52094.47905520896, 52183.0, 52247.21629175489, 432540.0, 440008.0, 440628.0, 441392.0, 441858.0, 28571.714282856905, 28853.56719649165, 28886.711132889242, 28890.27774305659, 28917.56623650605, 49028.75485622549, 50143.498565013884, 50758.49241507686, 50770.74614627051, 51365.22952155646, 42046.78976605098, 42790.786046069574, 42800.78599606982, 42884.78557607317, 43385.566144338154, 42271.69125497153, 42475.3628695576, 42667.3599896008, 42715.0, 42855.0, 41750.37374439446, 42309.788451058776, 42715.57284427116, 42981.35527967146, 43969.865510149866, 34850.30299394049, 35907.82046089753, 36715.63284367122, 37114.25771484609, 39336.60663393444, 28174.66840000196, 28667.273254476786, 28697.852085917166, 29028.0, 29033.85483072571], "value": 19088.146583075653, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.3330005789925, 385.41801879162466, 390.0677381059268, 399.30812947862614, 402.1775469165556, 17889.731654025185, 18881.905590472063, 19651.803481965213, 19795.90102049491, 19812.10845511952, 17732.37936672217, 18046.368377106803, 18185.27258909642, 18880.0, 19019.61960760784, 5271.103912334903, 5326.680399176043, 5493.670379777226, 5505.119180931052, 5700.572457065716, 5641.2384328115795, 5672.886542269152, 5681.119426488901, 5684.0, 5736.426357364272, 5593.216949627055, 5601.80393686219, 5639.436056394369, 5676.290463692038, 5695.03184458643, 5703.914441283363, 5703.914441283384, 5708.372079071299, 5708.543316534668, 5714.885702285952, 5079.161938280179, 5124.948750512522, 5148.790034341927, 5156.097682905476, 5162.380514338303, 22349.32952011442, 22525.887370563207, 23288.301350959497, 23442.53114937692, 23499.7650023501, 2013.5469519358173, 2131.4884427737234, 2359.752226016261, 2657.6810782706198, 2944.6319210098736, 10058.597656093747, 10446.843297350546, 10625.521851516623, 12354.938225308906, 14352.851771858226, 1833.7432759413693, 1886.5566591850904, 1890.7069404242363, 1894.2044341376654, 1899.164367678217, 59388.0, 76279.61860190719, 77808.61095694541, 82266.0, 83872.58063709704, 10201.795964080826, 10860.945695271632, 10915.56337746497, 11068.28056176346, 11325.433728313552, 15162.393504259706, 15236.619084522754, 15266.389344426321, 15306.0, 15348.386064557293, 8112.18878112184, 8136.7152149674475, 8142.063662678749, 8143.144969778088, 8208.138145494757, 7667.769966901002, 7675.385969122457, 7823.178566250575, 7845.058592968766, 7926.207379262143, 4561.24739417999, 4602.723836569817, 4710.905781884411, 4795.20879054959, 4833.371661683958, 1914.502229420333, 1976.8517361197967, 1980.821726044663, 1988.5426351939136, 1998.920043198285, 942.2568248739776, 955.0354142316311, 960.279790157382, 971.3297824501071, 1021.4484178543503, 19217.32739354116, 19560.217591296474, 19695.803041969684, 19913.900430498044, 19916.402507924784, 945.5981207986579, 976.4043933200742, 976.8095221431753, 1005.5022763732, 1014.0214692821463, 10407.843882341771, 10742.892571074346, 10818.513166907507, 10860.13118950482, 10958.068564171976, 441803.0, 454184.0, 455708.0, 457076.0, 458313.0, 56543.71728141333, 83821.0, 88654.0, 88890.55554722185, 92682.53658731663, 978.9559469823876, 1025.179856115105, 1029.248648486609, 1033.0960409641564, 1044.3211912257093, 14624.415023398944, 16688.749668754735, 17706.055425231458, 18115.54711132232, 18121.36575219861, 41621.58378416177, 41694.0, 41823.58176418319, 42557.78721106375, 43223.56776432195, 60275.39724602698, 61235.38764612475, 61862.0, 62112.0, 62678.37321626725, 7602.923970760443, 7950.125486196398, 8320.583970801315, 8447.324214062983, 8615.052344242004, 13317.134386264861, 13366.599002029954, 13525.391357389139, 13595.0, 13890.305484725925, 10810.29733067348, 11338.886611134112, 11410.372429516125, 11577.131715121568, 12113.09151813635, 11478.311301321948, 11557.595484158013, 11587.0, 11729.882701172879, 11760.882716141952, 7752.922470775446, 12321.507139714311, 12377.690557736129, 12423.130380873252, 12572.371381430708, 8779.517126557845, 8910.242629376316, 8947.328950328621, 8983.191512763882, 9023.593938272925, 8589.398742087993, 10849.837252441062, 11719.941400292944, 12173.39133043362, 12257.325847078497], "value": 9123.259099723566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.9787153192703, 1460.7224627320809, 1530.7933428987083, 1634.3625985865508, 1678.9664206715859, 8133.837323253531, 8209.835803283931, 8788.78028049299, 9434.056594340562, 9533.523323833806, 8673.262772664331, 8807.77980550485, 8953.507557084358, 9055.683051093212, 9105.95447022764, 2307.6538519222127, 2358.0, 2362.917297894574, 2376.061455724988, 2379.3456799380224, 2302.827287953402, 2312.5259321838985, 2319.7564255753155, 2327.104064935004, 2329.2546385156757, 2296.7932886040253, 2298.8735619540917, 2303.9308820735405, 2325.476767727265, 2336.1356298169703, 2243.741969673484, 2250.9662355064606, 2259.8870056497108, 2274.442761523437, 2284.8400611957168, 2226.565819665166, 2235.9217427390126, 2239.048404428128, 2266.3427605994243, 2274.2608652188105, 9040.728778136667, 9091.63633454661, 9094.590743416562, 9189.851268591427, 9195.448273103635, 5203.609729270282, 5339.199120131972, 5384.542313903323, 5399.946000539983, 5414.485623865727, 3140.1364624728153, 3165.446046941799, 3287.2439338951935, 3306.9503957440656, 3325.3016866458074, 1113.565709373345, 1118.6420345489446, 1141.1099342512853, 1169.9590514331958, 1170.8302296167094, 12642.74714505714, 12841.229526228362, 12881.033922455854, 12885.549005784846, 12938.0, 4672.883177920511, 4683.625309975262, 4771.093492236464, 4771.6898401603785, 4880.487548807395, 10940.726481837859, 11001.449927503592, 11030.393328367018, 11073.169512286611, 11084.16868734832, 5319.122344813062, 5414.242006119146, 5421.701806400607, 5433.2936718227165, 5450.945490545123, 4188.727732697426, 4615.746133962664, 4705.247160454311, 4758.1673207188605, 4805.711657300503, 3959.4456776051375, 3987.4218238355274, 4046.676265898721, 4086.6117718816663, 4112.239235741337, 1253.4422182128865, 1266.265565971734, 1277.9105462617713, 1301.3883474766844, 1325.3638253638308, 961.8941916389192, 974.9171320437842, 980.5636491761098, 1000.0799264676515, 1004.6232662751469, 6152.538559608047, 6272.843178920472, 6354.523410744213, 6445.484361251089, 6447.871042579216, 459.3913065188638, 459.88732760473897, 462.2649986521447, 471.8136336147271, 479.6905995632797, 4201.159768046342, 4278.058827058042, 4302.591253830881, 4320.697551171388, 4332.935005974913, 11079.556817727362, 11492.195546311677, 11538.13463990204, 11558.364289963965, 11571.6528504145, 11030.613928512463, 11170.497327620114, 11411.087113030937, 11465.770684586261, 11489.310641361379, 8460.534670593177, 8499.66001359951, 8553.144685531397, 8652.52411117382, 8656.956715216384, 6134.325224225242, 6253.96809526423, 6258.874822503433, 6308.243010838729, 6347.746090156342, 10027.498625068863, 10229.74425639365, 10237.846432303373, 10242.078212960869, 10261.17910567138, 10296.3822170667, 10388.11701005423, 10463.11063559606, 10515.947420263155, 10597.523111460157, 7194.6042967635185, 7572.091349038151, 7813.335866451188, 7993.800154996172, 8160.224778646019, 8510.74467765968, 8613.87079193825, 8688.91311086881, 8713.0, 8743.344249181464, 7492.175860655432, 7699.807504812425, 7711.730089446843, 7766.5728384939375, 7829.921700782919, 7539.736109236151, 7692.499962507258, 7705.30652241301, 7752.573608451589, 7771.533707977539, 6807.897881531682, 6835.69239384219, 6935.861282774215, 6948.992396102638, 6956.373926346653, 5018.573421259234, 5057.0, 5155.943031678422, 5222.216667499905, 5245.580353571781, 5179.974100129475, 5197.194434862602, 5217.06092903281, 5225.399079105951, 5258.395284542326], "value": 4618.939444624967, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.50184700784735, 317.29718673139, 321.55625237172706, 322.4502223708577, 325.7914934441956, 5259.263703081571, 5593.244911936892, 5605.887882242358, 5617.662940223589, 5675.772969081232, 5550.306211723535, 5556.527695145907, 5558.666480011202, 5587.189857470665, 5593.216949627055, 4353.978230108845, 4381.145676593065, 4395.758233297167, 4395.934060989088, 4396.318570621543, 4388.934165987513, 4399.912001759963, 4399.988002759367, 4428.535003824601, 4433.1577000369825, 4331.242032644291, 4355.978220108895, 4378.408914796493, 4390.780460976938, 4394.4067550880545, 4387.539308372607, 4418.248897687401, 4426.247537918562, 4429.424174857248, 4442.2892337225885, 3560.2167523145126, 3799.2211596622624, 3900.3759398496386, 3915.686745060417, 3928.3697265635014, 5342.958123165984, 5363.54409875161, 5377.0, 5402.162664786964, 5433.402325744165, 4871.756412179412, 4876.926846097312, 4884.5603895649565, 4908.631852611033, 4929.8028078876805, 5523.2543606613, 5807.535397168216, 5828.854278643025, 5831.766729330821, 5836.241288632493, 4066.4713587233764, 4084.7957602120073, 4101.954001729539, 4103.302438585448, 4140.0, 5915.881682366372, 5937.732802023919, 6033.577649564532, 6060.818175454743, 6081.574289799716, 4030.4760381150263, 4231.534531201565, 4232.132412855357, 4247.277962746341, 4274.380214868826, 4292.420523229386, 4296.677749168824, 4305.84929527465, 4311.741295522279, 4334.0, 4922.237053256751, 4946.9010619787405, 4964.875878103004, 4973.676711013773, 5002.22465517838, 5718.428157184248, 5841.561882858802, 5918.585699001114, 5936.910946335808, 5953.732082056318, 1438.697873446567, 1458.6061763323844, 1462.6635873749096, 1481.733288008169, 1483.970320593582, 892.4912799704236, 921.7004024325669, 926.2127191886977, 939.8919124300656, 940.229012209995, 4959.181735013754, 5005.299258103868, 5046.62150338726, 5051.6716413433005, 5072.923906141337, 5390.571498552887, 5393.649412788234, 5402.162664786964, 5420.4850539198715, 5427.402985671573, 5005.849824505198, 5063.518965698253, 5108.3103780989095, 5167.483251674803, 5709.942900570941, 3183.6657150998813, 3202.5836641236956, 3206.6312374076815, 3227.564278822376, 3238.2552013037134, 6071.787487437919, 6247.469370004378, 6260.467860231931, 6275.301620303222, 6280.277768056732, 6123.510119190454, 6135.478484328882, 6140.324564297924, 6171.074338849208, 6183.876322473526, 6231.594946328474, 6260.593061450991, 6261.812145635729, 6283.3088360280335, 6286.49708023357, 5730.226419433323, 5977.491913187428, 5986.161937328865, 5993.31076926159, 6049.153118563317, 5958.0, 5971.880562388815, 5988.580799344004, 6013.218281623361, 6025.849353766191, 5602.299712535933, 6247.625142491465, 6247.968760156352, 6259.718312676032, 6294.4964402846745, 4218.240716671029, 4232.280512312976, 4236.343366778155, 4259.531451540266, 4295.82109239167, 6031.939680603314, 6055.848603784941, 6056.0, 6083.600771822417, 6087.108623403848, 5640.379558248507, 5771.220885180447, 5862.153421672159, 5879.529637629065, 5919.881602368015, 5824.21373114641, 5830.18377427169, 5843.094320380348, 5859.414058594107, 5863.882722345615, 5590.832275031756, 5659.066254068197, 5737.684427356536, 5758.3090029196765, 5831.504322132666, 5848.590598658053, 5859.619124756877, 5902.6458412495385, 5910.847384759931, 5941.37615550361, 5783.6818974955095, 5832.358440571449, 5832.387599302012, 5863.882722345444, 5878.911816322673], "value": 4407.199727054921, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.2510376449085, 753.6269546574447, 757.6211894052974, 801.3909428834086, 825.8224481736428, 14431.278436078193, 15228.92385538072, 15286.694266114671, 15355.616109597251, 15682.529524114267, 15785.973911695732, 16581.751273730875, 16647.0, 16699.582510437245, 16727.749083763752, 765.2194761343426, 772.0426670928065, 781.0549235425142, 783.4829012851491, 788.3850596534712, 777.3625626985873, 782.0498094814799, 783.6238605469379, 787.2127872127872, 787.7676085554775, 822.1244374740882, 823.9052508961456, 824.9175082491763, 828.2876726015621, 829.1542626520945, 805.569020573996, 807.4468988742701, 810.2626609785126, 810.3517186251034, 814.9918500815005, 597.1520440973827, 597.6264834478451, 599.6432122886876, 599.6761748655721, 600.1477901380051, 15760.92119539395, 15878.9206053969, 15887.36450541977, 15906.204689765465, 15950.0, 13805.378757955816, 14309.78535321971, 14464.783028254584, 14628.268586570628, 14695.853041469556, 11499.19505634606, 11921.701957451047, 11973.580924667682, 12109.93945030278, 12138.211016284002, 3918.921621567553, 3934.7639141651593, 3965.8810235692977, 3978.0, 4086.652634526069, 77941.61029194875, 78266.99999999943, 79087.20912790856, 79379.0, 80171.5991420045, 10586.788264234672, 10703.678889633167, 10784.622538211124, 10905.291156074829, 11020.669379918616, 20527.28154514585, 20609.690854637192, 20720.171193152408, 20746.06642701082, 20965.68551471729, 8908.376413651113, 8911.287097032222, 9132.81734365309, 9202.723918282329, 9442.952785236168, 5002.699838009731, 5003.759791642814, 5020.2720605511995, 5096.745162741848, 5312.0, 3321.186309354224, 3419.7264218862433, 3459.7924124552605, 3461.100113970386, 3467.913302167466, 601.509769537834, 615.8952977993752, 623.1307326279905, 624.2166081567694, 637.7225906730587, 709.1631874388169, 719.9676014579356, 726.7819654103748, 759.5215014540914, 771.699037375424, 10126.923980583962, 10313.329633573943, 10466.21503387249, 10620.309679870783, 10731.517081731341, 585.7656937225144, 620.683451439769, 650.2424675253277, 703.0017375326946, 747.1258627405948, 4631.374764406762, 4787.760611969387, 4885.071836351153, 4911.189653707098, 5107.134130834727, 120435.0, 123461.0, 125209.0, 126576.0, 127288.36355818162, 83569.0, 97991.0, 98362.0, 98490.5075474618, 98952.50523747479, 57565.712171439714, 83850.0, 85427.0, 86727.13272867317, 88465.0, 9725.562349694139, 9914.504274786375, 9958.751031224278, 9961.50192490387, 9992.550335234786, 49546.50453495419, 50082.49917500924, 50225.0, 51282.48717512777, 51392.0, 66398.0, 75345.24654753382, 77114.22885771071, 78033.21966780486, 78356.0, 12880.871191287968, 12890.548830790878, 13000.609981700563, 13020.47918083304, 13286.601401957956, 14499.130052196902, 14650.413983440543, 14788.704225915637, 14850.108993460426, 14851.0, 12879.871201287868, 13860.584182474542, 14114.788278176042, 14171.787423188454, 14770.63073423173, 12903.0, 13008.544700935801, 13189.472421103432, 13252.337383130613, 13411.061225714497, 13968.092074015156, 14010.43958241659, 14179.432822686977, 14448.133112013313, 14948.775768363266, 11749.706257343292, 12024.098192635762, 12030.879691202976, 12094.274343539415, 12187.329696866758, 11839.348835814113, 12037.75924481523, 12045.397730113635, 12166.148369614397, 12175.56153288825], "value": 7627.187384308281, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 105.0, 111.0, 112.0, 114.0, 113.0, 111.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 132.0, 154.0, 180.0, 125.0, 152.0, 151.0, 128.0, 183.0, 126.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 167.0, 164.0, 164.0, 166.0, 169.0, 164.0, 162.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 164.0, 75.0, 75.0, 77.0, 75.0, 166.0, 78.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 147.0, 85.0, 86.0, 86.0, 143.0, 86.0, 86.0, 137.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 58.0, 54.0, 55.0, 55.0, 55.0, 55.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 66.0, 65.0, 64.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 81.0, 79.0, 91.0, 82.0, 80.0, 81.0, 93.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 133.0, 127.0, 126.0, 145.0, 133.0, 137.0, 124.0, 122.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 161.0, 161.0, 170.0, 171.0, 161.0, 156.0, 163.0, 158.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 71.0, 64.0, 64.0, 63.0, 62.0, 63.0, 61.0], "value": 64.3, "unit": "score"}]}]} 07:44:56 INFO - Return code: 0 07:44:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:44:56 ERROR - # TBPL SUCCESS # 07:44:56 INFO - Running post-action listener: _resource_record_post_action 07:44:56 INFO - ##### 07:44:56 INFO - ##### Finished run-tests step (success) 07:44:56 INFO - ##### 07:44:56 INFO - Running post-run listener: _resource_record_post_run 07:44:56 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 566804480; Read time: 12; Write time: 701956 07:44:56 INFO - TinderboxPrint: CPU usage
13.5% 07:44:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:44:56 INFO - TinderboxPrint: I/O write bytes / time
566,804,480 / 701,956 07:44:56 INFO - TinderboxPrint: CPU idle
8,205.2 (86.5%) 07:44:56 INFO - TinderboxPrint: CPU user
1,220.7 (12.9%) 07:44:56 INFO - TinderboxPrint: Swap in / out
0 / 0 07:44:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 269459456; Read time: 0; Write time: 402884 07:44:56 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 297009152; Read time: 0; Write time: 299020 07:44:56 INFO - Running post-run listener: _upload_blobber_files 07:44:56 INFO - Blob upload gear active. 07:44:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:44:56 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 07:44:56 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:44:56 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:44:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:57 INFO - (blobuploader) - INFO - Done attempting. 07:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:44:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:01 INFO - (blobuploader) - INFO - Done attempting. 07:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:45:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:02 INFO - (blobuploader) - INFO - Done attempting. 07:45:02 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:02 INFO - Return code: 0 07:45:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85a0f9d2bc52b3bfcc4e49447d41aa703e5371fd802b2e793b5ace2440bd405a8511aaa147cf35c5fe4a49fc1119ad383578c7a18c7508c4742922fbf64c78ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5012d7cbbe1f4aedbbfa726c371a2265b3c74a0c89642e06f1edea9ac0aeb31c9c84c22e8aed59c3967375a9dad2ac419bbbfe05a386b463c0e0b8633f6e20c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/36e055f4c49d073298986daf78498711b5ab138546fa762b5475a98a3567b561bf13124002ad2a7f5893492088983fd0b3a048e87549200b9e07704781fb64e0"} 07:45:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:02 INFO - Contents: 07:45:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85a0f9d2bc52b3bfcc4e49447d41aa703e5371fd802b2e793b5ace2440bd405a8511aaa147cf35c5fe4a49fc1119ad383578c7a18c7508c4742922fbf64c78ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5012d7cbbe1f4aedbbfa726c371a2265b3c74a0c89642e06f1edea9ac0aeb31c9c84c22e8aed59c3967375a9dad2ac419bbbfe05a386b463c0e0b8633f6e20c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/36e055f4c49d073298986daf78498711b5ab138546fa762b5475a98a3567b561bf13124002ad2a7f5893492088983fd0b3a048e87549200b9e07704781fb64e0"} 07:45:02 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:02 INFO - Copying logs to upload dir... 07:45:02 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.240008 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-28 07:45:02.346272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 07:45:02.349603) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85a0f9d2bc52b3bfcc4e49447d41aa703e5371fd802b2e793b5ace2440bd405a8511aaa147cf35c5fe4a49fc1119ad383578c7a18c7508c4742922fbf64c78ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5012d7cbbe1f4aedbbfa726c371a2265b3c74a0c89642e06f1edea9ac0aeb31c9c84c22e8aed59c3967375a9dad2ac419bbbfe05a386b463c0e0b8633f6e20c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/36e055f4c49d073298986daf78498711b5ab138546fa762b5475a98a3567b561bf13124002ad2a7f5893492088983fd0b3a048e87549200b9e07704781fb64e0"} build_url:https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85a0f9d2bc52b3bfcc4e49447d41aa703e5371fd802b2e793b5ace2440bd405a8511aaa147cf35c5fe4a49fc1119ad383578c7a18c7508c4742922fbf64c78ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5012d7cbbe1f4aedbbfa726c371a2265b3c74a0c89642e06f1edea9ac0aeb31c9c84c22e8aed59c3967375a9dad2ac419bbbfe05a386b463c0e0b8633f6e20c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/36e055f4c49d073298986daf78498711b5ab138546fa762b5475a98a3567b561bf13124002ad2a7f5893492088983fd0b3a048e87549200b9e07704781fb64e0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 07:45:02.376106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:45:02.376427) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467123663.706899-1813262401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:45:02.457949) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 07:45:02.458301) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 07:45:02.458608) ========= ========= Total master_lag: 0.17 =========