builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1468953495.28 results: success (0) buildid: 20160719073107 builduid: b91551c3f70a4aaebd072c030f1ca32b revision: 5a91e5b49be3c1ba401b057e90c92d7488e3647d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:15.284437) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:15.284856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:15.285135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:15.300614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:15.300869) ========= 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=33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 11:38:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-07-19 11:38:15 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097891 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:15.454495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:15.454833) ========= 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=33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018526 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:15.485703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:15.486055) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5a91e5b49be3c1ba401b057e90c92d7488e3647d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5a91e5b49be3c1ba401b057e90c92d7488e3647d --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=33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 11:38:15,638 truncating revision to first 12 chars 2016-07-19 11:38:15,638 Setting DEBUG logging. 2016-07-19 11:38:15,639 attempt 1/10 2016-07-19 11:38:15,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5a91e5b49be3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 11:38:15,962 unpacking tar archive at: mozilla-central-5a91e5b49be3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649959 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:16.222408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:16.222736) ========= script_repo_revision: 5a91e5b49be3c1ba401b057e90c92d7488e3647d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:16.223147) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:16.223427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 11:38:16.232698) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2016-07-19 11:38:16.232967) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:38:16 INFO - MultiFileLogger online at 20160719 11:38:16 in /builds/slave/test 11:38:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:38:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:38:16 INFO - {'append_to_log': False, 11:38:16 INFO - 'base_work_dir': '/builds/slave/test', 11:38:16 INFO - 'blob_upload_branch': 'Firefox', 11:38:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:38:16 INFO - 'branch': 'Firefox', 11:38:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:38:16 INFO - 'config_files': ('talos/linux_config.py',), 11:38:16 INFO - 'default_actions': ('clobber', 11:38:16 INFO - 'read-buildbot-config', 11:38:16 INFO - 'download-and-extract', 11:38:16 INFO - 'populate-webroot', 11:38:16 INFO - 'create-virtualenv', 11:38:16 INFO - 'install', 11:38:16 INFO - 'run-tests'), 11:38:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:38:16 INFO - 'download_minidump_stackwalk': True, 11:38:16 INFO - 'download_symbols': 'ondemand', 11:38:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:38:16 INFO - 'tooltool.py': '/tools/tooltool.py', 11:38:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:38:16 INFO - '/tools/misc-python/virtualenv.py')}, 11:38:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:38:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:38:16 INFO - 'installer_path': 'installer.exe', 11:38:16 INFO - 'log_level': 'info', 11:38:16 INFO - 'log_name': 'talos', 11:38:16 INFO - 'log_to_console': True, 11:38:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:38:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:38:16 INFO - 'opt_config_files': (), 11:38:16 INFO - 'pip_index': False, 11:38:16 INFO - 'sps_profile': False, 11:38:16 INFO - 'sps_profile_interval': 0, 11:38:16 INFO - 'suite': 'dromaeojs-e10s', 11:38:16 INFO - 'system_bits': '32', 11:38:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:38:16 INFO - 'title': 'talos-linux64-ix-063', 11:38:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:38:16 INFO - 'use_talos_json': True, 11:38:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:38:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:38:16 INFO - 'work_dir': 'build'} 11:38:16 INFO - ##### 11:38:16 INFO - ##### Running clobber step. 11:38:16 INFO - ##### 11:38:16 INFO - Running pre-action listener: _resource_record_pre_action 11:38:16 INFO - Running main action method: clobber 11:38:16 INFO - rmtree: /builds/slave/test/build 11:38:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:38:16 INFO - Running post-action listener: _resource_record_post_action 11:38:16 INFO - ##### 11:38:16 INFO - ##### Finished clobber step (success) 11:38:16 INFO - ##### 11:38:16 INFO - ##### 11:38:16 INFO - ##### Running read-buildbot-config step. 11:38:16 INFO - ##### 11:38:16 INFO - Running pre-action listener: _resource_record_pre_action 11:38:16 INFO - Running main action method: read_buildbot_config 11:38:16 INFO - Using buildbot properties: 11:38:16 INFO - { 11:38:16 INFO - "project": "", 11:38:16 INFO - "product": "firefox", 11:38:16 INFO - "script_repo_revision": "production", 11:38:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:38:16 INFO - "repository": "", 11:38:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:38:16 INFO - "buildid": "20160719073107", 11:38:16 INFO - "pgo_build": "True", 11:38:16 INFO - "basedir": "/builds/slave/test", 11:38:16 INFO - "buildnumber": 99, 11:38:16 INFO - "slavename": "talos-linux64-ix-063", 11:38:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:38:16 INFO - "platform": "ubuntu64_hw", 11:38:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 11:38:16 INFO - "branch": "mozilla-central", 11:38:16 INFO - "repo_path": "mozilla-central", 11:38:16 INFO - "revision": "5a91e5b49be3c1ba401b057e90c92d7488e3647d", 11:38:16 INFO - "stage_platform": "linux64-pgo", 11:38:16 INFO - "builduid": "b91551c3f70a4aaebd072c030f1ca32b", 11:38:16 INFO - "slavebuilddir": "test" 11:38:16 INFO - } 11:38:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:38:16 INFO - Running post-action listener: _resource_record_post_action 11:38:16 INFO - ##### 11:38:16 INFO - ##### Finished read-buildbot-config step (success) 11:38:16 INFO - ##### 11:38:16 INFO - ##### 11:38:16 INFO - ##### Running download-and-extract step. 11:38:16 INFO - ##### 11:38:16 INFO - Running pre-action listener: _resource_record_pre_action 11:38:16 INFO - Running main action method: download_and_extract 11:38:16 INFO - mkdir: /builds/slave/test/build/tests 11:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:16 INFO - https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:38:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:17 INFO - Downloaded 1361 bytes. 11:38:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:17 INFO - Using the following test package requirements: 11:38:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:38:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:38:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:17 INFO - u'jsshell-linux-x86_64.zip'], 11:38:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:38:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:38:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:38:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:38:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:38:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:17 INFO - https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:18 INFO - Downloaded 24336379 bytes. 11:38:18 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'] 11:38:18 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 11:38:20 INFO - Return code: 0 11:38:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:20 INFO - https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:23 INFO - Downloaded 24336379 bytes. 11:38:23 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'] 11:38:23 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 11:38:38 INFO - Return code: 0 11:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:38:38 INFO - https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:38:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:38:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:38:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:39 INFO - Downloaded 14403317 bytes. 11:38:39 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'] 11:38:39 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 11:38:39 INFO - Return code: 0 11:38: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')]} 11:38:39 INFO - https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:38:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:38:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:38:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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 11:38:41 INFO - Downloaded 60864451 bytes. 11:38:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:38:41 INFO - mkdir: /builds/slave/test/properties 11:38:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:38:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:38:41 INFO - Contents: 11:38:41 INFO - build_url:https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:38:41 INFO - Running post-action listener: _resource_record_post_action 11:38:41 INFO - Running post-action listener: set_extra_try_arguments 11:38:41 INFO - ##### 11:38:41 INFO - ##### Finished download-and-extract step (success) 11:38:41 INFO - ##### 11:38:41 INFO - ##### 11:38:41 INFO - ##### Running populate-webroot step. 11:38:41 INFO - ##### 11:38:41 INFO - Running pre-action listener: _resource_record_pre_action 11:38:41 INFO - Running main action method: populate_webroot 11:38:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:38:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:38:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:38:41 INFO - '--tppagecycles', 11:38:41 INFO - '7'], 11:38:41 INFO - 'tests': ['tsvgm']}}, 11:38:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:38:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:38:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:38:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:38:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:41 INFO - 'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:41 INFO - 'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['damp', 'tps']}, 11:38:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:41 INFO - 'tests': ['damp', 'tps']}, 11:38:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['dromaeo_dom']}, 11:38:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:38:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['basic_compositor_video']}, 11:38:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:38:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['a11yr', 11:38:41 INFO - 'ts_paint', 11:38:41 INFO - 'tpaint', 11:38:41 INFO - 'sessionrestore', 11:38:41 INFO - 'sessionrestore_no_auto_restore', 11:38:41 INFO - 'tabpaint']}, 11:38:41 INFO - 'other-e10s': {'tests': ['a11yr', 11:38:41 INFO - 'ts_paint', 11:38:41 INFO - 'tpaint', 11:38:41 INFO - 'sessionrestore', 11:38:41 INFO - 'sessionrestore_no_auto_restore', 11:38:41 INFO - 'tabpaint']}, 11:38:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:38:41 INFO - 'ts_paint', 11:38:41 INFO - 'tpaint', 11:38:41 INFO - 'sessionrestore', 11:38:41 INFO - 'sessionrestore_no_auto_restore', 11:38:41 INFO - 'tabpaint']}, 11:38:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:38:41 INFO - 'ts_paint', 11:38:41 INFO - 'tpaint', 11:38:41 INFO - 'sessionrestore', 11:38:41 INFO - 'sessionrestore_no_auto_restore', 11:38:41 INFO - 'tabpaint']}, 11:38:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['a11yr', 11:38:41 INFO - 'ts_paint', 11:38:41 INFO - 'tpaint', 11:38:41 INFO - 'sessionrestore', 11:38:41 INFO - 'sessionrestore_no_auto_restore', 11:38:41 INFO - 'tabpaint']}, 11:38:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['a11yr', 11:38:41 INFO - 'ts_paint', 11:38:41 INFO - 'tpaint', 11:38:41 INFO - 'sessionrestore', 11:38:41 INFO - 'sessionrestore_no_auto_restore', 11:38:41 INFO - 'tabpaint']}, 11:38:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['tsvgx', 11:38:41 INFO - 'tsvgr_opacity', 11:38:41 INFO - 'tart', 11:38:41 INFO - 'tscrollx', 11:38:41 INFO - 'cart']}, 11:38:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:38:41 INFO - 'tsvgr_opacity', 11:38:41 INFO - 'tart', 11:38:41 INFO - 'tscrollx', 11:38:41 INFO - 'cart']}, 11:38:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:41 INFO - 'talos_options': ['--disable-e10s'], 11:38:41 INFO - 'tests': ['tp5o']}, 11:38:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:41 INFO - 'tests': ['tp5o']}, 11:38:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:41 INFO - 'talos_options': ['--disable-e10s', 11:38:41 INFO - '--xperf_path', 11:38:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:41 INFO - 'tests': ['tp5n']}, 11:38:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:41 INFO - 'talos_options': ['--xperf_path', 11:38:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:41 INFO - 'tests': ['tp5n']}}, 11:38:41 INFO - 'talos.zip': {'path': '', 11:38:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:38:41 INFO - Running post-action listener: _resource_record_post_action 11:38:41 INFO - ##### 11:38:41 INFO - ##### Finished populate-webroot step (success) 11:38:41 INFO - ##### 11:38:41 INFO - ##### 11:38:41 INFO - ##### Running create-virtualenv step. 11:38:41 INFO - ##### 11:38:41 INFO - Running pre-action listener: _resource_record_pre_action 11:38:41 INFO - Running main action method: create_virtualenv 11:38:41 INFO - Creating virtualenv /builds/slave/test/build/venv 11:38:41 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 11:38:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:38:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:38:41 INFO - Using real prefix '/usr' 11:38:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:38:42 INFO - Installing distribute.............................................................................................................................................................................................done. 11:38:46 INFO - Installing pip.................done. 11:38:46 INFO - Return code: 0 11:38:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:38:46 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')]} 11:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:46 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')]} 11:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:46 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', '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 11:38:46 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 11:38:46 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 11:38:46 INFO - Using env: {'DISPLAY': ':0', 11:38:46 INFO - 'HOME': '/home/cltbld', 11:38:46 INFO - 'LANG': 'en_US.UTF-8', 11:38:46 INFO - 'LANGUAGE': 'en_US:en', 11:38:46 INFO - 'LOGNAME': 'cltbld', 11:38:46 INFO - 'MAIL': '/var/mail/cltbld', 11:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:46 INFO - 'MOZ_NO_REMOTE': '1', 11:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:46 INFO - 'NO_EM_RESTART': '1', 11:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:46 INFO - 'PWD': '/builds/slave/test', 11:38:46 INFO - 'SHELL': '/bin/bash', 11:38:46 INFO - 'SHLVL': '1', 11:38:46 INFO - 'TERM': 'linux', 11:38:46 INFO - 'TMOUT': '86400', 11:38:46 INFO - 'USER': 'cltbld', 11:38:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:46 INFO - '_': '/tools/buildbot/bin/python'} 11:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38: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 11:38:47 INFO - Cleaning up... 11:38:47 INFO - Return code: 0 11:38:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:38: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')]} 11:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38: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')]} 11:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38: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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', '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 11:38: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 11:38: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 11:38:47 INFO - Using env: {'DISPLAY': ':0', 11:38:47 INFO - 'HOME': '/home/cltbld', 11:38:47 INFO - 'LANG': 'en_US.UTF-8', 11:38:47 INFO - 'LANGUAGE': 'en_US:en', 11:38:47 INFO - 'LOGNAME': 'cltbld', 11:38:47 INFO - 'MAIL': '/var/mail/cltbld', 11:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:47 INFO - 'MOZ_NO_REMOTE': '1', 11:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:47 INFO - 'NO_EM_RESTART': '1', 11:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:47 INFO - 'PWD': '/builds/slave/test', 11:38:47 INFO - 'SHELL': '/bin/bash', 11:38:47 INFO - 'SHLVL': '1', 11:38:47 INFO - 'TERM': 'linux', 11:38:47 INFO - 'TMOUT': '86400', 11:38:47 INFO - 'USER': 'cltbld', 11:38:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:47 INFO - '_': '/tools/buildbot/bin/python'} 11:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:47 INFO - Downloading/unpacking psutil>=3.1.1 11:38:47 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 11:38:47 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 11:38:47 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 11:38:47 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 11:38:47 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 11:38:47 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 11:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:38:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:49 INFO - Installing collected packages: psutil 11:38:49 INFO - Running setup.py install for psutil 11:38:49 INFO - building 'psutil._psutil_linux' extension 11:38:49 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 11:38: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 11:38:50 INFO - building 'psutil._psutil_posix' extension 11:38: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 11:38: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 11:38:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:50 INFO - Successfully installed psutil 11:38:50 INFO - Cleaning up... 11:38:52 INFO - Return code: 0 11:38:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', '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 11:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:38:52 INFO - Using env: {'DISPLAY': ':0', 11:38:52 INFO - 'HOME': '/home/cltbld', 11:38:52 INFO - 'LANG': 'en_US.UTF-8', 11:38:52 INFO - 'LANGUAGE': 'en_US:en', 11:38:52 INFO - 'LOGNAME': 'cltbld', 11:38:52 INFO - 'MAIL': '/var/mail/cltbld', 11:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:52 INFO - 'MOZ_NO_REMOTE': '1', 11:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:52 INFO - 'NO_EM_RESTART': '1', 11:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:52 INFO - 'PWD': '/builds/slave/test', 11:38:52 INFO - 'SHELL': '/bin/bash', 11:38:52 INFO - 'SHLVL': '1', 11:38:52 INFO - 'TERM': 'linux', 11:38:52 INFO - 'TMOUT': '86400', 11:38:52 INFO - 'USER': 'cltbld', 11:38:52 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:52 INFO - '_': '/tools/buildbot/bin/python'} 11:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:38:52 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 11:38:52 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 11:38:52 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 11:38:52 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 11:38:52 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 11:38:52 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 11:38:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:38:54 INFO - Installing collected packages: mozsystemmonitor 11:38:54 INFO - Running setup.py install for mozsystemmonitor 11:38:57 INFO - Successfully installed mozsystemmonitor 11:38:57 INFO - Cleaning up... 11:39:05 INFO - Return code: 0 11:39:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:05 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', '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 11:39:05 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 11:39:05 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 11:39:05 INFO - Using env: {'DISPLAY': ':0', 11:39:05 INFO - 'HOME': '/home/cltbld', 11:39:05 INFO - 'LANG': 'en_US.UTF-8', 11:39:05 INFO - 'LANGUAGE': 'en_US:en', 11:39:05 INFO - 'LOGNAME': 'cltbld', 11:39:05 INFO - 'MAIL': '/var/mail/cltbld', 11:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:05 INFO - 'MOZ_NO_REMOTE': '1', 11:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:05 INFO - 'NO_EM_RESTART': '1', 11:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:05 INFO - 'PWD': '/builds/slave/test', 11:39:05 INFO - 'SHELL': '/bin/bash', 11:39:05 INFO - 'SHLVL': '1', 11:39:05 INFO - 'TERM': 'linux', 11:39:05 INFO - 'TMOUT': '86400', 11:39:05 INFO - 'USER': 'cltbld', 11:39:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:05 INFO - '_': '/tools/buildbot/bin/python'} 11:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:07 INFO - Downloading/unpacking jsonschema==2.5.1 11:39:07 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 11:39:07 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 11:39:07 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 11:39:07 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 11:39:07 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 11:39:07 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 11:39:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:39:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:09 INFO - Downloading functools32-3.2.3-2.tar.gz 11:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:39:09 INFO - warning: no files found matching '*.txt' 11:39:09 INFO - no previously-included directories found matching 'build' 11:39:09 INFO - no previously-included directories found matching 'dist' 11:39:09 INFO - no previously-included directories found matching '.git*' 11:39:09 INFO - Installing collected packages: jsonschema, functools32 11:39:09 INFO - Running setup.py install for functools32 11:39:09 INFO - warning: no files found matching '*.txt' 11:39:09 INFO - no previously-included directories found matching 'build' 11:39:09 INFO - no previously-included directories found matching 'dist' 11:39:09 INFO - no previously-included directories found matching '.git*' 11:39:09 INFO - Successfully installed jsonschema functools32 11:39:09 INFO - Cleaning up... 11:39:09 INFO - Return code: 0 11:39:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:09 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', '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 11:39:09 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 11:39:09 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 11:39:09 INFO - Using env: {'DISPLAY': ':0', 11:39:09 INFO - 'HOME': '/home/cltbld', 11:39:09 INFO - 'LANG': 'en_US.UTF-8', 11:39:09 INFO - 'LANGUAGE': 'en_US:en', 11:39:09 INFO - 'LOGNAME': 'cltbld', 11:39:09 INFO - 'MAIL': '/var/mail/cltbld', 11:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:09 INFO - 'MOZ_NO_REMOTE': '1', 11:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:09 INFO - 'NO_EM_RESTART': '1', 11:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:09 INFO - 'PWD': '/builds/slave/test', 11:39:09 INFO - 'SHELL': '/bin/bash', 11:39:09 INFO - 'SHLVL': '1', 11:39:09 INFO - 'TERM': 'linux', 11:39:09 INFO - 'TMOUT': '86400', 11:39:09 INFO - 'USER': 'cltbld', 11:39:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:09 INFO - '_': '/tools/buildbot/bin/python'} 11:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:09 INFO - Downloading/unpacking blobuploader==1.2.4 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:11 INFO - Downloading blobuploader-1.2.4.tar.gz 11:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:39:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:39:11 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 11:39:11 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 11:39:11 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 11:39:11 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 11:39:11 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 11:39:11 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 11:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:39:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 INFO - Downloading docopt-0.6.1.tar.gz 11:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:39:12 INFO - Installing collected packages: blobuploader, requests, docopt 11:39:12 INFO - Running setup.py install for blobuploader 11:39:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:39:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:39:12 INFO - Running setup.py install for requests 11:39:12 INFO - Running setup.py install for docopt 11:39:12 INFO - Successfully installed blobuploader requests docopt 11:39:12 INFO - Cleaning up... 11:39:12 INFO - Return code: 0 11:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:12 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')]} 11:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:12 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')]} 11:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:12 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', '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 11:39:12 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 11:39:12 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 11:39:12 INFO - Using env: {'DISPLAY': ':0', 11:39:12 INFO - 'HOME': '/home/cltbld', 11:39:12 INFO - 'LANG': 'en_US.UTF-8', 11:39:12 INFO - 'LANGUAGE': 'en_US:en', 11:39:12 INFO - 'LOGNAME': 'cltbld', 11:39:12 INFO - 'MAIL': '/var/mail/cltbld', 11:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:12 INFO - 'MOZ_NO_REMOTE': '1', 11:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:12 INFO - 'NO_EM_RESTART': '1', 11:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:12 INFO - 'PWD': '/builds/slave/test', 11:39:12 INFO - 'SHELL': '/bin/bash', 11:39:12 INFO - 'SHLVL': '1', 11:39:12 INFO - 'TERM': 'linux', 11:39:12 INFO - 'TMOUT': '86400', 11:39:12 INFO - 'USER': 'cltbld', 11:39:12 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:12 INFO - '_': '/tools/buildbot/bin/python'} 11:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:13 INFO - Running setup.py (path:/tmp/pip-mmexdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:13 INFO - Running setup.py (path:/tmp/pip-KmRybe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:13 INFO - Running setup.py (path:/tmp/pip-GRqVJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:13 INFO - Running setup.py (path:/tmp/pip-U0zgvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:13 INFO - Running setup.py (path:/tmp/pip-4wSr9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:13 INFO - Running setup.py (path:/tmp/pip-LYx1j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:13 INFO - Running setup.py (path:/tmp/pip-GaSC5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:13 INFO - Running setup.py (path:/tmp/pip-mXXQ5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:13 INFO - Running setup.py (path:/tmp/pip-w3PvMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:13 INFO - Running setup.py (path:/tmp/pip-KLCJZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:13 INFO - Running setup.py (path:/tmp/pip-FnW9Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:13 INFO - Running setup.py (path:/tmp/pip-feqBA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:14 INFO - Running setup.py (path:/tmp/pip-GB0haP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:14 INFO - Running setup.py (path:/tmp/pip-Jq_tYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:14 INFO - Running setup.py (path:/tmp/pip-Kfxsxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:14 INFO - Running setup.py (path:/tmp/pip-AJanmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:14 INFO - Running setup.py (path:/tmp/pip-UNZWDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:39:14 INFO - Running setup.py install for manifestparser 11:39:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:39:14 INFO - Running setup.py install for mozcrash 11:39:14 INFO - Running setup.py install for mozdebug 11:39:14 INFO - Running setup.py install for mozdevice 11:39:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:39:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:39:14 INFO - Running setup.py install for mozfile 11:39:14 INFO - Running setup.py install for mozhttpd 11:39:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:39:14 INFO - Running setup.py install for mozinfo 11:39:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozInstall 11:39:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozleak 11:39:15 INFO - Running setup.py install for mozlog 11:39:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for moznetwork 11:39:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozprocess 11:39:15 INFO - Running setup.py install for mozprofile 11:39:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozrunner 11:39:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozscreenshot 11:39:15 INFO - Running setup.py install for moztest 11:39:16 INFO - Running setup.py install for mozversion 11:39:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:39:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:39:16 INFO - Cleaning up... 11:39:16 INFO - Return code: 0 11:39:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:16 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', '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 11:39:16 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 11:39:16 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 11:39:16 INFO - Using env: {'DISPLAY': ':0', 11:39:16 INFO - 'HOME': '/home/cltbld', 11:39:16 INFO - 'LANG': 'en_US.UTF-8', 11:39:16 INFO - 'LANGUAGE': 'en_US:en', 11:39:16 INFO - 'LOGNAME': 'cltbld', 11:39:16 INFO - 'MAIL': '/var/mail/cltbld', 11:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:16 INFO - 'MOZ_NO_REMOTE': '1', 11:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:16 INFO - 'NO_EM_RESTART': '1', 11:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:16 INFO - 'PWD': '/builds/slave/test', 11:39:16 INFO - 'SHELL': '/bin/bash', 11:39:16 INFO - 'SHLVL': '1', 11:39:16 INFO - 'TERM': 'linux', 11:39:16 INFO - 'TMOUT': '86400', 11:39:16 INFO - 'USER': 'cltbld', 11:39:16 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:16 INFO - '_': '/tools/buildbot/bin/python'} 11:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:16 INFO - Running setup.py (path:/tmp/pip-3z2gu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:16 INFO - Running setup.py (path:/tmp/pip-rsst9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:16 INFO - Running setup.py (path:/tmp/pip-KmfFaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:16 INFO - Running setup.py (path:/tmp/pip-xLbgJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:16 INFO - Running setup.py (path:/tmp/pip-WkFfC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:16 INFO - Running setup.py (path:/tmp/pip-qKEVvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:16 INFO - Running setup.py (path:/tmp/pip-b4Fbm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:16 INFO - Running setup.py (path:/tmp/pip-QvGY31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:16 INFO - Running setup.py (path:/tmp/pip-0b3wtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:17 INFO - Running setup.py (path:/tmp/pip-TBm5I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:17 INFO - Running setup.py (path:/tmp/pip-RmDICs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:17 INFO - Running setup.py (path:/tmp/pip-9kdkUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:17 INFO - Running setup.py (path:/tmp/pip-EQMk0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:17 INFO - Running setup.py (path:/tmp/pip-gqqbfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:17 INFO - Running setup.py (path:/tmp/pip-7pepLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:17 INFO - Running setup.py (path:/tmp/pip-uqqct4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:17 INFO - Running setup.py (path:/tmp/pip-GLEhvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:17 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)) 11:39:17 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)) 11:39:17 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)) 11:39:17 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)) 11:39:17 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)) 11:39:17 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)) 11:39:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 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 11:39:17 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 11:39:19 INFO - Downloading blessings-1.6.tar.gz 11:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:39:19 INFO - Installing collected packages: blessings 11:39:19 INFO - Running setup.py install for blessings 11:39:19 INFO - Successfully installed blessings 11:39:19 INFO - Cleaning up... 11:39:19 INFO - Return code: 0 11:39:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:39:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:19 INFO - Reading from file tmpfile_stdout 11:39:19 INFO - Current package versions: 11:39:19 INFO - argparse == 1.2.1 11:39:19 INFO - blessings == 1.6 11:39:19 INFO - blobuploader == 1.2.4 11:39:19 INFO - docopt == 0.6.1 11:39:19 INFO - functools32 == 3.2.3-2 11:39:19 INFO - jsonschema == 2.5.1 11:39:19 INFO - manifestparser == 1.1 11:39:19 INFO - mozInstall == 1.12 11:39:19 INFO - mozcrash == 0.17 11:39:19 INFO - mozdebug == 0.1 11:39:19 INFO - mozdevice == 0.48 11:39:19 INFO - mozfile == 1.2 11:39:19 INFO - mozhttpd == 0.7 11:39:19 INFO - mozinfo == 0.9 11:39:19 INFO - mozleak == 0.1 11:39:19 INFO - mozlog == 3.3 11:39:19 INFO - moznetwork == 0.27 11:39:19 INFO - mozprocess == 0.23 11:39:19 INFO - mozprofile == 0.28 11:39:19 INFO - mozrunner == 6.12 11:39:19 INFO - mozscreenshot == 0.1 11:39:19 INFO - mozsystemmonitor == 0.3 11:39:19 INFO - moztest == 0.7 11:39:19 INFO - mozversion == 1.4 11:39:19 INFO - psutil == 3.1.1 11:39:19 INFO - requests == 1.2.3 11:39:19 INFO - wsgiref == 0.1.2 11:39:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:19 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')]} 11:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:19 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')]} 11:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:19 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', '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 11:39:19 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 11:39:19 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 11:39:19 INFO - Using env: {'DISPLAY': ':0', 11:39:19 INFO - 'HOME': '/home/cltbld', 11:39:19 INFO - 'LANG': 'en_US.UTF-8', 11:39:19 INFO - 'LANGUAGE': 'en_US:en', 11:39:19 INFO - 'LOGNAME': 'cltbld', 11:39:19 INFO - 'MAIL': '/var/mail/cltbld', 11:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:19 INFO - 'MOZ_NO_REMOTE': '1', 11:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:19 INFO - 'NO_EM_RESTART': '1', 11:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:19 INFO - 'PWD': '/builds/slave/test', 11:39:19 INFO - 'SHELL': '/bin/bash', 11:39:19 INFO - 'SHLVL': '1', 11:39:19 INFO - 'TERM': 'linux', 11:39:19 INFO - 'TMOUT': '86400', 11:39:19 INFO - 'USER': 'cltbld', 11:39:19 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:19 INFO - '_': '/tools/buildbot/bin/python'} 11:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 INFO - Cleaning up... 11:39:20 INFO - Return code: 0 11:39:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:20 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', '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 11:39:20 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 11:39:20 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 11:39:20 INFO - Using env: {'DISPLAY': ':0', 11:39:20 INFO - 'HOME': '/home/cltbld', 11:39:20 INFO - 'LANG': 'en_US.UTF-8', 11:39:20 INFO - 'LANGUAGE': 'en_US:en', 11:39:20 INFO - 'LOGNAME': 'cltbld', 11:39:20 INFO - 'MAIL': '/var/mail/cltbld', 11:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:20 INFO - 'MOZ_NO_REMOTE': '1', 11:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:20 INFO - 'NO_EM_RESTART': '1', 11:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:20 INFO - 'PWD': '/builds/slave/test', 11:39:20 INFO - 'SHELL': '/bin/bash', 11:39:20 INFO - 'SHLVL': '1', 11:39:20 INFO - 'TERM': 'linux', 11:39:20 INFO - 'TMOUT': '86400', 11:39:20 INFO - 'USER': 'cltbld', 11:39:20 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:20 INFO - '_': '/tools/buildbot/bin/python'} 11:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:39:20 INFO - Cleaning up... 11:39:20 INFO - Return code: 0 11:39:20 INFO - Running post-action listener: _resource_record_post_action 11:39:20 INFO - Running post-action listener: _start_resource_monitoring 11:39:20 INFO - Starting resource monitoring. 11:39:20 INFO - ##### 11:39:20 INFO - ##### Finished create-virtualenv step (success) 11:39:20 INFO - ##### 11:39:20 INFO - ##### 11:39:20 INFO - ##### Running install step. 11:39:20 INFO - ##### 11:39:20 INFO - Running pre-action listener: _resource_record_pre_action 11:39:20 INFO - Running main action method: install 11:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:20 INFO - Reading from file tmpfile_stdout 11:39:20 INFO - Detecting whether we're running mozinstall >=1.0... 11:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:39:20 INFO - Reading from file tmpfile_stdout 11:39:20 INFO - Output received: 11:39:20 INFO - Usage: mozinstall [options] installer 11:39:20 INFO - Options: 11:39:20 INFO - -h, --help show this help message and exit 11:39:20 INFO - -d DEST, --destination=DEST 11:39:20 INFO - Directory to install application into. [default: 11:39:20 INFO - "/builds/slave/test"] 11:39:20 INFO - --app=APP Application being installed. [default: firefox] 11:39:20 INFO - mkdir: /builds/slave/test/build/application 11:39:20 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'] 11:39:20 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 11:39:37 INFO - Reading from file tmpfile_stdout 11:39:37 INFO - Output received: 11:39:37 INFO - /builds/slave/test/build/application/firefox/firefox 11:39:37 INFO - Running post-action listener: _resource_record_post_action 11:39:37 INFO - ##### 11:39:37 INFO - ##### Finished install step (success) 11:39:37 INFO - ##### 11:39:37 INFO - ##### 11:39:37 INFO - ##### Running run-tests step. 11:39:37 INFO - ##### 11:39:37 INFO - Running pre-action listener: _resource_record_pre_action 11:39:37 INFO - Running main action method: run_tests 11:39:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:39:37 INFO - Python 2.7.3 11:39:37 INFO - Return code: 0 11:39:37 INFO - grabbing minidump binary from tooltool 11:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:37 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 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:39:37 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 11:39:37 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 11:39:37 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 11:39:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:39:38 INFO - Return code: 0 11:39:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:39:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:39:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:39:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:39:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 11:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 11:39:38 INFO - Using env: {'DISPLAY': ':0', 11:39:38 INFO - 'HOME': '/home/cltbld', 11:39:38 INFO - 'LANG': 'en_US.UTF-8', 11:39:38 INFO - 'LANGUAGE': 'en_US:en', 11:39:38 INFO - 'LOGNAME': 'cltbld', 11:39:38 INFO - 'MAIL': '/var/mail/cltbld', 11:39:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:38 INFO - 'MOZ_NO_REMOTE': '1', 11:39:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:38 INFO - 'NO_EM_RESTART': '1', 11:39:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:38 INFO - 'PWD': '/builds/slave/test', 11:39:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:38 INFO - 'SHELL': '/bin/bash', 11:39:38 INFO - 'SHLVL': '1', 11:39:38 INFO - 'TERM': 'linux', 11:39:38 INFO - 'TMOUT': '86400', 11:39:38 INFO - 'USER': 'cltbld', 11:39:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888', 11:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:38 INFO - '_': '/tools/buildbot/bin/python'} 11:39:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 11:39:38 INFO - mozversion application_buildid: 20160719073107 11:39:38 INFO - mozversion application_changeset: 5a91e5b49be3c1ba401b057e90c92d7488e3647d 11:39:38 INFO - mozversion application_display_name: Nightly 11:39:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:38 INFO - mozversion application_name: Firefox 11:39:38 INFO - mozversion application_remotingname: firefox 11:39:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:39:38 INFO - mozversion application_vendor: Mozilla 11:39:38 INFO - mozversion application_version: 50.0a1 11:39:38 INFO - mozversion platform_buildid: 20160719073107 11:39:38 INFO - mozversion platform_changeset: 5a91e5b49be3c1ba401b057e90c92d7488e3647d 11:39:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:39:38 INFO - mozversion platform_version: 50.0a1 11:39:38 INFO - using testdate: 1468953578 11:39:38 INFO - actual date: 1468953578 11:39:38 INFO - starting webserver on 'localhost:37024' 11:39:38 INFO - SUITE-START | Running 2 tests 11:39:38 INFO - TEST-START | dromaeo_css 11:39:38 INFO - operating with platform_type : linux_ 11:39:38 INFO - Initialising browser for dromaeo_css test... 11:39:38 INFO - TEST-INFO | started process 5317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGw77nu/profile http://localhost:37024/getInfo.html) 11:40:05 INFO - PROCESS | 5317 | __metrics Screen width/height:1600/1200 11:40:05 INFO - PROCESS | 5317 | colorDepth:24 11:40:05 INFO - PROCESS | 5317 | Browser inner width/height: 1024/697 11:40:05 INFO - PROCESS | 5317 | __metrics 11:40:06 ERROR - PROCESS | 5317 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:40:07 INFO - TEST-INFO | 5317: exit 0 11:40:07 INFO - Browser initialized. 11:40:07 INFO - Running cycle 1/1 for dromaeo_css test... 11:40:07 INFO - TEST-INFO | started process 5440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGw77nu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:19 INFO - PROCESS | 5440 | RSS: Main: 167534592 11:40:19 INFO - PROCESS | 5440 | 11:41:09 INFO - PROCESS | 5440 | 1468953669062 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] 11:43:17 INFO - PROCESS | 5440 | Cycle 1(1): loaded http://localhost:37024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37024/tests/dromaeo/cssquery-ext.html) 11:43:18 INFO - PROCESS | 5440 | RSS: Main: 174112768 11:43:18 INFO - PROCESS | 5440 | 11:46:20 INFO - PROCESS | 5440 | Cycle 1(1): loaded http://localhost:37024/tests/dromaeo/cssquery-ext.html (next: http://localhost:37024/tests/dromaeo/cssquery-jquery.html) 11:46:21 INFO - PROCESS | 5440 | RSS: Main: 169582592 11:46:21 INFO - PROCESS | 5440 | 11:49:23 INFO - PROCESS | 5440 | Cycle 1(1): loaded http://localhost:37024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37024/tests/dromaeo/cssquery-mootools.html) 11:49:23 INFO - PROCESS | 5440 | RSS: Main: 172310528 11:49:23 INFO - PROCESS | 5440 | 11:52:25 INFO - PROCESS | 5440 | Cycle 1(1): loaded http://localhost:37024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37024/tests/dromaeo/cssquery-prototype.html) 11:52:26 INFO - PROCESS | 5440 | RSS: Main: 166895616 11:52:26 INFO - PROCESS | 5440 | 11:55:28 INFO - PROCESS | 5440 | Cycle 1(1): loaded http://localhost:37024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37024/tests/dromaeo/cssquery-yui.html) 11:55:29 INFO - PROCESS | 5440 | RSS: Main: 169172992 11:55:29 INFO - PROCESS | 5440 | 11:58:31 INFO - PROCESS | 5440 | Cycle 1(1): loaded http://localhost:37024/tests/dromaeo/cssquery-yui.html (next: http://localhost:37024/tests/dromaeo/cssquery-dojo.html) 11:58:32 INFO - PROCESS | 5440 | RSS: Main: 171008000 11:58:32 INFO - PROCESS | 5440 | 11:58:32 INFO - PROCESS | 5440 | __start_tp_report 11:58:32 INFO - PROCESS | 5440 | _x_x_mozilla_page_load 11:58:32 INFO - PROCESS | 5440 | _x_x_mozilla_page_load_details 11:58:32 INFO - PROCESS | 5440 | |i|pagename|runs| 11:58:32 INFO - PROCESS | 5440 | |0;dojo.html;3080.2145452909504;3087.7221050105486;3107.0678796361094;3126.953095703565;3143.339898621289;5402.243685883979;5482.5613950883935;5493.862653433666;5518.724063796804;5570.6657600543895;5394.298741163643;5408.296921400222;5412.621116521845;5445.537129344;5468.699221542814;4885.951140488594;4925.064237794808;5010;5065;5095.6942583444925;792.2286983069664;4973.726445045521;5049.3435853339015;5077.822276220333;5094.261332106842;4904.828331008415;4952.603791696692;4966.453690094087;4977.054359671669;5022.070916880389;4827.710337379734;4995.475475075101;4997.025580011899;5007.899842003139;5052.343195384577;4851.248056551241;4895.437024742129;4924.975375123137;4946.431160416562;4952.603791696655;5426.077566813651;5476.3702174250075;5517.144842549411;5520.66875987442;5525.861853453655;5811.6803575803315;5836.970815145897;5915.674637894914;5932.228810254683;5938.198343223653;5894.351621321651;5949.702514874282;5949.791757288517;5954.374790646963;5999.190109335227;5489.1217405214975;5523.364813046471;5525.060739674265;5527.115661494182;5527.668339899578;5866.6480011199465;5968.701564921824;6022.909656355158;6039.698015099228;6073.544484163705;5814.447627475383;5820.88358232833;5828.504577110993;5838.970805146032;5839.620424672467;5837.29952405714;5840.415958404211;5892.705364731746;5900.085486749561;5915.911261331084;5619.213310136584;5686.516646085046;5702.914456283159;5728;5741.110127930177;5743.4543718346695;5815.534757219412;5827.096799996008;5839.474447299764;5897.026990546512;4478.529754375809;4481.7983190756495;4484.080763443486;4494.12364588902;4524.411826462539;3888.319544079775;3911.100446897173;3940.3498422760495;3997.7401468904427;4055;5568.638038527482;5627.971860140755;5646.6612003279115;5687.232223649837;5699.287589051369;5867;5925.851853703692;5932.703364831741;5941.168236446901;5942.078977758454;5481.479259470344;5557.805476808373;5586.860328491739;5601.271834661468;5601.439856014447;5024.598032157419;5033;5033.5721463676;5068.265101560253;5074.619403544675;6046.2139921809885;6079.422454866781;6079.483243924316;6088.1476593276975;6093.268807743099;5666.575006874418;5785.247917770663;5790.681512516852;5803.564732645153;5909.6158749681135;6010.278766548042;6011.398860114128;6051.4553690168095;6080.3615620361;6132.693365331805;5711.571632127524;5742.741576629145;5762.366139724711;5776.451237132465;5778.624389414675;5718.228039214653;5740.339860916049;5808.30300363959;5828.679422631626;5850.297964244318;5705.087186050212;5747.683877386784;5751.597388182787;5766.509846663081;5793.391693872083;5675.063614503726;5735.369109398046;5750.913736293875;5752.194692743103;5763.51010164124;5563.248961390161;5609.775608975595;5655.236543066633;5666.979943610189;5696.857578560569;5745.569082318759;5747.4252574742195;5781.075027995501;5805.883882322414;5813.418658134153;5613.578981576316;5645.209670646031;5646.124850648156;5652.463016013472;5677.574181936288 11:58:32 INFO - PROCESS | 5440 | |1;ext.html;551.9117335448997;596.3261514488629;607.5473772039828;609.5885277437729;629.0218709906094;42594;44273.33589996149;44290.77854610731;44369;44384;44332.77833610828;44455;44551.331730024074;44570.777146114306;44959.550404495945;8960.95519522403;9102.362834601581;9104.36269461138;9112.134347237003;9138.497382643953;9026.954865225698;9081.18269355758;9107.499087550183;9119.407238529475;9123.68067117651;9171.449713017208;9216.539173041354;9217.539123043854;9217.631294748202;9244.537773111351;9134.908650913505;9147.634094636207;9162.541872906328;9174.954125229364;9206.953965230197;8949.328800339936;9001.23489503393;9059.094090590954;9067.954660226722;9081.273498120201;41693.583064169274;41765.79117104426;41854.1629167418;41890.58109418897;41990.37014444786;3534.1341371363924;3599.4960705501253;3653.8173091345325;3685.7972811495356;3691.298653255873;32880.83559582211;33549;33812;33942.32115357679;34712.30575388478;4291.227579035773;4301.720388174758;4433.6009759121835;4507.256302710049;4584.564466375689;377938;380366;380695.1930480715;381777;383863;60688.66212358274;60695.393046069854;60708.392916070276;60971;61298.38701613016;36266.63733362633;37261;37409.25181496409;39088.413673794916;65167.34832651613;17897.910510447364;17906.462806115836;18036.368727094752;18073.45779626613;18091.276348945896;13137.211767293993;13139.934300328438;13280;13282.136661116996;13284.402201900937;20021.699674504893;20246.291379801638;20288.289909853083;20335.491612709506;20459.693104603444;7184.49708520409;7330.8900366494545;7375.483716139926;7403.296686814744;7548.320651141424;950.3157726436955;1011.8279892418307;1020.5407566595062;1044.2533588484118;1178.5816035307514;33041.66958330386;33411;33661.495077573854;33765.155871103416;34001.48997765035;1121.4785124916953;1147.9196456247982;1192;1207.9033677305795;1241.919275247106;16936.153192340334;17565.736513952303;17643.55728401935;17681.198542313465;17691.911540442215;646387;647308;650862;652360;654969;60870.39129608647;61626.38373616206;62385.68807155935;62398.68800655968;62644;1368.3568722700315;1368.644152520332;1371.3760239091189;1374.8281464816898;1390.5619729785085;29777.17017093887;31807.204819879687;32034.519482208252;32074.518882217253;32335.67664323421;54514;54515.72742136264;54830;54865.45134548763;54928;505756;505979;507775;507857;509275;25268.873655631603;25460.618090729025;25465.61801573015;27945.161645150678;28585;48966.64519006762;49278.31987716026;49295;49606.751966239935;49888.25167622416;39202.41196381999;42770.57229427666;43107.78446107749;43683;44009.77995110004;42585.19622454049;42833.357499636906;43080.56919430891;43138.35292470553;43169.784151079046;38257.80871095627;41505.1698966025;42275;42369;45615.049497054264;30594.388112238077;33940;34358.82820585881;34480.827595862866;34562.654373455945;28664;28947.85526072356;29892.55161172541;29942.700572993992;29968 11:58:32 INFO - PROCESS | 5440 | |2;jquery.html;391.59078762692985;393.8365578285012;394.9052227465409;396.72625888137173;425.7743396000119;13968.44126234952;18576;18797;20304.69542956857;20371.796282037176;19097.331593394232;19178;19541.120649570767;19898;19927.701084483746;5528.668279903199;5709.314882214129;5838.766449342022;5877.8824423511505;5940.019896717058;5829.183914252008;5853.560982926277;5854.912176317359;6115.877682446348;6572.145621069279;6529.2817790043055;6548.607083574977;6603.339666033382;6723.966380168117;6738.898916516257;6532.3467653234775;6595.53831231814;6672.699728512229;6775.186977562699;6792.388685018347;4960.082384758795;5237.528622423962;5909.497692696083;5939.346671866091;5945.494632956161;14090;14122.858771412257;15304.005239659498;23694.881525592435;24248.393790155213;2422.63660450932;2521.71000334962;2591.5853463445947;2613.294410509152;2838.4181242845375;10344.120749736281;10377.84433233502;10414.323069000491;10421.166306695446;10572.36565806054;1860.6650802855481;1864.673682105626;1875.1468082022648;1909.1530565909702;1990.9004549772453;74411.62794185994;79528.60235698785;81195;81403.59298203471;83273;10774.78450430987;10859.83710244347;11715.297082175097;11815.586454474053;12205;15603.063816171067;15629.531114066596;15653.452129175424;15675.372985080468;15719.528414147593;7796.532208067534;8060.637271322805;8162.836743265101;8279.875801862976;8485.830283394298;7529.623518824037;7660.233976602407;7733.574653394117;7778.338841198448;7826.9608651957515;4765.523447655276;4777.808887644455;4787.664863459594;4816.686915350561;4908.435529914034;1970.1823743146433;1994.4914046917943;2009.437357539891;2037.113855472874;2121.11973530986;959.1799011844912;1019.898010198989;1033.8087453821067;1077.3408950216578;1099.4722533183956;19584.902075489532;20099.899500502404;20300.898495507725;20427.693584596243;20498.487537811674;998.2413365842012;1011.2011510906449;1020.4234607446768;1026.312370711625;1082.1991726122612;10635.52140153695;11131.387773672526;11228.494717737722;11318.151138664633;11357.659270221906;305314;508183;515337;516780;519730;93848;99552.5022374898;100104.49947750215;101421;101765.49117254367;1011.6509804117568;1023.7338292043974;1053.7207639975413;1056.0653821368144;1076.5048077884262;17666.911665442105;17936.103194840467;18291;18502.629947400706;18615.668997507317;37138.62861371352;43422.78288608537;44329;44748.77625611851;44958.325625116304;47573.76213118912;57929.710351447975;58543;58777.4122258772;59195.408045918986;8691.869621955802;8751.606177721891;8770.956145219234;8825.161609647073;8922.776930576787;9969.40183588987;13424.664383390493;13863.514776982756;13919.512817051354;14015;11729.472173752372;11760.353180574808;11840.111991600492;11860.94069529647;11920.165588408729;11564.884351156381;11605.88394116048;11785.175037747274;11785.764284714429;11850.822237666614;11610.303381797119;11623.18637695387;12201.877981220074;12229.266244025386;12236.816447753468;8565.767716242364;8648.524331161847;8719.91280087191;8730.519821409884;8820.11798820113;10952.561897524329;11752.23610465317;11941.522339106687;12005.459754310903;12173 11:58:32 INFO - PROCESS | 5440 | |3;mootools.html;1482.8591283828036;1509.6376869551307;1662.3766087717106;1815.4553633909832;1819.1177279019682;7745.690172393098;8124.228198321158;8373.53945532997;8651.43765655232;8676.132386761321;8706.956465217665;8727.301815854733;8793.91206087939;8798.384113112084;8801.603927823247;2360.693109895711;2402.939926501834;2403.6995375578053;2404.3147702904675;2404.807615390773;2343.4727186383097;2347.225415612852;2384.2727967969763;2384.523095380922;2395.580773364663;2282.3038973113275;2288.6109361408517;2290.438842483594;2330.2776139396756;2355.646653002055;2258.1419060756807;2276.9089236430523;2278.2823410625683;2284.3832165315357;2284.4403121235237;2271.568402003614;2273.545290941818;2278.624027035537;2278.646809744492;2280.9885950570306;8794.076621954666;8848;8914.86627700585;8932.106789321017;8953;5140.331756871583;5201.271821944931;5226.686398816083;5267.26258323835;5275.894482110375;3319.4854797506423;3343.882964096245;3518.5074089627474;3523.066387407339;3529.8058606776617;1129.8644162700527;1155.4800339847018;1168.0830548019765;1171.1509155862018;1175.7001964499084;12034.217775844541;12058.336791476466;12066.879331206663;12075.335856527887;12077.033837292995;4421.911561768811;4657.208274593328;4752.5485078917445;4765.547273009059;4798.616110711135;9994.950025249827;10078.59685612582;10160.08559229673;10162.441065741456;10183.643572474928;5316.867078323073;5330.626856120112;5347.358317001985;5350;5354.41101478837;4332.176886391576;4795.280707893844;4928.457869634337;4946.554810067111;4968.056069346885;3934.6852251819787;4007.198560287954;4081.5306239782212;4112.074783173822;4123.463949686581;1288.3558220889556;1330.7604631166482;1338.5047532413068;1340.6581321762887;1345.1256683156028;821.6302663801314;832.3216578488513;863.1023735315201;885.291766586728;899.9325050621098;5348.759305831247;5782.2194003808945;5837.416258374214;5856.531477481792;5886.1465087562065;450.7791182320639;452.07550559106704;459.2009902769158;462.2649986521447;462.2673063194874;3749.081475038633;3780.640839120279;3788.3749181385315;3789.1285004449132;3806.257779732981;10098.545565449573;10525.84211236832;10677.412742299093;10801;10824.512896919658;10610.787784244272;10643.680689579325;10650.094741947021;10679.679609611723;10686.73283167927;7859.135495095535;8053;8086.150954149847;8109.10799812032;8131.308838748772;5830.854228644148;5839.065749480063;5839.211706419749;5845.941540584539;5905.852353691193;9927.205823533955;10041.447720375449;10067.093961543496;10121.746956326151;10127.392356458637;10105.797884042131;10127.746806329606;10132.544035518567;10424.68725938223;10487.580496780043;7809.180036096128;7907;7946.841063178819;8039.316658083894;8203.097659257357;8665.480071195749;8688.13118688126;8718.91281087181;8740.21338079576;8838;7600.923990760021;7756.015112348469;7855.293023627901;7902.881456778268;7950.801229969297;7557.508761930457;7617.65720542588;7668.539887606761;7675.923240767521;7805.297523222937;7081.114860642419;7095.645217739196;7130.215676275502;7132.893006605009;7247.746328878464;4739.976300118477;4795.112904112751;4925.138100832269;4965.205567109245;4993.15116430215;4886.582890961581;5134;5137.8972420550635;5184.196449550326;5254.5533629641905 11:58:32 INFO - PROCESS | 5440 | |4;prototype.html;323.93035497368066;325.9837008149592;332.3021654525497;339.27056827820184;339.8453703564878;5606.691631960241;5694.6867922264255;5697.857553561158;5716.685582292972;5717.428257174281;5578.24693666355;5604.187392828037;5604.887902241952;5630.774769009235;5648.632838865481;4161.565484191744;4241.618254357108;4296.162248361571;4320.56794320567;4330.112326972979;4303.311470164775;4312.676549258818;4315.395844581761;4339.1104823511105;4348.239058164824;4274.700770946035;4308.3968244445805;4310.288802347609;4322.632576231008;4324.6107850293465;4220.978895105535;4259.148170365924;4277.550857160016;4282.400463935051;4310.504292006397;3728.3475391806323;3744.0452684565535;3757.1922036761953;3768.566614839301;3774.3960966245268;5372.865678358034;5452.2094296327205;5474.91787623186;5482.753276102585;5502.779888804483;4805.327254184417;4958.132326842788;4963.106640804654;4971.527704868032;4977.900441991176;5833.679147646878;5864.325602555718;5886;5886.381929897385;5893.941060589425;4168.791560421967;4197.454330936958;4201.117765269297;4201.978990105061;4211.43145675333;5872.500837428824;5953.821385358447;6025.216721826178;6075.817725468243;6135.478484328837;4249.87250382489;4274.508431530352;4274.764887931132;4283.7001409901;4314.913701725948;4266.104118135227;4303.07483890965;4328.242557552416;4359.934600980988;4363.345498175236;4759.524047595212;4883.951160488421;4922.803087876517;4969.428515720739;4970.84351436833;5877.941220587825;5903.881922361615;5908.615939963888;5945.227120474311;5958.6424814511265;1520.2626726037863;1538.130956009851;1540.2683725230427;1542.537238828347;1542.7840102385676;970.96601618943;985.9852102218473;997.7455748784158;1008.5965613754557;1013.8023085498257;5596.097326908871;5598.888022239533;5617.915731264035;5628.887422251532;5636.943630563724;5886.70418536771;5887.764489420375;5902.704864756745;5905.793297234576;5926.466618004314;5401.459854014567;5584;5692.48767610917;5734.082546792577;5753.510951569164;3205.6313523945046;3209.138699554253;3211.51827225918;3217.5978002749657;3229.2088438332758;6064.211652485149;6144.754209831646;6155.861165684362;6187.257529096537;6222.097795819581;6150.815475535741;6163.568550201443;6169.290531588835;6177.980633195472;6194.938050619527;6073.6659483727935;6174.5060395168275;6202.658853763086;6215.228659831926;6228.314885362606;5898.64608123514;5972.7448540546375;5992.221011268507;5992.910106348496;6057.454829065406;5903.91144132847;5909.193133261666;5936.168936349001;5954.553408494467;6012.819615411545;6055.455858755989;6079.878402432015;6124.203853499017;6207.565470417027;6261.935470969855;4101.7744024077765;4104.281750693676;4130.938035929404;4134.627883490501;4155.1897380010605;6080.3615620361;6084.513238940963;6102.6574153686115;6114.877702445837;6120.785772497941;5705.486506214461;5865.94134058654;5869.207656966255;5879.323877753942;5892.322382926019;5814.709264536672;5848.298204215522;5902.7343769531335;5913.793017244376;5917.940820591739;5516.282883225155;5538.723063846872;5734.283214598176;5745.683987380734;5889.352171261072;5835.766569337179;5903.645781252967;5915.864591766371;5919.017129261745;5933.605602683452;5573.414791446839;5716.79991200306;5769.9711501442225;5780;5786.566007549366 11:58:32 INFO - PROCESS | 5440 | |5;yui.html;719.8560287942413;764.9426293028023;768.0284440183169;768.1281745219175;865.3250464637581;13868.930655346721;14579.781303280433;14615.342309596053;14630.41478340865;14730.63173420665;13071.803922941164;13810.1713897166;13811.585652430418;13833.377498012589;13840.446382144728;677.2110491277656;801.7314199743093;812.1188510466151;827.7268501394556;836.5900708652747;832.5129799067553;838.681301105579;839.2949922065463;839.6935118681668;839.9664013439456;871.1201686296822;871.2115535440437;873.9825203495926;874.1913729799942;875.1904488348284;850.1795767084731;851.4635779458932;855.0765173612483;856.6616186606287;857.8713193021034;630.2185290240116;633.8573820890309;635.4598591197491;637.0762394527907;637.7353398339684;14419.78370324446;14538.781918271234;14540.345684444119;14541.054831435922;14549.854501454956;14334.283285835667;14733.116013039253;14937.327820248007;15312.004719693296;15519.224038798127;12661.366931653472;12702.364881755968;12705.809412858815;12778.61664150077;12919.026328862394;3874.4575759393706;3897.162110146332;3931.828449161781;3954.62431069048;4002.9799851000557;75598.62200688961;77221;77363;79395.6030219851;79690.60154699248;11863.762724745457;11867.940660296816;11986.640400787815;12003.819942700866;12314.692132696755;22698.659520107212;22859.428514287276;22882.542349153257;22988.195413160458;22993;8832.293416526663;8906.242969347548;8920.776980575538;8928.687495937611;9386.20217281525;4988.401391833003;4999.175136102575;5069.340985671839;5138.049460849755;5166.844994650167;3394.8642054318043;3403.7957722536726;3485.3900567400606;3487.8604855805484;3530.293941211768;637.6333608175318;648.6497291462557;649.7076315657878;650.4926157597082;671.2549070531705;733.7065173930471;745.7352639812897;764.4992529892929;766.9003029606228;799.7960520067346;9175.357724959322;10337.948310258551;10375.377477351383;10677.57289708403;10849.546562262738;714.8463080437731;745.8023623739605;752.3642522068843;754.6641744423679;770.3529035610003;5192.766325515361;5231.398389185217;5290.285811415487;5324.733763311819;5343.7060961647485;72205.6389718048;72792;123418.38290808488;126186.36906815408;127257.3637131827;88570.11429885747;89587.55206223927;91031;102987.48506257421;103476.48261758794;76730.23269767342;87077.5646121778;88259.55870220608;89093.55453222692;91468.54265728629;10136.74658133523;10762.946185269024;10779;10930.890691093306;10981.780364392827;51078.23382649338;51507.74246128745;51750.482495176075;51933.740331298104;52117.61235519831;68331;74779.51322920642;75553.24446755683;76070;76819.61590192013;13314.46742130304;13530.18818870871;13674.179549227078;13706.454024420633;13718.588442346347;14707;15030.549083527512;15074.6985060296;15149.318280677617;15569.688606227586;13765.655858603215;13774.931125344308;14062.226577538333;14302.427902883768;14795.926020369829;13028.283444410648;14304.284785760878;14761.704765904837;14820;15109.622259443162;11801.940990295338;12420.130590858553;12738.617841464771;14011;14533.781993269899;10753;10811.891881081088;10948.56205751761;10984.505697243803;11351.886481135083;11800.645980620251;11976.16166868311;12009.279443233434;12269.447874845475;12351 11:58:32 INFO - PROCESS | 5440 | __end_tp_report 11:58:32 INFO - PROCESS | 5440 | __start_cc_report 11:58:32 INFO - PROCESS | 5440 | _x_x_mozilla_cycle_collect,352 11:58:32 INFO - PROCESS | 5440 | __end_cc_report 11:58:32 INFO - PROCESS | 5440 | __startTimestamp1468954712163__endTimestamp 11:58:32 INFO - PROCESS | 5440 | 11:58:32 INFO - PROCESS | 5440 | ------- Summary: start ------- 11:58:32 INFO - PROCESS | 5440 | Number of tests: 6 11:58:32 INFO - PROCESS | 5440 | 11:58:32 INFO - PROCESS | 5440 | [#0] dojo.html Cycles:165 Average:5418.13 Median:5675.06 stddev:724.63 (12.8%) stddev-sans-first:703.26 11:58:32 INFO - PROCESS | 5440 | Values: 3080.2 3087.7 3107.1 3127.0 3143.3 5402.2 5482.6 5493.9 5518.7 5570.7 5394.3 5408.3 5412.6 5445.5 5468.7 4886.0 4925.1 5010.0 5065.0 5095.7 792.2 4973.7 5049.3 5077.8 5094.3 4904.8 4952.6 4966.5 4977.1 5022.1 4827.7 4995.5 4997.0 5007.9 5052.3 4851.2 4895.4 4925.0 4946.4 4952.6 5426.1 5476.4 5517.1 5520.7 5525.9 5811.7 5837.0 5915.7 5932.2 5938.2 5894.4 5949.7 5949.8 5954.4 5999.2 5489.1 5523.4 5525.1 5527.1 5527.7 5866.6 5968.7 6022.9 6039.7 6073.5 5814.4 5820.9 5828.5 5839.0 5839.6 5837.3 5840.4 5892.7 5900.1 5915.9 5619.2 5686.5 5702.9 5728.0 5741.1 5743.5 5815.5 5827.1 5839.5 5897.0 4478.5 4481.8 4484.1 4494.1 4524.4 3888.3 3911.1 3940.3 3997.7 4055.0 5568.6 5628.0 5646.7 5687.2 5699.3 5867.0 5925.9 5932.7 5941.2 5942.1 5481.5 5557.8 5586.9 5601.3 5601.4 5024.6 5033.0 5033.6 5068.3 5074.6 6046.2 6079.4 6079.5 6088.1 6093.3 5666.6 5785.2 5790.7 5803.6 5909.6 6010.3 6011.4 6051.5 6080.4 6132.7 5711.6 5742.7 5762.4 5776.5 5778.6 5718.2 5740.3 5808.3 5828.7 5850.3 5705.1 5747.7 5751.6 5766.5 5793.4 5675.1 5735.4 5750.9 5752.2 5763.5 5563.2 5609.8 5655.2 5667.0 5696.9 5745.6 5747.4 5781.1 5805.9 5813.4 5613.6 5645.2 5646.1 5652.5 5677.6 11:58:32 INFO - PROCESS | 5440 | 11:58:32 INFO - PROCESS | 5440 | [#1] ext.html Cycles:180 Average:66371.31 Median:42801.96 stddev:139899.19 (326.9%) stddev-sans-first:140204.36 11:58:32 INFO - PROCESS | 5440 | Values: 551.9 596.3 607.5 609.6 629.0 42594.0 44273.3 44290.8 44369.0 44384.0 44332.8 44455.0 44551.3 44570.8 44959.6 8961.0 9102.4 9104.4 9112.1 9138.5 9027.0 9081.2 9107.5 9119.4 9123.7 9171.4 9216.5 9217.5 9217.6 9244.5 9134.9 9147.6 9162.5 9175.0 9207.0 8949.3 9001.2 9059.1 9068.0 9081.3 41693.6 41765.8 41854.2 41890.6 41990.4 3534.1 3599.5 3653.8 3685.8 3691.3 32880.8 33549.0 33812.0 33942.3 34712.3 4291.2 4301.7 4433.6 4507.3 4584.6 377938.0 380366.0 380695.2 381777.0 383863.0 60688.7 60695.4 60708.4 60971.0 61298.4 36266.6 37261.0 37409.3 39088.4 65167.3 17897.9 17906.5 18036.4 18073.5 18091.3 13137.2 13139.9 13280.0 13282.1 13284.4 20021.7 20246.3 20288.3 20335.5 20459.7 7184.5 7330.9 7375.5 7403.3 7548.3 950.3 1011.8 1020.5 1044.3 1178.6 33041.7 33411.0 33661.5 33765.2 34001.5 1121.5 1147.9 1192.0 1207.9 1241.9 16936.2 17565.7 17643.6 17681.2 17691.9 646387.0 647308.0 650862.0 652360.0 654969.0 60870.4 61626.4 62385.7 62398.7 62644.0 1368.4 1368.6 1371.4 1374.8 1390.6 29777.2 31807.2 32034.5 32074.5 32335.7 54514.0 54515.7 54830.0 54865.5 54928.0 505756.0 505979.0 507775.0 507857.0 509275.0 25268.9 25460.6 25465.6 27945.2 28585.0 48966.6 49278.3 49295.0 49606.8 49888.3 39202.4 42770.6 43107.8 43683.0 44009.8 42585.2 42833.4 43080.6 43138.4 43169.8 38257.8 41505.2 42275.0 42369.0 45615.0 30594.4 33940.0 34358.8 34480.8 34562.7 28664.0 28947.9 29892.6 29942.7 29968.0 11:58:32 INFO - PROCESS | 5440 | 11:58:32 INFO - PROCESS | 5440 | [#2] jquery.html Cycles:180 Average:28728.88 Median:20463.09 stddev:79477.16 (388.4%) stddev-sans-first:79671.64 11:58:32 INFO - PROCESS | 5440 | Values: 391.6 393.8 394.9 396.7 425.8 13968.4 18576.0 18797.0 20304.7 20371.8 19097.3 19178.0 19541.1 19898.0 19927.7 5528.7 5709.3 5838.8 5877.9 5940.0 5829.2 5853.6 5854.9 6115.9 6572.1 6529.3 6548.6 6603.3 6724.0 6738.9 6532.3 6595.5 6672.7 6775.2 6792.4 4960.1 5237.5 5909.5 5939.3 5945.5 14090.0 14122.9 15304.0 23694.9 24248.4 2422.6 2521.7 2591.6 2613.3 2838.4 10344.1 10377.8 10414.3 10421.2 10572.4 1860.7 1864.7 1875.1 1909.2 1990.9 74411.6 79528.6 81195.0 81403.6 83273.0 10774.8 10859.8 11715.3 11815.6 12205.0 15603.1 15629.5 15653.5 15675.4 15719.5 7796.5 8060.6 8162.8 8279.9 8485.8 7529.6 7660.2 7733.6 7778.3 7827.0 4765.5 4777.8 4787.7 4816.7 4908.4 1970.2 1994.5 2009.4 2037.1 2121.1 959.2 1019.9 1033.8 1077.3 1099.5 19584.9 20099.9 20300.9 20427.7 20498.5 998.2 1011.2 1020.4 1026.3 1082.2 10635.5 11131.4 11228.5 11318.2 11357.7 305314.0 508183.0 515337.0 516780.0 519730.0 93848.0 99552.5 100104.5 101421.0 101765.5 1011.7 1023.7 1053.7 1056.1 1076.5 17666.9 17936.1 18291.0 18502.6 18615.7 37138.6 43422.8 44329.0 44748.8 44958.3 47573.8 57929.7 58543.0 58777.4 59195.4 8691.9 8751.6 8771.0 8825.2 8922.8 9969.4 13424.7 13863.5 13919.5 14015.0 11729.5 11760.4 11840.1 11860.9 11920.2 11564.9 11605.9 11785.2 11785.8 11850.8 11610.3 11623.2 12201.9 12229.3 12236.8 8565.8 8648.5 8719.9 8730.5 8820.1 10952.6 11752.2 11941.5 12005.5 12173.0 11:58:32 INFO - PROCESS | 5440 | 11:58:32 INFO - PROCESS | 5440 | [#3] mootools.html Cycles:180 Average:5752.26 Median:4698.59 stddev:3274.31 (69.7%) stddev-sans-first:3267.78 11:58:32 INFO - PROCESS | 5440 | Values: 1482.9 1509.6 1662.4 1815.5 1819.1 7745.7 8124.2 8373.5 8651.4 8676.1 8707.0 8727.3 8793.9 8798.4 8801.6 2360.7 2402.9 2403.7 2404.3 2404.8 2343.5 2347.2 2384.3 2384.5 2395.6 2282.3 2288.6 2290.4 2330.3 2355.6 2258.1 2276.9 2278.3 2284.4 2284.4 2271.6 2273.5 2278.6 2278.6 2281.0 8794.1 8848.0 8914.9 8932.1 8953.0 5140.3 5201.3 5226.7 5267.3 5275.9 3319.5 3343.9 3518.5 3523.1 3529.8 1129.9 1155.5 1168.1 1171.2 1175.7 12034.2 12058.3 12066.9 12075.3 12077.0 4421.9 4657.2 4752.5 4765.5 4798.6 9995.0 10078.6 10160.1 10162.4 10183.6 5316.9 5330.6 5347.4 5350.0 5354.4 4332.2 4795.3 4928.5 4946.6 4968.1 3934.7 4007.2 4081.5 4112.1 4123.5 1288.4 1330.8 1338.5 1340.7 1345.1 821.6 832.3 863.1 885.3 899.9 5348.8 5782.2 5837.4 5856.5 5886.1 450.8 452.1 459.2 462.3 462.3 3749.1 3780.6 3788.4 3789.1 3806.3 10098.5 10525.8 10677.4 10801.0 10824.5 10610.8 10643.7 10650.1 10679.7 10686.7 7859.1 8053.0 8086.2 8109.1 8131.3 5830.9 5839.1 5839.2 5845.9 5905.9 9927.2 10041.4 10067.1 10121.7 10127.4 10105.8 10127.7 10132.5 10424.7 10487.6 7809.2 7907.0 7946.8 8039.3 8203.1 8665.5 8688.1 8718.9 8740.2 8838.0 7600.9 7756.0 7855.3 7902.9 7950.8 7557.5 7617.7 7668.5 7675.9 7805.3 7081.1 7095.6 7130.2 7132.9 7247.7 4740.0 4795.1 4925.1 4965.2 4993.2 4886.6 5134.0 5137.9 5184.2 5254.6 11:58:32 INFO - PROCESS | 5440 | 11:58:32 INFO - PROCESS | 5440 | [#4] prototype.html Cycles:180 Average:4921.97 Median:5633.86 stddev:1455.95 (25.8%) stddev-sans-first:1418.55 11:58:32 INFO - PROCESS | 5440 | Values: 323.9 326.0 332.3 339.3 339.8 5606.7 5694.7 5697.9 5716.7 5717.4 5578.2 5604.2 5604.9 5630.8 5648.6 4161.6 4241.6 4296.2 4320.6 4330.1 4303.3 4312.7 4315.4 4339.1 4348.2 4274.7 4308.4 4310.3 4322.6 4324.6 4221.0 4259.1 4277.6 4282.4 4310.5 3728.3 3744.0 3757.2 3768.6 3774.4 5372.9 5452.2 5474.9 5482.8 5502.8 4805.3 4958.1 4963.1 4971.5 4977.9 5833.7 5864.3 5886.0 5886.4 5893.9 4168.8 4197.5 4201.1 4202.0 4211.4 5872.5 5953.8 6025.2 6075.8 6135.5 4249.9 4274.5 4274.8 4283.7 4314.9 4266.1 4303.1 4328.2 4359.9 4363.3 4759.5 4884.0 4922.8 4969.4 4970.8 5877.9 5903.9 5908.6 5945.2 5958.6 1520.3 1538.1 1540.3 1542.5 1542.8 971.0 986.0 997.7 1008.6 1013.8 5596.1 5598.9 5617.9 5628.9 5636.9 5886.7 5887.8 5902.7 5905.8 5926.5 5401.5 5584.0 5692.5 5734.1 5753.5 3205.6 3209.1 3211.5 3217.6 3229.2 6064.2 6144.8 6155.9 6187.3 6222.1 6150.8 6163.6 6169.3 6178.0 6194.9 6073.7 6174.5 6202.7 6215.2 6228.3 5898.6 5972.7 5992.2 5992.9 6057.5 5903.9 5909.2 5936.2 5954.6 6012.8 6055.5 6079.9 6124.2 6207.6 6261.9 4101.8 4104.3 4130.9 4134.6 4155.2 6080.4 6084.5 6102.7 6114.9 6120.8 5705.5 5865.9 5869.2 5879.3 5892.3 5814.7 5848.3 5902.7 5913.8 5917.9 5516.3 5538.7 5734.3 5745.7 5889.4 5835.8 5903.6 5915.9 5919.0 5933.6 5573.4 5716.8 5770.0 5780.0 5786.6 11:58:32 INFO - PROCESS | 5440 | 11:58:32 INFO - PROCESS | 5440 | [#5] yui.html Cycles:180 Average:20644.98 Median:3914.50 stddev:29146.30 (744.6%) stddev-sans-first:29189.67 11:58:32 INFO - PROCESS | 5440 | Values: 719.9 764.9 768.0 768.1 865.3 13868.9 14579.8 14615.3 14630.4 14730.6 13071.8 13810.2 13811.6 13833.4 13840.4 677.2 801.7 812.1 827.7 836.6 832.5 838.7 839.3 839.7 840.0 871.1 871.2 874.0 874.2 875.2 850.2 851.5 855.1 856.7 857.9 630.2 633.9 635.5 637.1 637.7 14419.8 14538.8 14540.3 14541.1 14549.9 14334.3 14733.1 14937.3 15312.0 15519.2 12661.4 12702.4 12705.8 12778.6 12919.0 3874.5 3897.2 3931.8 3954.6 4003.0 75598.6 77221.0 77363.0 79395.6 79690.6 11863.8 11867.9 11986.6 12003.8 12314.7 22698.7 22859.4 22882.5 22988.2 22993.0 8832.3 8906.2 8920.8 8928.7 9386.2 4988.4 4999.2 5069.3 5138.0 5166.8 3394.9 3403.8 3485.4 3487.9 3530.3 637.6 648.6 649.7 650.5 671.3 733.7 745.7 764.5 766.9 799.8 9175.4 10337.9 10375.4 10677.6 10849.5 714.8 745.8 752.4 754.7 770.4 5192.8 5231.4 5290.3 5324.7 5343.7 72205.6 72792.0 123418.4 126186.4 127257.4 88570.1 89587.6 91031.0 102987.5 103476.5 76730.2 87077.6 88259.6 89093.6 91468.5 10136.7 10762.9 10779.0 10930.9 10981.8 51078.2 51507.7 51750.5 51933.7 52117.6 68331.0 74779.5 75553.2 76070.0 76819.6 13314.5 13530.2 13674.2 13706.5 13718.6 14707.0 15030.5 15074.7 15149.3 15569.7 13765.7 13774.9 14062.2 14302.4 14795.9 13028.3 14304.3 14761.7 14820.0 15109.6 11801.9 12420.1 12738.6 14011.0 14533.8 10753.0 10811.9 10948.6 10984.5 11351.9 11800.6 11976.2 12009.3 12269.4 12351.0 11:58:32 INFO - PROCESS | 5440 | -------- Summary: end -------- 11:58:32 INFO - PROCESS | 5440 | 11:58:33 INFO - TEST-INFO | 5440: exit 0 11:58:33 INFO - TEST-OK | dromaeo_css | took 1134814ms 11:58:33 INFO - TEST-START | kraken 11:58:33 INFO - operating with platform_type : linux_ 11:58:33 INFO - Initialising browser for kraken test... 11:58:33 INFO - TEST-INFO | started process 5687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw0eTxG/profile http://localhost:37024/getInfo.html) 11:58:40 INFO - PROCESS | 5687 | __metrics Screen width/height:1600/1200 11:58:40 INFO - PROCESS | 5687 | colorDepth:24 11:58:40 INFO - PROCESS | 5687 | Browser inner width/height: 1024/697 11:58:40 INFO - PROCESS | 5687 | __metrics 11:58:41 ERROR - PROCESS | 5687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:58:42 INFO - TEST-INFO | 5687: exit 0 11:58:42 INFO - Browser initialized. 11:58:42 INFO - Running cycle 1/1 for kraken test... 11:58:42 INFO - TEST-INFO | started process 5807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw0eTxG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:54 INFO - PROCESS | 5807 | RSS: Main: 168386560 11:58:54 INFO - PROCESS | 5807 | 11:58:56 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37024/tests/kraken/driver.html?testName=audio-beat-detection) 11:58:57 INFO - PROCESS | 5807 | RSS: Main: 173445120 11:58:57 INFO - PROCESS | 5807 | 11:59:00 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37024/tests/kraken/driver.html?testName=audio-dft) 11:59:00 INFO - PROCESS | 5807 | RSS: Main: 172859392 11:59:00 INFO - PROCESS | 5807 | 11:59:03 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37024/tests/kraken/driver.html?testName=audio-fft) 11:59:04 INFO - PROCESS | 5807 | RSS: Main: 167088128 11:59:04 INFO - PROCESS | 5807 | 11:59:06 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37024/tests/kraken/driver.html?testName=audio-oscillator) 11:59:07 INFO - PROCESS | 5807 | RSS: Main: 168288256 11:59:07 INFO - PROCESS | 5807 | 11:59:09 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:59:10 INFO - PROCESS | 5807 | RSS: Main: 168771584 11:59:10 INFO - PROCESS | 5807 | 11:59:13 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37024/tests/kraken/driver.html?testName=imaging-darkroom) 11:59:13 INFO - PROCESS | 5807 | RSS: Main: 169631744 11:59:13 INFO - PROCESS | 5807 | 11:59:17 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37024/tests/kraken/driver.html?testName=imaging-desaturate) 11:59:17 INFO - PROCESS | 5807 | RSS: Main: 167149568 11:59:17 INFO - PROCESS | 5807 | 11:59:20 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37024/tests/kraken/driver.html?testName=json-parse-financial) 11:59:21 INFO - PROCESS | 5807 | RSS: Main: 168280064 11:59:21 INFO - PROCESS | 5807 | 11:59:22 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:59:23 INFO - PROCESS | 5807 | RSS: Main: 168398848 11:59:23 INFO - PROCESS | 5807 | 11:59:25 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37024/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:59:25 INFO - PROCESS | 5807 | RSS: Main: 168706048 11:59:25 INFO - PROCESS | 5807 | 11:59:27 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:59:28 INFO - PROCESS | 5807 | RSS: Main: 168779776 11:59:28 INFO - PROCESS | 5807 | 11:59:31 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:59:31 INFO - PROCESS | 5807 | RSS: Main: 169250816 11:59:31 INFO - PROCESS | 5807 | 11:59:34 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:59:35 INFO - PROCESS | 5807 | RSS: Main: 169189376 11:59:35 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | Cycle 1(1): loaded http://localhost:37024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37024/tests/kraken/driver.html?testName=ai-astar) 11:59:37 INFO - PROCESS | 5807 | RSS: Main: 169754624 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | __start_tp_report 11:59:37 INFO - PROCESS | 5807 | _x_x_mozilla_page_load 11:59:37 INFO - PROCESS | 5807 | _x_x_mozilla_page_load_details 11:59:37 INFO - PROCESS | 5807 | |i|pagename|runs| 11:59:37 INFO - PROCESS | 5807 | |0;ai-astar;102;114;107;110;112;113;115;111;112;111 11:59:37 INFO - PROCESS | 5807 | |1;audio-beat-detection;155;118;148;166;121;144;142;121;175;116 11:59:37 INFO - PROCESS | 5807 | |2;audio-dft;161;162;162;163;163;164;173;161;162;162 11:59:37 INFO - PROCESS | 5807 | |3;audio-fft;75;75;75;155;77;75;75;80;157;76 11:59:37 INFO - PROCESS | 5807 | |4;audio-oscillator;90;84;152;84;84;85;145;83;85;139 11:59:37 INFO - PROCESS | 5807 | |5;imaging-gaussian-blur;117;117;117;118;118;118;118;117;118;118 11:59:37 INFO - PROCESS | 5807 | |6;imaging-darkroom;148;148;148;148;148;147;147;147;147;147 11:59:37 INFO - PROCESS | 5807 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;96;96 11:59:37 INFO - PROCESS | 5807 | |8;json-parse-financial;52;52;55;52;51;54;51;51;57;52 11:59:37 INFO - PROCESS | 5807 | |9;json-stringify-tinderbox;61;62;60;61;62;61;61;61;62;62 11:59:37 INFO - PROCESS | 5807 | |10;stanford-crypto-aes;76;76;75;76;75;74;78;76;79;76 11:59:37 INFO - PROCESS | 5807 | |11;stanford-crypto-ccm;125;128;128;123;130;129;127;124;161;120 11:59:37 INFO - PROCESS | 5807 | |12;stanford-crypto-pbkdf2;155;157;161;156;155;153;158;159;158;160 11:59:37 INFO - PROCESS | 5807 | |13;stanford-crypto-sha256-iterative;64;63;68;64;63;64;68;61;65;62 11:59:37 INFO - PROCESS | 5807 | __end_tp_report 11:59:37 INFO - PROCESS | 5807 | __start_cc_report 11:59:37 INFO - PROCESS | 5807 | _x_x_mozilla_cycle_collect,930 11:59:37 INFO - PROCESS | 5807 | __end_cc_report 11:59:37 INFO - PROCESS | 5807 | __startTimestamp1468954777181__endTimestamp 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | ------- Summary: start ------- 11:59:37 INFO - PROCESS | 5807 | Number of tests: 14 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.77 (3.4%) stddev-sans-first:2.35 11:59:37 INFO - PROCESS | 5807 | Values: 102.0 114.0 107.0 110.0 112.0 113.0 115.0 111.0 112.0 111.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:146.00 stddev:21.05 (14.4%) stddev-sans-first:21.67 11:59:37 INFO - PROCESS | 5807 | Values: 155.0 118.0 148.0 166.0 121.0 144.0 142.0 121.0 175.0 116.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.50 stddev:3.53 (2.2%) stddev-sans-first:3.64 11:59:37 INFO - PROCESS | 5807 | Values: 161.0 162.0 162.0 163.0 163.0 164.0 173.0 161.0 162.0 162.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.00 stddev:33.77 (45.0%) stddev-sans-first:35.25 11:59:37 INFO - PROCESS | 5807 | Values: 75.0 75.0 75.0 155.0 77.0 75.0 75.0 80.0 157.0 76.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:84.00 stddev:29.37 (35.0%) stddev-sans-first:30.76 11:59:37 INFO - PROCESS | 5807 | Values: 90.0 84.0 152.0 84.0 84.0 85.0 145.0 83.0 85.0 139.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:59:37 INFO - PROCESS | 5807 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:59:37 INFO - PROCESS | 5807 | Values: 148.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:59:37 INFO - PROCESS | 5807 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:2.00 (3.9%) stddev-sans-first:2.11 11:59:37 INFO - PROCESS | 5807 | Values: 52.0 52.0 55.0 52.0 51.0 54.0 51.0 51.0 57.0 52.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 11:59:37 INFO - PROCESS | 5807 | Values: 61.0 62.0 60.0 61.0 62.0 61.0 61.0 61.0 62.0 62.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:1.45 (1.9%) stddev-sans-first:1.54 11:59:37 INFO - PROCESS | 5807 | Values: 76.0 76.0 75.0 76.0 75.0 74.0 78.0 76.0 79.0 76.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:128.00 stddev:11.48 (9.0%) stddev-sans-first:12.06 11:59:37 INFO - PROCESS | 5807 | Values: 125.0 128.0 128.0 123.0 130.0 129.0 127.0 124.0 161.0 120.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:158.00 stddev:2.49 (1.6%) stddev-sans-first:2.51 11:59:37 INFO - PROCESS | 5807 | Values: 155.0 157.0 161.0 156.0 155.0 153.0 158.0 159.0 158.0 160.0 11:59:37 INFO - PROCESS | 5807 | 11:59:37 INFO - PROCESS | 5807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:2.30 (3.6%) stddev-sans-first:2.44 11:59:37 INFO - PROCESS | 5807 | Values: 64.0 63.0 68.0 64.0 63.0 64.0 68.0 61.0 65.0 62.0 11:59:37 INFO - PROCESS | 5807 | -------- Summary: end -------- 11:59:37 INFO - PROCESS | 5807 | 11:59:38 INFO - TEST-INFO | 5807: exit 0 11:59:38 INFO - TEST-OK | kraken | took 65923ms 11:59:38 INFO - SUITE-END | took 1200s 11:59:39 INFO - Completed test suite (00:20:01) 11:59:39 INFO - javascript benchmark 11:59:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7385.564278779987, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.2145452909504, 3087.7221050105486, 3107.0678796361094, 3126.953095703565, 3143.339898621289, 5402.243685883979, 5482.5613950883935, 5493.862653433666, 5518.724063796804, 5570.6657600543895, 5394.298741163643, 5408.296921400222, 5412.621116521845, 5445.537129344, 5468.699221542814, 4885.951140488594, 4925.064237794808, 5010.0, 5065.0, 5095.6942583444925, 792.2286983069664, 4973.726445045521, 5049.3435853339015, 5077.822276220333, 5094.261332106842, 4904.828331008415, 4952.603791696692, 4966.453690094087, 4977.054359671669, 5022.070916880389, 4827.710337379734, 4995.475475075101, 4997.025580011899, 5007.899842003139, 5052.343195384577, 4851.248056551241, 4895.437024742129, 4924.975375123137, 4946.431160416562, 4952.603791696655, 5426.077566813651, 5476.3702174250075, 5517.144842549411, 5520.66875987442, 5525.861853453655, 5811.6803575803315, 5836.970815145897, 5915.674637894914, 5932.228810254683, 5938.198343223653, 5894.351621321651, 5949.702514874282, 5949.791757288517, 5954.374790646963, 5999.190109335227, 5489.1217405214975, 5523.364813046471, 5525.060739674265, 5527.115661494182, 5527.668339899578, 5866.6480011199465, 5968.701564921824, 6022.909656355158, 6039.698015099228, 6073.544484163705, 5814.447627475383, 5820.88358232833, 5828.504577110993, 5838.970805146032, 5839.620424672467, 5837.29952405714, 5840.415958404211, 5892.705364731746, 5900.085486749561, 5915.911261331084, 5619.213310136584, 5686.516646085046, 5702.914456283159, 5728.0, 5741.110127930177, 5743.4543718346695, 5815.534757219412, 5827.096799996008, 5839.474447299764, 5897.026990546512, 4478.529754375809, 4481.7983190756495, 4484.080763443486, 4494.12364588902, 4524.411826462539, 3888.319544079775, 3911.100446897173, 3940.3498422760495, 3997.7401468904427, 4055.0, 5568.638038527482, 5627.971860140755, 5646.6612003279115, 5687.232223649837, 5699.287589051369, 5867.0, 5925.851853703692, 5932.703364831741, 5941.168236446901, 5942.078977758454, 5481.479259470344, 5557.805476808373, 5586.860328491739, 5601.271834661468, 5601.439856014447, 5024.598032157419, 5033.0, 5033.5721463676, 5068.265101560253, 5074.619403544675, 6046.2139921809885, 6079.422454866781, 6079.483243924316, 6088.1476593276975, 6093.268807743099, 5666.575006874418, 5785.247917770663, 5790.681512516852, 5803.564732645153, 5909.6158749681135, 6010.278766548042, 6011.398860114128, 6051.4553690168095, 6080.3615620361, 6132.693365331805, 5711.571632127524, 5742.741576629145, 5762.366139724711, 5776.451237132465, 5778.624389414675, 5718.228039214653, 5740.339860916049, 5808.30300363959, 5828.679422631626, 5850.297964244318, 5705.087186050212, 5747.683877386784, 5751.597388182787, 5766.509846663081, 5793.391693872083, 5675.063614503726, 5735.369109398046, 5750.913736293875, 5752.194692743103, 5763.51010164124, 5563.248961390161, 5609.775608975595, 5655.236543066633, 5666.979943610189, 5696.857578560569, 5745.569082318759, 5747.4252574742195, 5781.075027995501, 5805.883882322414, 5813.418658134153, 5613.578981576316, 5645.209670646031, 5646.124850648156, 5652.463016013472, 5677.574181936288], "value": 5370.131007851906, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.9117335448997, 596.3261514488629, 607.5473772039828, 609.5885277437729, 629.0218709906094, 42594.0, 44273.33589996149, 44290.77854610731, 44369.0, 44384.0, 44332.77833610828, 44455.0, 44551.331730024074, 44570.777146114306, 44959.550404495945, 8960.95519522403, 9102.362834601581, 9104.36269461138, 9112.134347237003, 9138.497382643953, 9026.954865225698, 9081.18269355758, 9107.499087550183, 9119.407238529475, 9123.68067117651, 9171.449713017208, 9216.539173041354, 9217.539123043854, 9217.631294748202, 9244.537773111351, 9134.908650913505, 9147.634094636207, 9162.541872906328, 9174.954125229364, 9206.953965230197, 8949.328800339936, 9001.23489503393, 9059.094090590954, 9067.954660226722, 9081.273498120201, 41693.583064169274, 41765.79117104426, 41854.1629167418, 41890.58109418897, 41990.37014444786, 3534.1341371363924, 3599.4960705501253, 3653.8173091345325, 3685.7972811495356, 3691.298653255873, 32880.83559582211, 33549.0, 33812.0, 33942.32115357679, 34712.30575388478, 4291.227579035773, 4301.720388174758, 4433.6009759121835, 4507.256302710049, 4584.564466375689, 377938.0, 380366.0, 380695.1930480715, 381777.0, 383863.0, 60688.66212358274, 60695.393046069854, 60708.392916070276, 60971.0, 61298.38701613016, 36266.63733362633, 37261.0, 37409.25181496409, 39088.413673794916, 65167.34832651613, 17897.910510447364, 17906.462806115836, 18036.368727094752, 18073.45779626613, 18091.276348945896, 13137.211767293993, 13139.934300328438, 13280.0, 13282.136661116996, 13284.402201900937, 20021.699674504893, 20246.291379801638, 20288.289909853083, 20335.491612709506, 20459.693104603444, 7184.49708520409, 7330.8900366494545, 7375.483716139926, 7403.296686814744, 7548.320651141424, 950.3157726436955, 1011.8279892418307, 1020.5407566595062, 1044.2533588484118, 1178.5816035307514, 33041.66958330386, 33411.0, 33661.495077573854, 33765.155871103416, 34001.48997765035, 1121.4785124916953, 1147.9196456247982, 1192.0, 1207.9033677305795, 1241.919275247106, 16936.153192340334, 17565.736513952303, 17643.55728401935, 17681.198542313465, 17691.911540442215, 646387.0, 647308.0, 650862.0, 652360.0, 654969.0, 60870.39129608647, 61626.38373616206, 62385.68807155935, 62398.68800655968, 62644.0, 1368.3568722700315, 1368.644152520332, 1371.3760239091189, 1374.8281464816898, 1390.5619729785085, 29777.17017093887, 31807.204819879687, 32034.519482208252, 32074.518882217253, 32335.67664323421, 54514.0, 54515.72742136264, 54830.0, 54865.45134548763, 54928.0, 505756.0, 505979.0, 507775.0, 507857.0, 509275.0, 25268.873655631603, 25460.618090729025, 25465.61801573015, 27945.161645150678, 28585.0, 48966.64519006762, 49278.31987716026, 49295.0, 49606.751966239935, 49888.25167622416, 39202.41196381999, 42770.57229427666, 43107.78446107749, 43683.0, 44009.77995110004, 42585.19622454049, 42833.357499636906, 43080.56919430891, 43138.35292470553, 43169.784151079046, 38257.80871095627, 41505.1698966025, 42275.0, 42369.0, 45615.049497054264, 30594.388112238077, 33940.0, 34358.82820585881, 34480.827595862866, 34562.654373455945, 28664.0, 28947.85526072356, 29892.55161172541, 29942.700572993992, 29968.0], "value": 20630.44505044087, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.59078762692985, 393.8365578285012, 394.9052227465409, 396.72625888137173, 425.7743396000119, 13968.44126234952, 18576.0, 18797.0, 20304.69542956857, 20371.796282037176, 19097.331593394232, 19178.0, 19541.120649570767, 19898.0, 19927.701084483746, 5528.668279903199, 5709.314882214129, 5838.766449342022, 5877.8824423511505, 5940.019896717058, 5829.183914252008, 5853.560982926277, 5854.912176317359, 6115.877682446348, 6572.145621069279, 6529.2817790043055, 6548.607083574977, 6603.339666033382, 6723.966380168117, 6738.898916516257, 6532.3467653234775, 6595.53831231814, 6672.699728512229, 6775.186977562699, 6792.388685018347, 4960.082384758795, 5237.528622423962, 5909.497692696083, 5939.346671866091, 5945.494632956161, 14090.0, 14122.858771412257, 15304.005239659498, 23694.881525592435, 24248.393790155213, 2422.63660450932, 2521.71000334962, 2591.5853463445947, 2613.294410509152, 2838.4181242845375, 10344.120749736281, 10377.84433233502, 10414.323069000491, 10421.166306695446, 10572.36565806054, 1860.6650802855481, 1864.673682105626, 1875.1468082022648, 1909.1530565909702, 1990.9004549772453, 74411.62794185994, 79528.60235698785, 81195.0, 81403.59298203471, 83273.0, 10774.78450430987, 10859.83710244347, 11715.297082175097, 11815.586454474053, 12205.0, 15603.063816171067, 15629.531114066596, 15653.452129175424, 15675.372985080468, 15719.528414147593, 7796.532208067534, 8060.637271322805, 8162.836743265101, 8279.875801862976, 8485.830283394298, 7529.623518824037, 7660.233976602407, 7733.574653394117, 7778.338841198448, 7826.9608651957515, 4765.523447655276, 4777.808887644455, 4787.664863459594, 4816.686915350561, 4908.435529914034, 1970.1823743146433, 1994.4914046917943, 2009.437357539891, 2037.113855472874, 2121.11973530986, 959.1799011844912, 1019.898010198989, 1033.8087453821067, 1077.3408950216578, 1099.4722533183956, 19584.902075489532, 20099.899500502404, 20300.898495507725, 20427.693584596243, 20498.487537811674, 998.2413365842012, 1011.2011510906449, 1020.4234607446768, 1026.312370711625, 1082.1991726122612, 10635.52140153695, 11131.387773672526, 11228.494717737722, 11318.151138664633, 11357.659270221906, 305314.0, 508183.0, 515337.0, 516780.0, 519730.0, 93848.0, 99552.5022374898, 100104.49947750215, 101421.0, 101765.49117254367, 1011.6509804117568, 1023.7338292043974, 1053.7207639975413, 1056.0653821368144, 1076.5048077884262, 17666.911665442105, 17936.103194840467, 18291.0, 18502.629947400706, 18615.668997507317, 37138.62861371352, 43422.78288608537, 44329.0, 44748.77625611851, 44958.325625116304, 47573.76213118912, 57929.710351447975, 58543.0, 58777.4122258772, 59195.408045918986, 8691.869621955802, 8751.606177721891, 8770.956145219234, 8825.161609647073, 8922.776930576787, 9969.40183588987, 13424.664383390493, 13863.514776982756, 13919.512817051354, 14015.0, 11729.472173752372, 11760.353180574808, 11840.111991600492, 11860.94069529647, 11920.165588408729, 11564.884351156381, 11605.88394116048, 11785.175037747274, 11785.764284714429, 11850.822237666614, 11610.303381797119, 11623.18637695387, 12201.877981220074, 12229.266244025386, 12236.816447753468, 8565.767716242364, 8648.524331161847, 8719.91280087191, 8730.519821409884, 8820.11798820113, 10952.561897524329, 11752.23610465317, 11941.522339106687, 12005.459754310903, 12173.0], "value": 9392.481248311811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.8591283828036, 1509.6376869551307, 1662.3766087717106, 1815.4553633909832, 1819.1177279019682, 7745.690172393098, 8124.228198321158, 8373.53945532997, 8651.43765655232, 8676.132386761321, 8706.956465217665, 8727.301815854733, 8793.91206087939, 8798.384113112084, 8801.603927823247, 2360.693109895711, 2402.939926501834, 2403.6995375578053, 2404.3147702904675, 2404.807615390773, 2343.4727186383097, 2347.225415612852, 2384.2727967969763, 2384.523095380922, 2395.580773364663, 2282.3038973113275, 2288.6109361408517, 2290.438842483594, 2330.2776139396756, 2355.646653002055, 2258.1419060756807, 2276.9089236430523, 2278.2823410625683, 2284.3832165315357, 2284.4403121235237, 2271.568402003614, 2273.545290941818, 2278.624027035537, 2278.646809744492, 2280.9885950570306, 8794.076621954666, 8848.0, 8914.86627700585, 8932.106789321017, 8953.0, 5140.331756871583, 5201.271821944931, 5226.686398816083, 5267.26258323835, 5275.894482110375, 3319.4854797506423, 3343.882964096245, 3518.5074089627474, 3523.066387407339, 3529.8058606776617, 1129.8644162700527, 1155.4800339847018, 1168.0830548019765, 1171.1509155862018, 1175.7001964499084, 12034.217775844541, 12058.336791476466, 12066.879331206663, 12075.335856527887, 12077.033837292995, 4421.911561768811, 4657.208274593328, 4752.5485078917445, 4765.547273009059, 4798.616110711135, 9994.950025249827, 10078.59685612582, 10160.08559229673, 10162.441065741456, 10183.643572474928, 5316.867078323073, 5330.626856120112, 5347.358317001985, 5350.0, 5354.41101478837, 4332.176886391576, 4795.280707893844, 4928.457869634337, 4946.554810067111, 4968.056069346885, 3934.6852251819787, 4007.198560287954, 4081.5306239782212, 4112.074783173822, 4123.463949686581, 1288.3558220889556, 1330.7604631166482, 1338.5047532413068, 1340.6581321762887, 1345.1256683156028, 821.6302663801314, 832.3216578488513, 863.1023735315201, 885.291766586728, 899.9325050621098, 5348.759305831247, 5782.2194003808945, 5837.416258374214, 5856.531477481792, 5886.1465087562065, 450.7791182320639, 452.07550559106704, 459.2009902769158, 462.2649986521447, 462.2673063194874, 3749.081475038633, 3780.640839120279, 3788.3749181385315, 3789.1285004449132, 3806.257779732981, 10098.545565449573, 10525.84211236832, 10677.412742299093, 10801.0, 10824.512896919658, 10610.787784244272, 10643.680689579325, 10650.094741947021, 10679.679609611723, 10686.73283167927, 7859.135495095535, 8053.0, 8086.150954149847, 8109.10799812032, 8131.308838748772, 5830.854228644148, 5839.065749480063, 5839.211706419749, 5845.941540584539, 5905.852353691193, 9927.205823533955, 10041.447720375449, 10067.093961543496, 10121.746956326151, 10127.392356458637, 10105.797884042131, 10127.746806329606, 10132.544035518567, 10424.68725938223, 10487.580496780043, 7809.180036096128, 7907.0, 7946.841063178819, 8039.316658083894, 8203.097659257357, 8665.480071195749, 8688.13118688126, 8718.91281087181, 8740.21338079576, 8838.0, 7600.923990760021, 7756.015112348469, 7855.293023627901, 7902.881456778268, 7950.801229969297, 7557.508761930457, 7617.65720542588, 7668.539887606761, 7675.923240767521, 7805.297523222937, 7081.114860642419, 7095.645217739196, 7130.215676275502, 7132.893006605009, 7247.746328878464, 4739.976300118477, 4795.112904112751, 4925.138100832269, 4965.205567109245, 4993.15116430215, 4886.582890961581, 5134.0, 5137.8972420550635, 5184.196449550326, 5254.5533629641905], "value": 4531.033007528311, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.93035497368066, 325.9837008149592, 332.3021654525497, 339.27056827820184, 339.8453703564878, 5606.691631960241, 5694.6867922264255, 5697.857553561158, 5716.685582292972, 5717.428257174281, 5578.24693666355, 5604.187392828037, 5604.887902241952, 5630.774769009235, 5648.632838865481, 4161.565484191744, 4241.618254357108, 4296.162248361571, 4320.56794320567, 4330.112326972979, 4303.311470164775, 4312.676549258818, 4315.395844581761, 4339.1104823511105, 4348.239058164824, 4274.700770946035, 4308.3968244445805, 4310.288802347609, 4322.632576231008, 4324.6107850293465, 4220.978895105535, 4259.148170365924, 4277.550857160016, 4282.400463935051, 4310.504292006397, 3728.3475391806323, 3744.0452684565535, 3757.1922036761953, 3768.566614839301, 3774.3960966245268, 5372.865678358034, 5452.2094296327205, 5474.91787623186, 5482.753276102585, 5502.779888804483, 4805.327254184417, 4958.132326842788, 4963.106640804654, 4971.527704868032, 4977.900441991176, 5833.679147646878, 5864.325602555718, 5886.0, 5886.381929897385, 5893.941060589425, 4168.791560421967, 4197.454330936958, 4201.117765269297, 4201.978990105061, 4211.43145675333, 5872.500837428824, 5953.821385358447, 6025.216721826178, 6075.817725468243, 6135.478484328837, 4249.87250382489, 4274.508431530352, 4274.764887931132, 4283.7001409901, 4314.913701725948, 4266.104118135227, 4303.07483890965, 4328.242557552416, 4359.934600980988, 4363.345498175236, 4759.524047595212, 4883.951160488421, 4922.803087876517, 4969.428515720739, 4970.84351436833, 5877.941220587825, 5903.881922361615, 5908.615939963888, 5945.227120474311, 5958.6424814511265, 1520.2626726037863, 1538.130956009851, 1540.2683725230427, 1542.537238828347, 1542.7840102385676, 970.96601618943, 985.9852102218473, 997.7455748784158, 1008.5965613754557, 1013.8023085498257, 5596.097326908871, 5598.888022239533, 5617.915731264035, 5628.887422251532, 5636.943630563724, 5886.70418536771, 5887.764489420375, 5902.704864756745, 5905.793297234576, 5926.466618004314, 5401.459854014567, 5584.0, 5692.48767610917, 5734.082546792577, 5753.510951569164, 3205.6313523945046, 3209.138699554253, 3211.51827225918, 3217.5978002749657, 3229.2088438332758, 6064.211652485149, 6144.754209831646, 6155.861165684362, 6187.257529096537, 6222.097795819581, 6150.815475535741, 6163.568550201443, 6169.290531588835, 6177.980633195472, 6194.938050619527, 6073.6659483727935, 6174.5060395168275, 6202.658853763086, 6215.228659831926, 6228.314885362606, 5898.64608123514, 5972.7448540546375, 5992.221011268507, 5992.910106348496, 6057.454829065406, 5903.91144132847, 5909.193133261666, 5936.168936349001, 5954.553408494467, 6012.819615411545, 6055.455858755989, 6079.878402432015, 6124.203853499017, 6207.565470417027, 6261.935470969855, 4101.7744024077765, 4104.281750693676, 4130.938035929404, 4134.627883490501, 4155.1897380010605, 6080.3615620361, 6084.513238940963, 6102.6574153686115, 6114.877702445837, 6120.785772497941, 5705.486506214461, 5865.94134058654, 5869.207656966255, 5879.323877753942, 5892.322382926019, 5814.709264536672, 5848.298204215522, 5902.7343769531335, 5913.793017244376, 5917.940820591739, 5516.282883225155, 5538.723063846872, 5734.283214598176, 5745.683987380734, 5889.352171261072, 5835.766569337179, 5903.645781252967, 5915.864591766371, 5919.017129261745, 5933.605602683452, 5573.414791446839, 5716.79991200306, 5769.9711501442225, 5780.0, 5786.566007549366], "value": 4454.4257715861195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.8560287942413, 764.9426293028023, 768.0284440183169, 768.1281745219175, 865.3250464637581, 13868.930655346721, 14579.781303280433, 14615.342309596053, 14630.41478340865, 14730.63173420665, 13071.803922941164, 13810.1713897166, 13811.585652430418, 13833.377498012589, 13840.446382144728, 677.2110491277656, 801.7314199743093, 812.1188510466151, 827.7268501394556, 836.5900708652747, 832.5129799067553, 838.681301105579, 839.2949922065463, 839.6935118681668, 839.9664013439456, 871.1201686296822, 871.2115535440437, 873.9825203495926, 874.1913729799942, 875.1904488348284, 850.1795767084731, 851.4635779458932, 855.0765173612483, 856.6616186606287, 857.8713193021034, 630.2185290240116, 633.8573820890309, 635.4598591197491, 637.0762394527907, 637.7353398339684, 14419.78370324446, 14538.781918271234, 14540.345684444119, 14541.054831435922, 14549.854501454956, 14334.283285835667, 14733.116013039253, 14937.327820248007, 15312.004719693296, 15519.224038798127, 12661.366931653472, 12702.364881755968, 12705.809412858815, 12778.61664150077, 12919.026328862394, 3874.4575759393706, 3897.162110146332, 3931.828449161781, 3954.62431069048, 4002.9799851000557, 75598.62200688961, 77221.0, 77363.0, 79395.6030219851, 79690.60154699248, 11863.762724745457, 11867.940660296816, 11986.640400787815, 12003.819942700866, 12314.692132696755, 22698.659520107212, 22859.428514287276, 22882.542349153257, 22988.195413160458, 22993.0, 8832.293416526663, 8906.242969347548, 8920.776980575538, 8928.687495937611, 9386.20217281525, 4988.401391833003, 4999.175136102575, 5069.340985671839, 5138.049460849755, 5166.844994650167, 3394.8642054318043, 3403.7957722536726, 3485.3900567400606, 3487.8604855805484, 3530.293941211768, 637.6333608175318, 648.6497291462557, 649.7076315657878, 650.4926157597082, 671.2549070531705, 733.7065173930471, 745.7352639812897, 764.4992529892929, 766.9003029606228, 799.7960520067346, 9175.357724959322, 10337.948310258551, 10375.377477351383, 10677.57289708403, 10849.546562262738, 714.8463080437731, 745.8023623739605, 752.3642522068843, 754.6641744423679, 770.3529035610003, 5192.766325515361, 5231.398389185217, 5290.285811415487, 5324.733763311819, 5343.7060961647485, 72205.6389718048, 72792.0, 123418.38290808488, 126186.36906815408, 127257.3637131827, 88570.11429885747, 89587.55206223927, 91031.0, 102987.48506257421, 103476.48261758794, 76730.23269767342, 87077.5646121778, 88259.55870220608, 89093.55453222692, 91468.54265728629, 10136.74658133523, 10762.946185269024, 10779.0, 10930.890691093306, 10981.780364392827, 51078.23382649338, 51507.74246128745, 51750.482495176075, 51933.740331298104, 52117.61235519831, 68331.0, 74779.51322920642, 75553.24446755683, 76070.0, 76819.61590192013, 13314.46742130304, 13530.18818870871, 13674.179549227078, 13706.454024420633, 13718.588442346347, 14707.0, 15030.549083527512, 15074.6985060296, 15149.318280677617, 15569.688606227586, 13765.655858603215, 13774.931125344308, 14062.226577538333, 14302.427902883768, 14795.926020369829, 13028.283444410648, 14304.284785760878, 14761.704765904837, 14820.0, 15109.622259443162, 11801.940990295338, 12420.130590858553, 12738.617841464771, 14011.0, 14533.781993269899, 10753.0, 10811.891881081088, 10948.56205751761, 10984.505697243803, 11351.886481135083, 11800.645980620251, 11976.16166868311, 12009.279443233434, 12269.447874845475, 12351.0], "value": 7726.706982006928, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 107.0, 110.0, 112.0, 113.0, 115.0, 111.0, 112.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 148.0, 166.0, 121.0, 144.0, 142.0, 121.0, 175.0, 116.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 163.0, 164.0, 173.0, 161.0, 162.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 155.0, 77.0, 75.0, 75.0, 80.0, 157.0, 76.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 152.0, 84.0, 84.0, 85.0, 145.0, 83.0, 85.0, 139.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 55.0, 52.0, 51.0, 54.0, 51.0, 51.0, 57.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 75.0, 74.0, 78.0, 76.0, 79.0, 76.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 128.0, 128.0, 123.0, 130.0, 129.0, 127.0, 124.0, 161.0, 120.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 161.0, 156.0, 155.0, 153.0, 158.0, 159.0, 158.0, 160.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 68.0, 64.0, 63.0, 64.0, 68.0, 61.0, 65.0, 62.0], "value": 64.2, "unit": "score"}]}]} 11:59:39 INFO - Return code: 0 11:59:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:59:39 ERROR - # TBPL SUCCESS # 11:59:39 INFO - Running post-action listener: _resource_record_post_action 11:59:39 INFO - ##### 11:59:39 INFO - ##### Finished run-tests step (success) 11:59:39 INFO - ##### 11:59:39 INFO - Running post-run listener: _resource_record_post_run 11:59:39 INFO - Total resource usage - Wall time: 1218s; CPU: 13.0%; Read bytes: 495616; Write bytes: 299286528; Read time: 76; Write time: 1878868 11:59:39 INFO - TinderboxPrint: CPU usage
13.4% 11:59:39 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 76 11:59:39 INFO - TinderboxPrint: I/O write bytes / time
299,286,528 / 1,878,868 11:59:39 INFO - TinderboxPrint: CPU idle
8,413.3 (86.6%) 11:59:39 INFO - TinderboxPrint: CPU user
1,212.9 (12.5%) 11:59:39 INFO - TinderboxPrint: Swap in / out
0 / 0 11:59:39 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 643072; Read time: 0; Write time: 196 11:59:39 INFO - run-tests - Wall time: 1202s; CPU: 13.0%; Read bytes: 491520; Write bytes: 297902080; Read time: 52; Write time: 1878652 11:59:40 INFO - Running post-run listener: _upload_blobber_files 11:59:40 INFO - Blob upload gear active. 11:59:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:59:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:59:40 INFO - (blobuploader) - INFO - Open directory for files ... 11:59:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:59:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:00:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:24 INFO - (blobuploader) - INFO - Done attempting. 12:00:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:00:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:00:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:25 INFO - (blobuploader) - INFO - Done attempting. 12:00:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:00:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:00:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:26 INFO - (blobuploader) - INFO - Done attempting. 12:00:26 INFO - (blobuploader) - INFO - Iteration through files over. 12:00:26 INFO - Return code: 0 12:00:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:00:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:00:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87e44c3989349eab0174f7c8d945fdd3350ac644dc817ceb06e70a965b0211b4d7c7ecbc8bab02c4c32574cccec1cb87ee3bd15b61a9a706de9c0c59568d8955", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91783d445b02131aa4041113d28aa24881e09cb642835da2b7a6e1109422d68f55ac635943511a741451216d74c99563a4f55079bd981fc292fc1984dfc22532", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/347865d3593ec4e60ff696ac1af26db2e4638c2f5bf419fe748c01d13223cd56ee9d3cc1e6c9e53d045de89e219a2406b42225cac15da6a9d84ec45cf1bcf059"} 12:00:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:00:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:00:26 INFO - Contents: 12:00:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87e44c3989349eab0174f7c8d945fdd3350ac644dc817ceb06e70a965b0211b4d7c7ecbc8bab02c4c32574cccec1cb87ee3bd15b61a9a706de9c0c59568d8955", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91783d445b02131aa4041113d28aa24881e09cb642835da2b7a6e1109422d68f55ac635943511a741451216d74c99563a4f55079bd981fc292fc1984dfc22532", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/347865d3593ec4e60ff696ac1af26db2e4638c2f5bf419fe748c01d13223cd56ee9d3cc1e6c9e53d045de89e219a2406b42225cac15da6a9d84ec45cf1bcf059"} 12:00:26 INFO - Running post-run listener: copy_logs_to_upload_dir 12:00:26 INFO - Copying logs to upload dir... 12:00:26 INFO - mkdir: /builds/slave/test/build/upload/logs 12:00:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1330.111576 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2016-07-19 12:00:26.352157) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 12:00:26.355279) ========= 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=33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888 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/Firefox/sha512/87e44c3989349eab0174f7c8d945fdd3350ac644dc817ceb06e70a965b0211b4d7c7ecbc8bab02c4c32574cccec1cb87ee3bd15b61a9a706de9c0c59568d8955", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91783d445b02131aa4041113d28aa24881e09cb642835da2b7a6e1109422d68f55ac635943511a741451216d74c99563a4f55079bd981fc292fc1984dfc22532", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/347865d3593ec4e60ff696ac1af26db2e4638c2f5bf419fe748c01d13223cd56ee9d3cc1e6c9e53d045de89e219a2406b42225cac15da6a9d84ec45cf1bcf059"} build_url:https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/BDzLcYPxQHC8DXEmOUNLgQ/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/Firefox/sha512/87e44c3989349eab0174f7c8d945fdd3350ac644dc817ceb06e70a965b0211b4d7c7ecbc8bab02c4c32574cccec1cb87ee3bd15b61a9a706de9c0c59568d8955", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91783d445b02131aa4041113d28aa24881e09cb642835da2b7a6e1109422d68f55ac635943511a741451216d74c99563a4f55079bd981fc292fc1984dfc22532", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/347865d3593ec4e60ff696ac1af26db2e4638c2f5bf419fe748c01d13223cd56ee9d3cc1e6c9e53d045de89e219a2406b42225cac15da6a9d84ec45cf1bcf059"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 12:00:26.379806) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:00:26.380108) ========= 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=33d5923976266a1c518c4bf7000001ab-1468953494.185767-1668463888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:00:26.463787) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 12:00:26.464113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 12:00:26.464411) ========= ========= Total master_lag: 0.25 =========