builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1468462472.99 results: success (0) buildid: 20160713173001 builduid: 79e950d3dff84e988b9ab4bda7c9991c revision: 31cab0ba8bbf1d88b08abeae45bcdf317645355a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:32.992059) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:32.992519) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:32.993002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:33.028119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:33.028506) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 19:14:33-- 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% 113M=0s 2016-07-13 19:14:33 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162838 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:33.205751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:33.206107) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019287 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:33.255677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 19:14:33.256025) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 31cab0ba8bbf1d88b08abeae45bcdf317645355a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 31cab0ba8bbf1d88b08abeae45bcdf317645355a --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=652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 19:14:33,788 truncating revision to first 12 chars 2016-07-13 19:14:33,788 Setting DEBUG logging. 2016-07-13 19:14:33,788 attempt 1/10 2016-07-13 19:14:33,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/31cab0ba8bbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 19:14:35,022 unpacking tar archive at: fx-team-31cab0ba8bbf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.578590 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 19:14:34.848811) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:34.849296) ========= script_repo_revision: 31cab0ba8bbf1d88b08abeae45bcdf317645355a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:34.849725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:34.849995) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 19:14:34.863824) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-13 19:14:34.864110) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:14:35 INFO - MultiFileLogger online at 20160713 19:14:35 in /builds/slave/test 19:14:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:14:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:14:35 INFO - {'append_to_log': False, 19:14:35 INFO - 'base_work_dir': '/builds/slave/test', 19:14:35 INFO - 'blob_upload_branch': 'Fx-Team', 19:14:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:14:35 INFO - 'branch': 'Fx-Team', 19:14:35 INFO - 'buildbot_json_path': 'buildprops.json', 19:14:35 INFO - 'config_files': ('talos/linux_config.py',), 19:14:35 INFO - 'default_actions': ('clobber', 19:14:35 INFO - 'read-buildbot-config', 19:14:35 INFO - 'download-and-extract', 19:14:35 INFO - 'populate-webroot', 19:14:35 INFO - 'create-virtualenv', 19:14:35 INFO - 'install', 19:14:35 INFO - 'run-tests'), 19:14:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:14:35 INFO - 'download_minidump_stackwalk': True, 19:14:35 INFO - 'download_symbols': 'ondemand', 19:14:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:14:35 INFO - 'tooltool.py': '/tools/tooltool.py', 19:14:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:14:35 INFO - '/tools/misc-python/virtualenv.py')}, 19:14:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:14:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:14:35 INFO - 'installer_path': 'installer.exe', 19:14:35 INFO - 'log_level': 'info', 19:14:35 INFO - 'log_name': 'talos', 19:14:35 INFO - 'log_to_console': True, 19:14:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:14:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:14:35 INFO - 'opt_config_files': (), 19:14:35 INFO - 'pip_index': False, 19:14:35 INFO - 'sps_profile': False, 19:14:35 INFO - 'sps_profile_interval': 0, 19:14:35 INFO - 'suite': 'dromaeojs-e10s', 19:14:35 INFO - 'system_bits': '32', 19:14:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:14:35 INFO - 'title': 'talos-linux64-ix-046', 19:14:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:14:35 INFO - 'use_talos_json': True, 19:14:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:14:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:14:35 INFO - 'work_dir': 'build'} 19:14:35 INFO - ##### 19:14:35 INFO - ##### Running clobber step. 19:14:35 INFO - ##### 19:14:35 INFO - Running pre-action listener: _resource_record_pre_action 19:14:35 INFO - Running main action method: clobber 19:14:35 INFO - rmtree: /builds/slave/test/build 19:14:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:14:35 INFO - Running post-action listener: _resource_record_post_action 19:14:35 INFO - ##### 19:14:35 INFO - ##### Finished clobber step (success) 19:14:35 INFO - ##### 19:14:35 INFO - ##### 19:14:35 INFO - ##### Running read-buildbot-config step. 19:14:35 INFO - ##### 19:14:35 INFO - Running pre-action listener: _resource_record_pre_action 19:14:35 INFO - Running main action method: read_buildbot_config 19:14:35 INFO - Using buildbot properties: 19:14:35 INFO - { 19:14:35 INFO - "project": "", 19:14:35 INFO - "product": "firefox", 19:14:35 INFO - "script_repo_revision": "production", 19:14:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:14:35 INFO - "repository": "", 19:14:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:14:35 INFO - "buildid": "20160713173001", 19:14:35 INFO - "pgo_build": "True", 19:14:35 INFO - "basedir": "/builds/slave/test", 19:14:35 INFO - "buildnumber": 924, 19:14:35 INFO - "slavename": "talos-linux64-ix-046", 19:14:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:14:35 INFO - "platform": "ubuntu64_hw", 19:14:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:14:35 INFO - "branch": "fx-team", 19:14:35 INFO - "repo_path": "integration/fx-team", 19:14:35 INFO - "revision": "31cab0ba8bbf1d88b08abeae45bcdf317645355a", 19:14:35 INFO - "stage_platform": "linux64-pgo", 19:14:35 INFO - "builduid": "79e950d3dff84e988b9ab4bda7c9991c", 19:14:35 INFO - "slavebuilddir": "test" 19:14:35 INFO - } 19:14:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:14:35 INFO - Running post-action listener: _resource_record_post_action 19:14:35 INFO - ##### 19:14:35 INFO - ##### Finished read-buildbot-config step (success) 19:14:35 INFO - ##### 19:14:35 INFO - ##### 19:14:35 INFO - ##### Running download-and-extract step. 19:14:35 INFO - ##### 19:14:35 INFO - Running pre-action listener: _resource_record_pre_action 19:14:35 INFO - Running main action method: download_and_extract 19:14:35 INFO - mkdir: /builds/slave/test/build/tests 19:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:35 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:37 INFO - Downloaded 1361 bytes. 19:14:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:14:37 INFO - Using the following test package requirements: 19:14:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:14:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:14:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:14:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:37 INFO - u'jsshell-linux-x86_64.zip'], 19:14:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:14:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:14:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:14:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:14:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:14:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:14:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:14: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')]} 19:14:37 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:39 INFO - Downloaded 24326434 bytes. 19:14:39 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'] 19:14:39 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 19:14:40 INFO - Return code: 0 19:14:40 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 19:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:40 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:41 INFO - Downloaded 24326434 bytes. 19:14:41 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'] 19:14:41 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 19:14:43 INFO - Return code: 0 19:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:43 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:44 INFO - Downloaded 14403317 bytes. 19:14:44 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'] 19:14:44 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 19:14:44 INFO - Return code: 0 19:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:44 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:14:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:14:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:14:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:14:45 INFO - Downloaded 60806469 bytes. 19:14:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:14:45 INFO - mkdir: /builds/slave/test/properties 19:14:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:14:45 INFO - Writing to file /builds/slave/test/properties/build_url 19:14:45 INFO - Contents: 19:14:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:14:46 INFO - Running post-action listener: _resource_record_post_action 19:14:46 INFO - Running post-action listener: set_extra_try_arguments 19:14:46 INFO - ##### 19:14:46 INFO - ##### Finished download-and-extract step (success) 19:14:46 INFO - ##### 19:14:46 INFO - ##### 19:14:46 INFO - ##### Running populate-webroot step. 19:14:46 INFO - ##### 19:14:46 INFO - Running pre-action listener: _resource_record_pre_action 19:14:46 INFO - Running main action method: populate_webroot 19:14:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:14:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:14:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:14:46 INFO - '--tppagecycles', 19:14:46 INFO - '7'], 19:14:46 INFO - 'tests': ['tsvgm']}}, 19:14:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:14:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:14:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:14:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:14:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:46 INFO - 'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:14:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:14:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:46 INFO - 'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['damp', 'tps']}, 19:14:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:46 INFO - 'tests': ['damp', 'tps']}, 19:14:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['dromaeo_dom']}, 19:14:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:14:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['basic_compositor_video']}, 19:14:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:14:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['a11yr', 19:14:46 INFO - 'ts_paint', 19:14:46 INFO - 'tpaint', 19:14:46 INFO - 'sessionrestore', 19:14:46 INFO - 'sessionrestore_no_auto_restore', 19:14:46 INFO - 'tabpaint']}, 19:14:46 INFO - 'other-e10s': {'tests': ['a11yr', 19:14:46 INFO - 'ts_paint', 19:14:46 INFO - 'tpaint', 19:14:46 INFO - 'sessionrestore', 19:14:46 INFO - 'sessionrestore_no_auto_restore', 19:14:46 INFO - 'tabpaint']}, 19:14:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:14:46 INFO - 'ts_paint', 19:14:46 INFO - 'tpaint', 19:14:46 INFO - 'sessionrestore', 19:14:46 INFO - 'sessionrestore_no_auto_restore', 19:14:46 INFO - 'tabpaint']}, 19:14:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:14:46 INFO - 'ts_paint', 19:14:46 INFO - 'tpaint', 19:14:46 INFO - 'sessionrestore', 19:14:46 INFO - 'sessionrestore_no_auto_restore', 19:14:46 INFO - 'tabpaint']}, 19:14:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['a11yr', 19:14:46 INFO - 'ts_paint', 19:14:46 INFO - 'tpaint', 19:14:46 INFO - 'sessionrestore', 19:14:46 INFO - 'sessionrestore_no_auto_restore', 19:14:46 INFO - 'tabpaint']}, 19:14:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['a11yr', 19:14:46 INFO - 'ts_paint', 19:14:46 INFO - 'tpaint', 19:14:46 INFO - 'sessionrestore', 19:14:46 INFO - 'sessionrestore_no_auto_restore', 19:14:46 INFO - 'tabpaint']}, 19:14:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['tsvgx', 19:14:46 INFO - 'tsvgr_opacity', 19:14:46 INFO - 'tart', 19:14:46 INFO - 'tscrollx', 19:14:46 INFO - 'cart']}, 19:14:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:14:46 INFO - 'tsvgr_opacity', 19:14:46 INFO - 'tart', 19:14:46 INFO - 'tscrollx', 19:14:46 INFO - 'cart']}, 19:14:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:46 INFO - 'talos_options': ['--disable-e10s'], 19:14:46 INFO - 'tests': ['tp5o']}, 19:14:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:46 INFO - 'tests': ['tp5o']}, 19:14:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:46 INFO - 'talos_options': ['--disable-e10s', 19:14:46 INFO - '--xperf_path', 19:14:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:14:46 INFO - 'tests': ['tp5n']}, 19:14:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:46 INFO - 'talos_options': ['--xperf_path', 19:14:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:14:46 INFO - 'tests': ['tp5n']}}, 19:14:46 INFO - 'talos.zip': {'path': '', 19:14:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:14:46 INFO - Running post-action listener: _resource_record_post_action 19:14:46 INFO - ##### 19:14:46 INFO - ##### Finished populate-webroot step (success) 19:14:46 INFO - ##### 19:14:46 INFO - ##### 19:14:46 INFO - ##### Running create-virtualenv step. 19:14:46 INFO - ##### 19:14:46 INFO - Running pre-action listener: _resource_record_pre_action 19:14:46 INFO - Running main action method: create_virtualenv 19:14:46 INFO - Creating virtualenv /builds/slave/test/build/venv 19:14:46 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 19:14:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:14:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:14:46 INFO - Using real prefix '/usr' 19:14:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:14:46 INFO - Installing distribute.............................................................................................................................................................................................done. 19:14:48 INFO - Installing pip.................done. 19:14:48 INFO - Return code: 0 19:14:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', '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 19:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:14:48 INFO - Using env: {'DISPLAY': ':0', 19:14:48 INFO - 'HOME': '/home/cltbld', 19:14:48 INFO - 'LANG': 'en_US.UTF-8', 19:14:48 INFO - 'LANGUAGE': 'en_US:en', 19:14:48 INFO - 'LOGNAME': 'cltbld', 19:14:48 INFO - 'MAIL': '/var/mail/cltbld', 19:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:48 INFO - 'MOZ_NO_REMOTE': '1', 19:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:48 INFO - 'NO_EM_RESTART': '1', 19:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:48 INFO - 'PWD': '/builds/slave/test', 19:14:48 INFO - 'SHELL': '/bin/bash', 19:14:48 INFO - 'SHLVL': '1', 19:14:48 INFO - 'TERM': 'linux', 19:14:48 INFO - 'TMOUT': '86400', 19:14:48 INFO - 'USER': 'cltbld', 19:14:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:48 INFO - '_': '/tools/buildbot/bin/python'} 19:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:49 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 19:14:49 INFO - Cleaning up... 19:14:49 INFO - Return code: 0 19:14:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:14:49 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')]} 19:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:49 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')]} 19:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:49 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', '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 19:14:49 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 19:14:49 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 19:14:49 INFO - Using env: {'DISPLAY': ':0', 19:14:49 INFO - 'HOME': '/home/cltbld', 19:14:49 INFO - 'LANG': 'en_US.UTF-8', 19:14:49 INFO - 'LANGUAGE': 'en_US:en', 19:14:49 INFO - 'LOGNAME': 'cltbld', 19:14:49 INFO - 'MAIL': '/var/mail/cltbld', 19:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:49 INFO - 'MOZ_NO_REMOTE': '1', 19:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:49 INFO - 'NO_EM_RESTART': '1', 19:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:49 INFO - 'PWD': '/builds/slave/test', 19:14:49 INFO - 'SHELL': '/bin/bash', 19:14:49 INFO - 'SHLVL': '1', 19:14:49 INFO - 'TERM': 'linux', 19:14:49 INFO - 'TMOUT': '86400', 19:14:49 INFO - 'USER': 'cltbld', 19:14:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:49 INFO - '_': '/tools/buildbot/bin/python'} 19:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:49 INFO - Downloading/unpacking psutil>=3.1.1 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:14:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:51 INFO - Installing collected packages: psutil 19:14:51 INFO - Running setup.py install for psutil 19:14:51 INFO - building 'psutil._psutil_linux' extension 19:14:51 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 19:14:51 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 19:14:51 INFO - building 'psutil._psutil_posix' extension 19:14:51 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 19:14:51 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 19:14:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:51 INFO - Successfully installed psutil 19:14:51 INFO - Cleaning up... 19:14:51 INFO - Return code: 0 19:14:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', '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 19:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:14:51 INFO - Using env: {'DISPLAY': ':0', 19:14:51 INFO - 'HOME': '/home/cltbld', 19:14:51 INFO - 'LANG': 'en_US.UTF-8', 19:14:51 INFO - 'LANGUAGE': 'en_US:en', 19:14:51 INFO - 'LOGNAME': 'cltbld', 19:14:51 INFO - 'MAIL': '/var/mail/cltbld', 19:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:51 INFO - 'MOZ_NO_REMOTE': '1', 19:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:51 INFO - 'NO_EM_RESTART': '1', 19:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:51 INFO - 'PWD': '/builds/slave/test', 19:14:51 INFO - 'SHELL': '/bin/bash', 19:14:51 INFO - 'SHLVL': '1', 19:14:51 INFO - 'TERM': 'linux', 19:14:51 INFO - 'TMOUT': '86400', 19:14:51 INFO - 'USER': 'cltbld', 19:14:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:51 INFO - '_': '/tools/buildbot/bin/python'} 19:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:14:54 INFO - Installing collected packages: mozsystemmonitor 19:14:54 INFO - Running setup.py install for mozsystemmonitor 19:14:54 INFO - Successfully installed mozsystemmonitor 19:14:54 INFO - Cleaning up... 19:14:54 INFO - Return code: 0 19:14:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:14:54 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')]} 19:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:54 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')]} 19:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:54 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', '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 19:14:54 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 19:14:54 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 19:14:54 INFO - Using env: {'DISPLAY': ':0', 19:14:54 INFO - 'HOME': '/home/cltbld', 19:14:54 INFO - 'LANG': 'en_US.UTF-8', 19:14:54 INFO - 'LANGUAGE': 'en_US:en', 19:14:54 INFO - 'LOGNAME': 'cltbld', 19:14:54 INFO - 'MAIL': '/var/mail/cltbld', 19:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:54 INFO - 'MOZ_NO_REMOTE': '1', 19:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:54 INFO - 'NO_EM_RESTART': '1', 19:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:54 INFO - 'PWD': '/builds/slave/test', 19:14:54 INFO - 'SHELL': '/bin/bash', 19:14:54 INFO - 'SHLVL': '1', 19:14:54 INFO - 'TERM': 'linux', 19:14:54 INFO - 'TMOUT': '86400', 19:14:54 INFO - 'USER': 'cltbld', 19:14:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:54 INFO - '_': '/tools/buildbot/bin/python'} 19:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:54 INFO - Downloading/unpacking jsonschema==2.5.1 19:14:54 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 19:14:54 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 19:14:54 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 19:14:54 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 19:14:54 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 19:14:54 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 19:14:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:14:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:14:56 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 19:14:56 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 19:14:56 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 19:14:56 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 19:14:56 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 19:14:56 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 19:14:56 INFO - Downloading functools32-3.2.3-2.tar.gz 19:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:14:56 INFO - warning: no files found matching '*.txt' 19:14:56 INFO - no previously-included directories found matching 'build' 19:14:56 INFO - no previously-included directories found matching 'dist' 19:14:56 INFO - no previously-included directories found matching '.git*' 19:14:56 INFO - Installing collected packages: jsonschema, functools32 19:14:56 INFO - Running setup.py install for functools32 19:14:56 INFO - warning: no files found matching '*.txt' 19:14:56 INFO - no previously-included directories found matching 'build' 19:14:56 INFO - no previously-included directories found matching 'dist' 19:14:56 INFO - no previously-included directories found matching '.git*' 19:14:56 INFO - Successfully installed jsonschema functools32 19:14:56 INFO - Cleaning up... 19:14:56 INFO - Return code: 0 19:14:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:14:56 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')]} 19:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:56 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')]} 19:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:56 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', '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 19:14:56 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 19:14:56 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 19:14:56 INFO - Using env: {'DISPLAY': ':0', 19:14:56 INFO - 'HOME': '/home/cltbld', 19:14:56 INFO - 'LANG': 'en_US.UTF-8', 19:14:56 INFO - 'LANGUAGE': 'en_US:en', 19:14:56 INFO - 'LOGNAME': 'cltbld', 19:14:56 INFO - 'MAIL': '/var/mail/cltbld', 19:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:56 INFO - 'MOZ_NO_REMOTE': '1', 19:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:56 INFO - 'NO_EM_RESTART': '1', 19:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:56 INFO - 'PWD': '/builds/slave/test', 19:14:56 INFO - 'SHELL': '/bin/bash', 19:14:56 INFO - 'SHLVL': '1', 19:14:56 INFO - 'TERM': 'linux', 19:14:56 INFO - 'TMOUT': '86400', 19:14:56 INFO - 'USER': 'cltbld', 19:14:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:56 INFO - '_': '/tools/buildbot/bin/python'} 19:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:58 INFO - Downloading blobuploader-1.2.4.tar.gz 19:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:14:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:14:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:59 INFO - Downloading docopt-0.6.1.tar.gz 19:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:14:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:14:59 INFO - Running setup.py install for blobuploader 19:14:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:14:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:14:59 INFO - Running setup.py install for requests 19:15:00 INFO - Running setup.py install for docopt 19:15:00 INFO - Successfully installed blobuploader requests docopt 19:15:00 INFO - Cleaning up... 19:15:00 INFO - Return code: 0 19:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:00 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', '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 19:15:00 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 19:15:00 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 19:15:00 INFO - Using env: {'DISPLAY': ':0', 19:15:00 INFO - 'HOME': '/home/cltbld', 19:15:00 INFO - 'LANG': 'en_US.UTF-8', 19:15:00 INFO - 'LANGUAGE': 'en_US:en', 19:15:00 INFO - 'LOGNAME': 'cltbld', 19:15:00 INFO - 'MAIL': '/var/mail/cltbld', 19:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:00 INFO - 'MOZ_NO_REMOTE': '1', 19:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:00 INFO - 'NO_EM_RESTART': '1', 19:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:00 INFO - 'PWD': '/builds/slave/test', 19:15:00 INFO - 'SHELL': '/bin/bash', 19:15:00 INFO - 'SHLVL': '1', 19:15:00 INFO - 'TERM': 'linux', 19:15:00 INFO - 'TMOUT': '86400', 19:15:00 INFO - 'USER': 'cltbld', 19:15:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:00 INFO - '_': '/tools/buildbot/bin/python'} 19:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:15:00 INFO - Running setup.py (path:/tmp/pip-HAGJI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:15:00 INFO - Running setup.py (path:/tmp/pip-XTp6mB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:15:00 INFO - Running setup.py (path:/tmp/pip-DM2rpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:15:00 INFO - Running setup.py (path:/tmp/pip-3aUNXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:15:00 INFO - Running setup.py (path:/tmp/pip-6aZF37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:15:00 INFO - Running setup.py (path:/tmp/pip-UVz7hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:15:00 INFO - Running setup.py (path:/tmp/pip-yX_8cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:15:01 INFO - Running setup.py (path:/tmp/pip-JexuKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:15:01 INFO - Running setup.py (path:/tmp/pip-NzWtDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:15:01 INFO - Running setup.py (path:/tmp/pip-dtXOpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:15:01 INFO - Running setup.py (path:/tmp/pip-b1is9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:15:01 INFO - Running setup.py (path:/tmp/pip-LeQ529-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:15:01 INFO - Running setup.py (path:/tmp/pip-xPgoYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:15:01 INFO - Running setup.py (path:/tmp/pip-PVthfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:01 INFO - Running setup.py (path:/tmp/pip-oplkyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:15:01 INFO - Running setup.py (path:/tmp/pip-6G9ehL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:15:01 INFO - Running setup.py (path:/tmp/pip-3859RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:15:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:15:01 INFO - Running setup.py install for manifestparser 19:15:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:15:01 INFO - Running setup.py install for mozcrash 19:15:01 INFO - Running setup.py install for mozdebug 19:15:02 INFO - Running setup.py install for mozdevice 19:15:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Running setup.py install for mozfile 19:15:02 INFO - Running setup.py install for mozhttpd 19:15:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Running setup.py install for mozinfo 19:15:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Running setup.py install for mozInstall 19:15:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Running setup.py install for mozleak 19:15:02 INFO - Running setup.py install for mozlog 19:15:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Running setup.py install for moznetwork 19:15:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:15:02 INFO - Running setup.py install for mozprocess 19:15:02 INFO - Running setup.py install for mozprofile 19:15:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:15:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:15:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:15:03 INFO - Running setup.py install for mozrunner 19:15:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:15:03 INFO - Running setup.py install for mozscreenshot 19:15:03 INFO - Running setup.py install for moztest 19:15:03 INFO - Running setup.py install for mozversion 19:15:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:15:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:15:03 INFO - Cleaning up... 19:15:03 INFO - Return code: 0 19:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:03 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', '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 19:15:03 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 19:15:03 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 19:15:03 INFO - Using env: {'DISPLAY': ':0', 19:15:03 INFO - 'HOME': '/home/cltbld', 19:15:03 INFO - 'LANG': 'en_US.UTF-8', 19:15:03 INFO - 'LANGUAGE': 'en_US:en', 19:15:03 INFO - 'LOGNAME': 'cltbld', 19:15:03 INFO - 'MAIL': '/var/mail/cltbld', 19:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:03 INFO - 'MOZ_NO_REMOTE': '1', 19:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:03 INFO - 'NO_EM_RESTART': '1', 19:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:03 INFO - 'PWD': '/builds/slave/test', 19:15:03 INFO - 'SHELL': '/bin/bash', 19:15:03 INFO - 'SHLVL': '1', 19:15:03 INFO - 'TERM': 'linux', 19:15:03 INFO - 'TMOUT': '86400', 19:15:03 INFO - 'USER': 'cltbld', 19:15:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:03 INFO - '_': '/tools/buildbot/bin/python'} 19:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:15:03 INFO - Running setup.py (path:/tmp/pip-ibkbQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:15:03 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)) 19:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:15:03 INFO - Running setup.py (path:/tmp/pip-QGcMdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:15:03 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)) 19:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:15:03 INFO - Running setup.py (path:/tmp/pip-fqfaJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:15:03 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)) 19:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:15:03 INFO - Running setup.py (path:/tmp/pip-kqoq2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:15:04 INFO - Running setup.py (path:/tmp/pip-gK4WtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:15:04 INFO - Running setup.py (path:/tmp/pip-SRJqH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:15:04 INFO - Running setup.py (path:/tmp/pip-cOf8xZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:15:04 INFO - Running setup.py (path:/tmp/pip-2UA6KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:15:04 INFO - Running setup.py (path:/tmp/pip-bplIs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:15:04 INFO - Running setup.py (path:/tmp/pip-yxORTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:15:04 INFO - Running setup.py (path:/tmp/pip-Vj395x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:15:04 INFO - Running setup.py (path:/tmp/pip-RpVfSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:15:04 INFO - Running setup.py (path:/tmp/pip-RPcvA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:15:04 INFO - Running setup.py (path:/tmp/pip-pP5B9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:04 INFO - Running setup.py (path:/tmp/pip-pZ09Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:15:04 INFO - Running setup.py (path:/tmp/pip-T2tr9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:15:04 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)) 19:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:15:04 INFO - Running setup.py (path:/tmp/pip-Uw1wSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:15:05 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)) 19:15:05 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)) 19:15:05 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)) 19:15:05 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)) 19:15:05 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)) 19:15:05 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)) 19:15:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:15:05 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 19:15:05 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 19:15:05 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 19:15:05 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 19:15:05 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 19:15:05 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 19:15:06 INFO - Downloading blessings-1.6.tar.gz 19:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:15:06 INFO - Installing collected packages: blessings 19:15:07 INFO - Running setup.py install for blessings 19:15:07 INFO - Successfully installed blessings 19:15:07 INFO - Cleaning up... 19:15:07 INFO - Return code: 0 19:15:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:15:07 INFO - Reading from file tmpfile_stdout 19:15:07 INFO - Current package versions: 19:15:07 INFO - argparse == 1.2.1 19:15:07 INFO - blessings == 1.6 19:15:07 INFO - blobuploader == 1.2.4 19:15:07 INFO - docopt == 0.6.1 19:15:07 INFO - functools32 == 3.2.3-2 19:15:07 INFO - jsonschema == 2.5.1 19:15:07 INFO - manifestparser == 1.1 19:15:07 INFO - mozInstall == 1.12 19:15:07 INFO - mozcrash == 0.17 19:15:07 INFO - mozdebug == 0.1 19:15:07 INFO - mozdevice == 0.48 19:15:07 INFO - mozfile == 1.2 19:15:07 INFO - mozhttpd == 0.7 19:15:07 INFO - mozinfo == 0.9 19:15:07 INFO - mozleak == 0.1 19:15:07 INFO - mozlog == 3.2 19:15:07 INFO - moznetwork == 0.27 19:15:07 INFO - mozprocess == 0.23 19:15:07 INFO - mozprofile == 0.28 19:15:07 INFO - mozrunner == 6.12 19:15:07 INFO - mozscreenshot == 0.1 19:15:07 INFO - mozsystemmonitor == 0.3 19:15:07 INFO - moztest == 0.7 19:15:07 INFO - mozversion == 1.4 19:15:07 INFO - psutil == 3.1.1 19:15:07 INFO - requests == 1.2.3 19:15:07 INFO - wsgiref == 0.1.2 19:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:07 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', '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 19:15:07 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 19:15:07 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 19:15:07 INFO - Using env: {'DISPLAY': ':0', 19:15:07 INFO - 'HOME': '/home/cltbld', 19:15:07 INFO - 'LANG': 'en_US.UTF-8', 19:15:07 INFO - 'LANGUAGE': 'en_US:en', 19:15:07 INFO - 'LOGNAME': 'cltbld', 19:15:07 INFO - 'MAIL': '/var/mail/cltbld', 19:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:07 INFO - 'MOZ_NO_REMOTE': '1', 19:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:07 INFO - 'NO_EM_RESTART': '1', 19:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:07 INFO - 'PWD': '/builds/slave/test', 19:15:07 INFO - 'SHELL': '/bin/bash', 19:15:07 INFO - 'SHLVL': '1', 19:15:07 INFO - 'TERM': 'linux', 19:15:07 INFO - 'TMOUT': '86400', 19:15:07 INFO - 'USER': 'cltbld', 19:15:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:07 INFO - '_': '/tools/buildbot/bin/python'} 19:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 INFO - Cleaning up... 19:15:07 INFO - Return code: 0 19:15:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:07 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', '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 19:15:07 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 19:15:07 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 19:15:07 INFO - Using env: {'DISPLAY': ':0', 19:15:07 INFO - 'HOME': '/home/cltbld', 19:15:07 INFO - 'LANG': 'en_US.UTF-8', 19:15:07 INFO - 'LANGUAGE': 'en_US:en', 19:15:07 INFO - 'LOGNAME': 'cltbld', 19:15:07 INFO - 'MAIL': '/var/mail/cltbld', 19:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:07 INFO - 'MOZ_NO_REMOTE': '1', 19:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:07 INFO - 'NO_EM_RESTART': '1', 19:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:07 INFO - 'PWD': '/builds/slave/test', 19:15:07 INFO - 'SHELL': '/bin/bash', 19:15:07 INFO - 'SHLVL': '1', 19:15:07 INFO - 'TERM': 'linux', 19:15:07 INFO - 'TMOUT': '86400', 19:15:07 INFO - 'USER': 'cltbld', 19:15:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:07 INFO - '_': '/tools/buildbot/bin/python'} 19:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:15:07 INFO - Cleaning up... 19:15:07 INFO - Return code: 0 19:15:07 INFO - Running post-action listener: _resource_record_post_action 19:15:07 INFO - Running post-action listener: _start_resource_monitoring 19:15:07 INFO - Starting resource monitoring. 19:15:07 INFO - ##### 19:15:07 INFO - ##### Finished create-virtualenv step (success) 19:15:07 INFO - ##### 19:15:07 INFO - ##### 19:15:07 INFO - ##### Running install step. 19:15:07 INFO - ##### 19:15:07 INFO - Running pre-action listener: _resource_record_pre_action 19:15:07 INFO - Running main action method: install 19:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:15:08 INFO - Reading from file tmpfile_stdout 19:15:08 INFO - Detecting whether we're running mozinstall >=1.0... 19:15:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:15:08 INFO - Reading from file tmpfile_stdout 19:15:08 INFO - Output received: 19:15:08 INFO - Usage: mozinstall [options] installer 19:15:08 INFO - Options: 19:15:08 INFO - -h, --help show this help message and exit 19:15:08 INFO - -d DEST, --destination=DEST 19:15:08 INFO - Directory to install application into. [default: 19:15:08 INFO - "/builds/slave/test"] 19:15:08 INFO - --app=APP Application being installed. [default: firefox] 19:15:08 INFO - mkdir: /builds/slave/test/build/application 19:15:08 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'] 19:15:08 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 19:15:25 INFO - Reading from file tmpfile_stdout 19:15:25 INFO - Output received: 19:15:25 INFO - /builds/slave/test/build/application/firefox/firefox 19:15:25 INFO - Running post-action listener: _resource_record_post_action 19:15:25 INFO - ##### 19:15:25 INFO - ##### Finished install step (success) 19:15:25 INFO - ##### 19:15:25 INFO - ##### 19:15:25 INFO - ##### Running run-tests step. 19:15:25 INFO - ##### 19:15:25 INFO - Running pre-action listener: _resource_record_pre_action 19:15:25 INFO - Running main action method: run_tests 19:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:15:25 INFO - Python 2.7.3 19:15:25 INFO - Return code: 0 19:15:25 INFO - grabbing minidump binary from tooltool 19:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:25 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 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:15:25 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 19:15:25 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 19:15:25 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 19:15:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:15:25 INFO - Return code: 0 19:15:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:15:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:15:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:15:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:15:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 19:15:25 INFO - Using env: {'DISPLAY': ':0', 19:15:25 INFO - 'HOME': '/home/cltbld', 19:15:25 INFO - 'LANG': 'en_US.UTF-8', 19:15:25 INFO - 'LANGUAGE': 'en_US:en', 19:15:25 INFO - 'LOGNAME': 'cltbld', 19:15:25 INFO - 'MAIL': '/var/mail/cltbld', 19:15:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:15:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:25 INFO - 'MOZ_NO_REMOTE': '1', 19:15:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:25 INFO - 'NO_EM_RESTART': '1', 19:15:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:25 INFO - 'PWD': '/builds/slave/test', 19:15:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:15:25 INFO - 'SHELL': '/bin/bash', 19:15:25 INFO - 'SHLVL': '1', 19:15:25 INFO - 'TERM': 'linux', 19:15:25 INFO - 'TMOUT': '86400', 19:15:25 INFO - 'USER': 'cltbld', 19:15:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515', 19:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:25 INFO - '_': '/tools/buildbot/bin/python'} 19:15:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:15:25 INFO - mozversion application_buildid: 20160713173001 19:15:25 INFO - mozversion application_changeset: 31cab0ba8bbf1d88b08abeae45bcdf317645355a 19:15:25 INFO - mozversion application_display_name: Nightly 19:15:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:15:25 INFO - mozversion application_name: Firefox 19:15:25 INFO - mozversion application_remotingname: firefox 19:15:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:15:25 INFO - mozversion application_vendor: Mozilla 19:15:25 INFO - mozversion application_version: 50.0a1 19:15:25 INFO - mozversion platform_buildid: 20160713173001 19:15:25 INFO - mozversion platform_changeset: 31cab0ba8bbf1d88b08abeae45bcdf317645355a 19:15:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:15:25 INFO - mozversion platform_version: 50.0a1 19:15:25 INFO - using testdate: 1468462525 19:15:25 INFO - actual date: 1468462525 19:15:25 INFO - starting webserver on 'localhost:41597' 19:15:25 INFO - SUITE-START | Running 2 tests 19:15:25 INFO - TEST-START | dromaeo_css 19:15:25 INFO - operating with platform_type : linux_ 19:15:25 INFO - Initialising browser for dromaeo_css test... 19:15:25 INFO - TEST-INFO | started process 4518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZc6jyJ/profile http://localhost:41597/getInfo.html) 19:15:30 INFO - PROCESS | 4518 | __metrics Screen width/height:1600/1200 19:15:30 INFO - PROCESS | 4518 | colorDepth:24 19:15:30 INFO - PROCESS | 4518 | Browser inner width/height: 1024/697 19:15:30 INFO - PROCESS | 4518 | __metrics 19:15:30 ERROR - PROCESS | 4518 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 19:15:31 INFO - TEST-INFO | 4518: exit 0 19:15:31 INFO - Browser initialized. 19:15:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:15:31 INFO - TEST-INFO | started process 4641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZc6jyJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:15:43 INFO - PROCESS | 4641 | RSS: Main: 168058880 19:15:43 INFO - PROCESS | 4641 | 19:16:33 INFO - PROCESS | 4641 | 1468462593154 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] 19:18:42 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41597/tests/dromaeo/cssquery-ext.html) 19:18:42 INFO - PROCESS | 4641 | RSS: Main: 171053056 19:18:43 INFO - PROCESS | 4641 | 19:21:45 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-ext.html (next: http://localhost:41597/tests/dromaeo/cssquery-jquery.html) 19:21:45 INFO - PROCESS | 4641 | RSS: Main: 168402944 19:21:45 INFO - PROCESS | 4641 | 19:24:47 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41597/tests/dromaeo/cssquery-mootools.html) 19:24:47 INFO - PROCESS | 4641 | RSS: Main: 171479040 19:24:47 INFO - PROCESS | 4641 | 19:27:49 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41597/tests/dromaeo/cssquery-prototype.html) 19:27:50 INFO - PROCESS | 4641 | RSS: Main: 166985728 19:27:50 INFO - PROCESS | 4641 | 19:30:52 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41597/tests/dromaeo/cssquery-yui.html) 19:30:53 INFO - PROCESS | 4641 | RSS: Main: 168951808 19:30:53 INFO - PROCESS | 4641 | 19:33:55 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-yui.html (next: http://localhost:41597/tests/dromaeo/cssquery-dojo.html) 19:33:56 INFO - PROCESS | 4641 | RSS: Main: 170115072 19:33:56 INFO - PROCESS | 4641 | 19:33:56 INFO - PROCESS | 4641 | __start_tp_report 19:33:56 INFO - PROCESS | 4641 | _x_x_mozilla_page_load 19:33:56 INFO - PROCESS | 4641 | _x_x_mozilla_page_load_details 19:33:56 INFO - PROCESS | 4641 | |i|pagename|runs| 19:33:56 INFO - PROCESS | 4641 | |0;dojo.html;3127.6559578446368;3130.326979699364;3149.2284390324376;3165.5409965554995;3188.7927284726493;5592.804251851186;5622.746976386063;5664.716764161791;5695.54435645149;5705.4294570542925;5415.296011518507;5523.558115350772;5558.722063896809;5582.581306402016;5634.661920284786;5006.249062640606;5066.74666266687;5097.541221290083;5202.661826981234;5208.5051920067535;5036.320096786942;5214.817481388152;5219.347581552306;5239.79040838366;5265.341832270966;5029.924551131736;5053.166227572465;5056.241563765428;5066.721330326831;5104.25988231708;5109.744512774347;5110.897782044338;5113.258577506278;5114.693118412907;5149.356330458692;5065.240213967897;5084.644074914758;5089.389273287229;5089.465606111379;5099.6685215460875;5473.124300111963;5482.862928426821;5528.695921724304;5555.777768889239;5582.7766889324375;5997.610155339889;5997.790077347316;6002.789902353396;6008.579399442041;6013.75944962201;5784.971075144597;5952.285725712899;6033.245844269466;6043.456088952015;6045.576809623328;5569.610127291091;5624.971875140639;5628.915566266468;5635.126555383922;5641.323041235037;6171;6177.382261773877;6178.4439400453275;6178.907316390258;6184.6598437086395;5709.51469125129;5769.221155144086;5773.336066352339;5902.852428689317;5911.231539899785;5933.554983376264;5936.821895343147;5952.285725712942;5953.583249172516;5975;5856.795012174553;5892.734826932799;5914.319853216849;5932.79235226765;5964.970175149097;5799.8550036249435;5907.822765317047;5932.644041357532;5980.820575382745;5995.370486098984;4594.862154135381;4597.149527337453;4599.08775952739;4627.861164165013;4628.768561571908;4068.1863627274665;4077.8164982575854;4080.3063479208604;4094.181163767199;4112.383142528644;5714.371419143891;5729.054705973551;5731.8567035824435;5794.246747922743;5796.884062318814;5995.220621319288;6063.939360606338;6071.908921366183;6076.848078797977;6082.9695851520455;5649.293838270216;5795.9420405796245;5800.506956908625;5806.04200306953;5812.854678633068;5076.949230507722;5104.132297509433;5124.666896651705;5126.666766660155;5139.997700448376;6259.561830671901;6269.62382257066;6275.968620156961;6276.937230627726;6283.748650054038;5942.019566771607;6023.879522409615;6058.091286307089;6073.483753880793;6095.878082438415;6217.502599791916;6340.1440805490665;6343.2070991124265;6363.840903977438;6372.9362706374195;5973.283206015306;5980.9401905980385;5983.222181116427;5988.431099045583;5990.191324171181;5831.387704290988;5915.792947246826;5916.497097746567;6090.4536654491885;6093.695315234309;5647.407022262603;5793.391693872251;5843.590948633555;5847.649141051551;5890.293164820249;5810.593258472036;5822.796202133074;5831.387704290988;5834.15404766315;5859.00396932531;5630.690312032713;5756.568257380797;5783.624064435799;5792.942070579409;5827.067669172912;5872.383399743137;5894.115882617642;5955.047192449188;5965.433283838029;5966.3735307793795;5778.479936805707;5791.536677065909;5836.212111365081;5845.210896528914;5845.41545845412 19:33:56 INFO - PROCESS | 4641 | |1;ext.html;531.2403263333434;567.7133047810856;576.5877397660672;579.49873359544;595.9612625179363;43265;43801.342979855246;43960.120797584066;44133;47027.52972470274;45449.09101817961;45810.770946145305;45949.540504594945;46009.76995115028;46111.76944115275;9020.729378118667;9162.496062716547;9163.129502697266;9171.312151588625;9194.862077068849;8985.056569060253;9035.186833185013;9038.051004644516;9042.86435703465;9105.772355691128;9182.219511341511;9217.953910230473;9223.953880230589;9228.815423691522;9242.537873106352;9117.22503587196;9143.862842057375;9162.908370916271;9171.266298696155;9172.954135229314;8979.102089791035;9012.909870901272;9033.683821066297;9074.909250907473;9094.408863423923;41885;41986.58013419857;42184;42488.3626745599;42525;3666.5600127984544;3692.8522859085606;3766.6986641068647;3851.1912498375373;4203.810828512694;33395;34039.65960340414;34143.07354654222;34244.82877585596;34271.485927710855;4428.535003824584;4437.955620443787;4453.554644535553;4558.088382323548;4601.332806743037;387431;388697.99999999715;393198.99999999715;393334;393899;58430;58442.41557584455;58603.70698146482;58648.41351586515;58803;35457;36385;36574.268514630094;38097.04757381032;60724.69637651784;16097.275622597012;16118.435854745263;16149.596260093356;16161.4343497977;16288;12158.331291779037;12246.510139594495;12325.876741232652;12327.260364378166;12363.505459781687;19241.973825913028;19637.50906227356;19670.901645491682;19717.408477745692;19808.60382792336;7203.667321545531;7308.780736577911;7404.2595740426605;7428.893241431589;7605.771826845093;986.5954958466995;1047.669983955067;1090.9127269818396;1131.4851742457163;1148.9827652585218;32700;32806;33272.66727332744;33355.332893342;33939.830300848334;1136.5624234669713;1203.7231436769416;1210.4008515784742;1217.993910030444;1228.6805430587933;16935.66128677444;17319.740203896952;17394.391196308323;17423.912880435517;17471.12644367802;162126;164247;164456;166004;166016;59189.408105919254;59978.40021599728;60003.39996600065;60084.39915600875;60547.69726151341;1356.9253691047088;1374.1548947397478;1380.3719307714966;1382.377929931535;1388.902776805614;30871;32174;32467;32847.83576082104;33640.1589960253;52462.21306680326;55969;57217.427825721206;57243.42756572381;61971.380286198364;427286;429113;432007;432584;432742;42190.57809421989;42338.15323693571;42433;42527.14945701131;42733.35899961565;47640.52359476499;48043;48147;48492.51507485021;49233.26150107823;39579.406308904814;40817.79591102026;41351.58648413477;41424.37863432111;41476.79261603673;39960.4005939917;40302;41639.37540936949;42045.78977105095;42233.36649950192;40573.79713101416;42034.78982605068;42308.36537452002;42389.78805105955;45446;38298;39412.802935985135;39953;40733.38899916445;40745.01631659757;29344.706552934196;29458.703031025205;29482.852585736935;29519;29519.55720664149 19:33:56 INFO - PROCESS | 4641 | |2;jquery.html;389.5500696695318;389.85575337125266;401.0815233116164;403.11113993644017;404.7086098009433;18534.258629654814;19727.1122799474;20037.59924801505;20243.190272389103;21261.787382126175;19750.802491975075;20207.898960505212;20836.374908752725;20931.895340523315;20957.79042209581;5693.629914055584;5745.6265342752795;5758.827235182951;5913.763449462016;5914;5736.512396446286;5760.855978600526;5804.419558044204;5822.505087067604;5838.9124163137585;5643.153526970967;5752.482276595106;5775.884482310351;5779.913301300484;5835.883282334351;5758;5796.50729687977;5804;5811.273590801129;5876.853078673024;5066.290719299301;5136.794528218904;5142.794288228504;5159.793608255665;5204.34945631796;24136.51726965451;24672.753272467406;24817.25548233556;24946;24975.375615609573;2583.4058166621594;2654.1639383594297;2700.7164247754095;2894.4500544896614;3203.9199020024453;14930.25348732559;15366;15402.460913868073;15496.147711875843;15524.534263972098;1919.443361425185;1974.7235387045826;1982.7224188613607;2041.1325186795552;2066.4937090412795;85009.57495212484;85017.14982850217;85593.14406855914;86700.56649716775;87233;10446.843297350546;10546.314489558154;10866.239363244655;10895;10913.672589822318;14834.703305933821;14909.776353354708;14927.328270227867;14947.40210391594;14975.652191302835;8015.398845086642;8184.181581841887;8229.753107406787;8308.210719981593;8328.750137495885;7811.765647030598;7882.763517094496;7952.125266220711;8086;8178.263956243966;6445.45213656835;6555.737770489127;6597.274299827015;6725.495587830835;6827.385535301847;1910.579672472054;1943.0284857571214;1986.5728868293386;2027.523531969986;2028.1887245102077;970.834958057132;1023.6519583341551;1088.1294964028746;1125.4429057616533;1143.274020996673;19391.70341042026;20372.592548148954;20469.795302047085;20537.2811951581;21105.26131585418;1013.4089479517235;1020.3622735790132;1038.2109596706557;1065.8219778468422;1089.782043591285;10910.836337454944;11213.10295176384;11254.38100904458;11288.887111128948;11316.20786544934;413510;416591;520310;528567;544780;102381.48809255906;108638.45680771545;109031;111341;112077;474.87890587899864;497.5174081141287;497.6168350370267;498.80546586831167;499.5279460909406;10720.731981700208;10772.569097236023;11665.708357291136;11830.82253766177;11839.76320473603;44029.33955990727;44784.328235075845;44932.77533612311;45708.4301817003;46261.53738462572;58297;58408.70795646164;63306.68346658237;63976.36023639704;64093.679531603906;8592.957035214784;8747.343949203709;8807.207351338411;8872.33457490678;9023.684171053981;10425.739356516147;11426.48580813882;12587.622371328875;12724.872751272369;14220.360083796048;11204.439778010903;11766.117541184274;12076.818847717466;12096.092793040381;12383.19509231897;11276.718082048015;11520.769584608428;11929.28424294545;12272.693182670148;12310.938445307716;11506.884931150917;11628.18602697803;11646.76706465849;12128.575499857463;12198.451069701707;8209.425340226366;8432.5783710813;8668.91331086681;8726.607302671522;8830.293576513735;8669.783255418664;11171.385573793194;11561.537538498702;12141;12381.133320667466 19:33:56 INFO - PROCESS | 4641 | |3;mootools.html;1508.7435136026877;1528.3122594832325;1659.7261751400576;1805.1966874740745;1816.2371803842384;8075.9192408075905;8749.431286966359;8777.429467084643;9359.438433693975;9391.29565282604;8881.777955551115;8961.05908879568;9093.54532273387;9204.171624553788;9214.585343659535;2305.0318866076245;2345.7067866516686;2347.1784875293597;2348.013834189636;2355.340504658698;2317;2326.9185578504757;2352.200251914349;2372.4697570067297;2377.9167729129485;2234.6759719840616;2237.1834280487587;2238;2249.415152060468;2261.705978222829;2265.6261716816707;2274.7611500792345;2274.795268425841;2277.191596983064;2289.9695137188332;2209.2267706302828;2210.4363387336125;2230.721159855018;2234.910603575855;2236.575050740354;9178.357514973955;9207.125323094295;9291.953540232324;9295.953520232422;9299.721008369692;5212.452692467275;5307.6019298552765;5330.360356757175;5360.195970604402;5364.168553874156;3379.357921994838;3459.066052165901;3469.7224222062428;3492.266624008961;3551.7158627309755;1151.683287096047;1156.7223866272118;2249.8650080995194;2308.5686874137973;2322.4426137726823;12658.81011784824;12771.48914043437;12772.744545109139;12786.61640150797;12791.936040319832;4441.222786012435;4451.265541185733;4596.97701511497;4602.355670206174;4703.294505824086;10094.747631309276;10110.39337639744;10119.190464762802;10123;10123.341982771097;5162.174052151638;5171.172612382001;5177.0940085485645;5208.765605547759;5216.686998780086;4269.210196113667;4661.114388266286;4777.331173635694;4789.329493870791;4818.8795280118275;3838.5201849768778;3844.8654297100024;3889.766614003169;3954.9604503955165;3981.482407287034;1149.2127892393737;1156.8206927926017;1167.2121318110242;1182.467889449751;1185.0637995983077;979.3291595257272;1035;1058.5501162006271;1060.6393826099163;1078.428432930548;6336.271328797156;6504.577202481823;6538;6551;6614.305497922745;436.2692490079105;440.66729619137345;446.1523106098439;448.6724690975606;452.46609001378687;4294.141171765659;4358.4769827620885;4371.540988196193;4471.7987690554;4475.597196252353;10977.12183025356;11189.776204475866;11257.774844503065;11366.545338186379;11390;10711.143108551298;11282.605108821152;11310.886891131147;11312.660620181408;11357.20499565039;8211.876821847676;8517.48895066298;8610.268127209132;8629.870551941725;8640.438371505832;6288.779892703917;6573.112629794917;6600;6628.171478565179;6682.632455214815;10138.188944884245;10518.263721539724;10524.105451036748;10615.203859710398;10654.14766818668;10771.89228107709;10803.945980270048;10893;10897.29167604135;10959.945200273947;7426.14599321085;7502.512336698097;7739.729109481141;8255.834883302421;8404.831903362021;8927.33045021639;8941.37410381293;8943.910560894308;9012.684556040507;9015.729528114167;7517.887231691419;7548.056492938383;7637.541747495168;7793.532388056735;8081;7793.61031948389;8071.273585377344;8121.106678265268;8201.548914809742;8213.137620549756;7094.964525177341;7334.083239595051;7380.96309518449;7388.889166662612;7395.038644976119;5400.486953739389;5429.945700542944;5473.534749546333;5539.224508568885;5587.217789509553;5195.68825870449;5198;5322.228276899906;5418.403975562606;5509.559235261089 19:33:56 INFO - PROCESS | 4641 | |4;prototype.html;318.8995466428075;319.16856588586734;320.233041864734;327.04176762087076;328.1353633176579;5609.354924183725;5615.382307946123;5683.715814209283;5690.516306113986;5692.402297758737;5572.5263352615075;5579.609427340088;5615.522680572156;5639.125935479997;5646.830595082144;4098.344264917607;4212.368144778293;4330.5669433056755;4339.088791353819;4339.41417908583;4267.530571637118;4324.286492728696;4334.84828031019;4340.97829510852;4345.109252603209;4312.2453570625175;4327.826886924519;4349.673774466912;4351.129774045188;4351.151525452538;4219.725717828347;4294.892627684301;4301.720388174758;4306.224879521685;4310.482742070972;3766.2655782122497;3772.7736335819664;3786.8295926683363;3788.015116069814;3795.525559305087;5375.462453754632;5463.808766693147;5464.26232458617;5481.397046324901;5496.642718223343;4892.608591312686;4935.975320123376;4938.876528086791;4944.851654450372;4999.650024498286;5768.711564421762;5824.737886795105;5835.737391817336;5843;5874.882502349929;4159.168166366709;4161.271777438936;4173.812178451977;4178.770167640779;4187.91624167515;5872.970635146839;5960.731767070492;6000.699965001776;6014.8496287592725;6118.736067654996;4261.998430368861;4264.530901600821;4267.551907049778;4268.765217913045;4269.612375977757;4322.200392927319;4324.221640104748;4333.371661109121;4335.783210839445;4339.045410009856;4886.3403440535785;4935.950640493621;4997.225430058346;5002.749862506933;5007.148784706608;5895.734691938873;5900.64596124234;5900.822975310747;5927.436893495111;5930.673812940329;1446.464808021018;1464.8974571779872;1470.7132109238596;1478.8003619511228;1481.2445652717192;905.542700936023;934.8921527989219;936.8220038192858;941.9685444438466;943.5612440215333;5008.273800298936;5047.848564543069;5053.2420136979745;5074.188129899272;5099.87250318745;5246.56034943753;5279.234510995961;5308.442613525602;5331.733413329318;5339.599530035263;4991.67554108989;4995.575376093073;5363.329583802025;5805.448482394166;5813.76744930198;3210.197450637341;3229.757768167397;3235.1750303672884;3242.4974129010043;3256.706896379337;6217.658028808459;6297.4962003039645;6308.936910630835;6357.615894039735;6385.393387628168;6082.178905847654;6111.694415279218;6146.293176284695;6186.123452594565;6189.164462797465;6298.7795427160745;6307.2431308242385;6314.55798094129;6319.96840015797;6344;5853.94146058534;6021.518278537794;6023.66869822164;6037.577369584087;6127.713180232201;6048.304444988883;6050.788222412194;6075.544334175043;6085;6087.36082711309;5988.933817832841;6211.844703882259;6227.252729672468;6301.991681331148;6308.747650094128;4262.914741705086;4297.505786834429;4310.504292006334;4313.749012786382;4330.7401555906745;5886.558508111823;5915.349311575809;6048.274207095177;6141.938580614136;6174.475169610633;5884.9705751470965;5886.735096920564;5890.322612899571;5926.199963005111;5946.810637872356;5617.887642247214;5928.288605367211;5941.613795103304;5941.792037278848;5957.255343082114;5779.162021506942;5799.188113664006;5805.970970145122;5813.476787089182;5815.738291776965;5875.970620146872;5913.34953155144;5920.940790592039;5934.43622855828;5947.364474769473;5651.915221271602;5761.596688231783;5794.246747922743;5810.4189581041555;5826.42686474658 19:33:56 INFO - PROCESS | 4641 | |5;yui.html;760.1220590218293;760.6348952502802;765.6248438265249;769.2615089514067;817.4114637461028;14083.859161408396;15007.549773506786;15012.174330411823;15022.173780442085;15024.924875375607;12923.418446169944;14766.187859667714;14769.704605907902;14779.704405911876;14801.851981480182;793.1632128104861;809.4536188073027;809.76516810125;810.1129263456505;814.5194335342147;801.7554645833019;810.0603300171801;811.1158836867813;811.2617518058568;814.5601375257354;869.1612593846936;873.6723728601775;873.8558137907238;874.1651722604929;875.1948207648978;861.1517655109743;865.7705707987388;868.3010176807667;868.3183700794846;872.3457406944791;628.4501061571125;628.538024551954;629.5624540944045;630.593267342566;633.6831584207896;12982.935085324607;13096.410661520255;13616.93191534046;13639.659008524766;13642.658933526742;13075.738485230242;13107.14803537767;13248.602541923758;13264.204147751167;13321.13412628176;11667.474963626657;11688.47401866918;11717.296962182296;11825.935665790033;11981.041516678644;3692.8522859085606;3778.2821263960036;3830.0616348994395;3831.770093794353;3895.1625400538737;77896.61051694705;82112;83039;83199.5840020796;83336.58331708303;9991.950040249898;10164.847527287096;10299.12457441111;10336.793264134825;10572.36565806054;20537.58924821495;20559.8972005139;20576.279830205873;20612.175512979313;21647.891760541097;8414.537200454033;8469.153084691605;8487.787805304917;8635.309175265964;8721.869171962426;4668.929966050512;4711.434627844681;4764.118638051971;4836.685615434985;4885.193942999436;3717.386631205821;3812.733108682421;3862.1503269280715;3867.2845523577666;3874.438206460104;703.5743375257895;708.4651088428204;711.8576284743073;718.0952000479433;724.8803947348629;705.7036044861171;748.6593599912027;760.6919197724931;761.4441457735884;762.7482930632989;10131.290809643402;10171.54228059739;10183.075508654187;10594.379755936912;10729.517171727135;673.1787219592089;745.9351006664685;759.4038679636459;771.8572064168147;778.3111945927894;4903.141950158708;5139.331886854759;5164.096283150434;5201.869953251124;5214.13966695491;126591;128786;129216.35391822981;130730;136847;82157.58921205356;92746.36268186563;93804.53097734468;94385;119829;56288.71855640777;56303.71848140815;91019;92626;94324;9505.619775208914;9685.661001865183;10603.787924241318;10676.359418434919;10769.838452423062;52664.21003684871;52715.472845271055;53617.46382536281;53693.73153134209;53920.73039634777;71782.64108679423;71912.64043679748;79455;81351;81852.18147818446;13130.474781008652;13313.600591982256;13688.794668079787;13963.301834908418;14043.508477203657;13624.93187534056;13896.096753710977;14163.787543186654;15215.08709477435;15468.381264749283;14375.568732938029;14393.352299146354;14618.195999219719;15409.84590154129;15428.84571154319;13307.334633268492;14297.356618951964;14900.180490072717;14905.701885962437;14932.701345972802;14073.788893166406;14269.857301426853;14341.498047568284;14360.138391696531;14451.421943122157;10535.883694016333;10622.36265824053;10660.573577057141;11057.281276716987;11218.66344009681;11982.820257696316;12339.197952133083;12466.501339946662;12486.250824950532;12603.306818125091 19:33:56 INFO - PROCESS | 4641 | __end_tp_report 19:33:56 INFO - PROCESS | 4641 | __start_cc_report 19:33:56 INFO - PROCESS | 4641 | _x_x_mozilla_cycle_collect,352 19:33:56 INFO - PROCESS | 4641 | __end_cc_report 19:33:56 INFO - PROCESS | 4641 | __startTimestamp1468463636085__endTimestamp 19:33:56 INFO - PROCESS | 4641 | 19:33:56 INFO - PROCESS | 4641 | ------- Summary: start ------- 19:33:56 INFO - PROCESS | 4641 | Number of tests: 6 19:33:56 INFO - PROCESS | 4641 | 19:33:56 INFO - PROCESS | 4641 | [#0] dojo.html Cycles:165 Average:5574.53 Median:5795.94 stddev:647.76 (11.2%) stddev-sans-first:620.66 19:33:56 INFO - PROCESS | 4641 | Values: 3127.7 3130.3 3149.2 3165.5 3188.8 5592.8 5622.7 5664.7 5695.5 5705.4 5415.3 5523.6 5558.7 5582.6 5634.7 5006.2 5066.7 5097.5 5202.7 5208.5 5036.3 5214.8 5219.3 5239.8 5265.3 5029.9 5053.2 5056.2 5066.7 5104.3 5109.7 5110.9 5113.3 5114.7 5149.4 5065.2 5084.6 5089.4 5089.5 5099.7 5473.1 5482.9 5528.7 5555.8 5582.8 5997.6 5997.8 6002.8 6008.6 6013.8 5785.0 5952.3 6033.2 6043.5 6045.6 5569.6 5625.0 5628.9 5635.1 5641.3 6171.0 6177.4 6178.4 6178.9 6184.7 5709.5 5769.2 5773.3 5902.9 5911.2 5933.6 5936.8 5952.3 5953.6 5975.0 5856.8 5892.7 5914.3 5932.8 5965.0 5799.9 5907.8 5932.6 5980.8 5995.4 4594.9 4597.1 4599.1 4627.9 4628.8 4068.2 4077.8 4080.3 4094.2 4112.4 5714.4 5729.1 5731.9 5794.2 5796.9 5995.2 6063.9 6071.9 6076.8 6083.0 5649.3 5795.9 5800.5 5806.0 5812.9 5076.9 5104.1 5124.7 5126.7 5140.0 6259.6 6269.6 6276.0 6276.9 6283.7 5942.0 6023.9 6058.1 6073.5 6095.9 6217.5 6340.1 6343.2 6363.8 6372.9 5973.3 5980.9 5983.2 5988.4 5990.2 5831.4 5915.8 5916.5 6090.5 6093.7 5647.4 5793.4 5843.6 5847.6 5890.3 5810.6 5822.8 5831.4 5834.2 5859.0 5630.7 5756.6 5783.6 5792.9 5827.1 5872.4 5894.1 5955.0 5965.4 5966.4 5778.5 5791.5 5836.2 5845.2 5845.4 19:33:56 INFO - PROCESS | 4641 | 19:33:56 INFO - PROCESS | 4641 | [#1] ext.html Cycles:180 Average:51428.57 Median:42114.89 stddev:92332.42 (219.2%) stddev-sans-first:92512.36 19:33:56 INFO - PROCESS | 4641 | Values: 531.2 567.7 576.6 579.5 596.0 43265.0 43801.3 43960.1 44133.0 47027.5 45449.1 45810.8 45949.5 46009.8 46111.8 9020.7 9162.5 9163.1 9171.3 9194.9 8985.1 9035.2 9038.1 9042.9 9105.8 9182.2 9218.0 9224.0 9228.8 9242.5 9117.2 9143.9 9162.9 9171.3 9173.0 8979.1 9012.9 9033.7 9074.9 9094.4 41885.0 41986.6 42184.0 42488.4 42525.0 3666.6 3692.9 3766.7 3851.2 4203.8 33395.0 34039.7 34143.1 34244.8 34271.5 4428.5 4438.0 4453.6 4558.1 4601.3 387431.0 388698.0 393199.0 393334.0 393899.0 58430.0 58442.4 58603.7 58648.4 58803.0 35457.0 36385.0 36574.3 38097.0 60724.7 16097.3 16118.4 16149.6 16161.4 16288.0 12158.3 12246.5 12325.9 12327.3 12363.5 19242.0 19637.5 19670.9 19717.4 19808.6 7203.7 7308.8 7404.3 7428.9 7605.8 986.6 1047.7 1090.9 1131.5 1149.0 32700.0 32806.0 33272.7 33355.3 33939.8 1136.6 1203.7 1210.4 1218.0 1228.7 16935.7 17319.7 17394.4 17423.9 17471.1 162126.0 164247.0 164456.0 166004.0 166016.0 59189.4 59978.4 60003.4 60084.4 60547.7 1356.9 1374.2 1380.4 1382.4 1388.9 30871.0 32174.0 32467.0 32847.8 33640.2 52462.2 55969.0 57217.4 57243.4 61971.4 427286.0 429113.0 432007.0 432584.0 432742.0 42190.6 42338.2 42433.0 42527.1 42733.4 47640.5 48043.0 48147.0 48492.5 49233.3 39579.4 40817.8 41351.6 41424.4 41476.8 39960.4 40302.0 41639.4 42045.8 42233.4 40573.8 42034.8 42308.4 42389.8 45446.0 38298.0 39412.8 39953.0 40733.4 40745.0 29344.7 29458.7 29482.9 29519.0 29519.6 19:33:56 INFO - PROCESS | 4641 | 19:33:56 INFO - PROCESS | 4641 | [#2] jquery.html Cycles:180 Average:29794.83 Median:24881.63 stddev:81064.85 (325.8%) stddev-sans-first:81262.19 19:33:56 INFO - PROCESS | 4641 | Values: 389.6 389.9 401.1 403.1 404.7 18534.3 19727.1 20037.6 20243.2 21261.8 19750.8 20207.9 20836.4 20931.9 20957.8 5693.6 5745.6 5758.8 5913.8 5914.0 5736.5 5760.9 5804.4 5822.5 5838.9 5643.2 5752.5 5775.9 5779.9 5835.9 5758.0 5796.5 5804.0 5811.3 5876.9 5066.3 5136.8 5142.8 5159.8 5204.3 24136.5 24672.8 24817.3 24946.0 24975.4 2583.4 2654.2 2700.7 2894.5 3203.9 14930.3 15366.0 15402.5 15496.1 15524.5 1919.4 1974.7 1982.7 2041.1 2066.5 85009.6 85017.1 85593.1 86700.6 87233.0 10446.8 10546.3 10866.2 10895.0 10913.7 14834.7 14909.8 14927.3 14947.4 14975.7 8015.4 8184.2 8229.8 8308.2 8328.8 7811.8 7882.8 7952.1 8086.0 8178.3 6445.5 6555.7 6597.3 6725.5 6827.4 1910.6 1943.0 1986.6 2027.5 2028.2 970.8 1023.7 1088.1 1125.4 1143.3 19391.7 20372.6 20469.8 20537.3 21105.3 1013.4 1020.4 1038.2 1065.8 1089.8 10910.8 11213.1 11254.4 11288.9 11316.2 413510.0 416591.0 520310.0 528567.0 544780.0 102381.5 108638.5 109031.0 111341.0 112077.0 474.9 497.5 497.6 498.8 499.5 10720.7 10772.6 11665.7 11830.8 11839.8 44029.3 44784.3 44932.8 45708.4 46261.5 58297.0 58408.7 63306.7 63976.4 64093.7 8593.0 8747.3 8807.2 8872.3 9023.7 10425.7 11426.5 12587.6 12724.9 14220.4 11204.4 11766.1 12076.8 12096.1 12383.2 11276.7 11520.8 11929.3 12272.7 12310.9 11506.9 11628.2 11646.8 12128.6 12198.5 8209.4 8432.6 8668.9 8726.6 8830.3 8669.8 11171.4 11561.5 12141.0 12381.1 19:33:56 INFO - PROCESS | 4641 | 19:33:56 INFO - PROCESS | 4641 | [#3] mootools.html Cycles:180 Average:5980.12 Median:4446.24 stddev:3430.55 (77.2%) stddev-sans-first:3423.71 19:33:56 INFO - PROCESS | 4641 | Values: 1508.7 1528.3 1659.7 1805.2 1816.2 8075.9 8749.4 8777.4 9359.4 9391.3 8881.8 8961.1 9093.5 9204.2 9214.6 2305.0 2345.7 2347.2 2348.0 2355.3 2317.0 2326.9 2352.2 2372.5 2377.9 2234.7 2237.2 2238.0 2249.4 2261.7 2265.6 2274.8 2274.8 2277.2 2290.0 2209.2 2210.4 2230.7 2234.9 2236.6 9178.4 9207.1 9292.0 9296.0 9299.7 5212.5 5307.6 5330.4 5360.2 5364.2 3379.4 3459.1 3469.7 3492.3 3551.7 1151.7 1156.7 2249.9 2308.6 2322.4 12658.8 12771.5 12772.7 12786.6 12791.9 4441.2 4451.3 4597.0 4602.4 4703.3 10094.7 10110.4 10119.2 10123.0 10123.3 5162.2 5171.2 5177.1 5208.8 5216.7 4269.2 4661.1 4777.3 4789.3 4818.9 3838.5 3844.9 3889.8 3955.0 3981.5 1149.2 1156.8 1167.2 1182.5 1185.1 979.3 1035.0 1058.6 1060.6 1078.4 6336.3 6504.6 6538.0 6551.0 6614.3 436.3 440.7 446.2 448.7 452.5 4294.1 4358.5 4371.5 4471.8 4475.6 10977.1 11189.8 11257.8 11366.5 11390.0 10711.1 11282.6 11310.9 11312.7 11357.2 8211.9 8517.5 8610.3 8629.9 8640.4 6288.8 6573.1 6600.0 6628.2 6682.6 10138.2 10518.3 10524.1 10615.2 10654.1 10771.9 10803.9 10893.0 10897.3 10959.9 7426.1 7502.5 7739.7 8255.8 8404.8 8927.3 8941.4 8943.9 9012.7 9015.7 7517.9 7548.1 7637.5 7793.5 8081.0 7793.6 8071.3 8121.1 8201.5 8213.1 7095.0 7334.1 7381.0 7388.9 7395.0 5400.5 5429.9 5473.5 5539.2 5587.2 5195.7 5198.0 5322.2 5418.4 5509.6 19:33:56 INFO - PROCESS | 4641 | 19:33:56 INFO - PROCESS | 4641 | [#4] prototype.html Cycles:180 Average:4903.20 Median:5612.37 stddev:1460.78 (26.0%) stddev-sans-first:1423.77 19:33:56 INFO - PROCESS | 4641 | Values: 318.9 319.2 320.2 327.0 328.1 5609.4 5615.4 5683.7 5690.5 5692.4 5572.5 5579.6 5615.5 5639.1 5646.8 4098.3 4212.4 4330.6 4339.1 4339.4 4267.5 4324.3 4334.8 4341.0 4345.1 4312.2 4327.8 4349.7 4351.1 4351.2 4219.7 4294.9 4301.7 4306.2 4310.5 3766.3 3772.8 3786.8 3788.0 3795.5 5375.5 5463.8 5464.3 5481.4 5496.6 4892.6 4936.0 4938.9 4944.9 4999.7 5768.7 5824.7 5835.7 5843.0 5874.9 4159.2 4161.3 4173.8 4178.8 4187.9 5873.0 5960.7 6000.7 6014.8 6118.7 4262.0 4264.5 4267.6 4268.8 4269.6 4322.2 4324.2 4333.4 4335.8 4339.0 4886.3 4936.0 4997.2 5002.7 5007.1 5895.7 5900.6 5900.8 5927.4 5930.7 1446.5 1464.9 1470.7 1478.8 1481.2 905.5 934.9 936.8 942.0 943.6 5008.3 5047.8 5053.2 5074.2 5099.9 5246.6 5279.2 5308.4 5331.7 5339.6 4991.7 4995.6 5363.3 5805.4 5813.8 3210.2 3229.8 3235.2 3242.5 3256.7 6217.7 6297.5 6308.9 6357.6 6385.4 6082.2 6111.7 6146.3 6186.1 6189.2 6298.8 6307.2 6314.6 6320.0 6344.0 5853.9 6021.5 6023.7 6037.6 6127.7 6048.3 6050.8 6075.5 6085.0 6087.4 5988.9 6211.8 6227.3 6302.0 6308.7 4262.9 4297.5 4310.5 4313.7 4330.7 5886.6 5915.3 6048.3 6141.9 6174.5 5885.0 5886.7 5890.3 5926.2 5946.8 5617.9 5928.3 5941.6 5941.8 5957.3 5779.2 5799.2 5806.0 5813.5 5815.7 5876.0 5913.3 5920.9 5934.4 5947.4 5651.9 5761.6 5794.2 5810.4 5826.4 19:33:56 INFO - PROCESS | 4641 | 19:33:56 INFO - PROCESS | 4641 | [#5] yui.html Cycles:180 Average:21246.63 Median:3870.86 stddev:31426.00 (811.9%) stddev-sans-first:31476.51 19:33:56 INFO - PROCESS | 4641 | Values: 760.1 760.6 765.6 769.3 817.4 14083.9 15007.5 15012.2 15022.2 15024.9 12923.4 14766.2 14769.7 14779.7 14801.9 793.2 809.5 809.8 810.1 814.5 801.8 810.1 811.1 811.3 814.6 869.2 873.7 873.9 874.2 875.2 861.2 865.8 868.3 868.3 872.3 628.5 628.5 629.6 630.6 633.7 12982.9 13096.4 13616.9 13639.7 13642.7 13075.7 13107.1 13248.6 13264.2 13321.1 11667.5 11688.5 11717.3 11825.9 11981.0 3692.9 3778.3 3830.1 3831.8 3895.2 77896.6 82112.0 83039.0 83199.6 83336.6 9992.0 10164.8 10299.1 10336.8 10572.4 20537.6 20559.9 20576.3 20612.2 21647.9 8414.5 8469.2 8487.8 8635.3 8721.9 4668.9 4711.4 4764.1 4836.7 4885.2 3717.4 3812.7 3862.2 3867.3 3874.4 703.6 708.5 711.9 718.1 724.9 705.7 748.7 760.7 761.4 762.7 10131.3 10171.5 10183.1 10594.4 10729.5 673.2 745.9 759.4 771.9 778.3 4903.1 5139.3 5164.1 5201.9 5214.1 126591.0 128786.0 129216.4 130730.0 136847.0 82157.6 92746.4 93804.5 94385.0 119829.0 56288.7 56303.7 91019.0 92626.0 94324.0 9505.6 9685.7 10603.8 10676.4 10769.8 52664.2 52715.5 53617.5 53693.7 53920.7 71782.6 71912.6 79455.0 81351.0 81852.2 13130.5 13313.6 13688.8 13963.3 14043.5 13624.9 13896.1 14163.8 15215.1 15468.4 14375.6 14393.4 14618.2 15409.8 15428.8 13307.3 14297.4 14900.2 14905.7 14932.7 14073.8 14269.9 14341.5 14360.1 14451.4 10535.9 10622.4 10660.6 11057.3 11218.7 11982.8 12339.2 12466.5 12486.3 12603.3 19:33:56 INFO - PROCESS | 4641 | -------- Summary: end -------- 19:33:56 INFO - PROCESS | 4641 | 19:33:56 INFO - TEST-INFO | 4641: exit 0 19:33:56 INFO - TEST-OK | dromaeo_css | took 1111164ms 19:33:56 INFO - TEST-START | kraken 19:33:56 INFO - operating with platform_type : linux_ 19:33:56 INFO - Initialising browser for kraken test... 19:33:56 INFO - TEST-INFO | started process 4889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7NNG2D/profile http://localhost:41597/getInfo.html) 19:34:01 INFO - PROCESS | 4889 | __metrics Screen width/height:1600/1200 19:34:01 INFO - PROCESS | 4889 | colorDepth:24 19:34:01 INFO - PROCESS | 4889 | Browser inner width/height: 1024/697 19:34:01 INFO - PROCESS | 4889 | __metrics 19:34:01 ERROR - PROCESS | 4889 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 19:34:02 INFO - TEST-INFO | 4889: exit 0 19:34:02 INFO - Browser initialized. 19:34:02 INFO - Running cycle 1/1 for kraken test... 19:34:02 INFO - TEST-INFO | started process 5010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7NNG2D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:34:14 INFO - PROCESS | 5010 | RSS: Main: 167817216 19:34:14 INFO - PROCESS | 5010 | 19:34:16 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41597/tests/kraken/driver.html?testName=audio-beat-detection) 19:34:17 INFO - PROCESS | 5010 | RSS: Main: 173158400 19:34:17 INFO - PROCESS | 5010 | 19:34:20 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41597/tests/kraken/driver.html?testName=audio-dft) 19:34:21 INFO - PROCESS | 5010 | RSS: Main: 172642304 19:34:21 INFO - PROCESS | 5010 | 19:34:23 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41597/tests/kraken/driver.html?testName=audio-fft) 19:34:24 INFO - PROCESS | 5010 | RSS: Main: 167272448 19:34:24 INFO - PROCESS | 5010 | 19:34:26 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41597/tests/kraken/driver.html?testName=audio-oscillator) 19:34:27 INFO - PROCESS | 5010 | RSS: Main: 167952384 19:34:27 INFO - PROCESS | 5010 | 19:34:29 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:34:30 INFO - PROCESS | 5010 | RSS: Main: 168423424 19:34:30 INFO - PROCESS | 5010 | 19:34:33 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41597/tests/kraken/driver.html?testName=imaging-darkroom) 19:34:33 INFO - PROCESS | 5010 | RSS: Main: 168087552 19:34:33 INFO - PROCESS | 5010 | 19:34:37 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41597/tests/kraken/driver.html?testName=imaging-desaturate) 19:34:37 INFO - PROCESS | 5010 | RSS: Main: 169873408 19:34:37 INFO - PROCESS | 5010 | 19:34:40 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41597/tests/kraken/driver.html?testName=json-parse-financial) 19:34:41 INFO - PROCESS | 5010 | RSS: Main: 169250816 19:34:41 INFO - PROCESS | 5010 | 19:34:42 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:34:43 INFO - PROCESS | 5010 | RSS: Main: 169091072 19:34:43 INFO - PROCESS | 5010 | 19:34:45 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:34:46 INFO - PROCESS | 5010 | RSS: Main: 169590784 19:34:46 INFO - PROCESS | 5010 | 19:34:48 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:34:48 INFO - PROCESS | 5010 | RSS: Main: 169664512 19:34:48 INFO - PROCESS | 5010 | 19:34:51 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:34:51 INFO - PROCESS | 5010 | RSS: Main: 170307584 19:34:51 INFO - PROCESS | 5010 | 19:34:54 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:34:55 INFO - PROCESS | 5010 | RSS: Main: 169971712 19:34:55 INFO - PROCESS | 5010 | 19:34:56 INFO - PROCESS | 5010 | Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41597/tests/kraken/driver.html?testName=ai-astar) 19:34:57 INFO - PROCESS | 5010 | RSS: Main: 170524672 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | __start_tp_report 19:34:57 INFO - PROCESS | 5010 | _x_x_mozilla_page_load 19:34:57 INFO - PROCESS | 5010 | _x_x_mozilla_page_load_details 19:34:57 INFO - PROCESS | 5010 | |i|pagename|runs| 19:34:57 INFO - PROCESS | 5010 | |0;ai-astar;103;114;106;111;115;112;114;110;110;110 19:34:57 INFO - PROCESS | 5010 | |1;audio-beat-detection;148;118;143;170;125;143;147;119;168;120 19:34:57 INFO - PROCESS | 5010 | |2;audio-dft;163;163;163;165;163;165;171;165;162;162 19:34:57 INFO - PROCESS | 5010 | |3;audio-fft;75;75;76;157;77;76;76;76;162;76 19:34:57 INFO - PROCESS | 5010 | |4;audio-oscillator;84;83;151;85;83;85;145;85;83;151 19:34:57 INFO - PROCESS | 5010 | |5;imaging-gaussian-blur;120;117;118;118;118;118;117;117;118;118 19:34:57 INFO - PROCESS | 5010 | |6;imaging-darkroom;146;149;147;148;147;147;147;146;148;148 19:34:57 INFO - PROCESS | 5010 | |7;imaging-desaturate;95;100;101;96;96;95;95;96;94;95 19:34:57 INFO - PROCESS | 5010 | |8;json-parse-financial;54;53;54;54;53;64;53;53;54;53 19:34:57 INFO - PROCESS | 5010 | |9;json-stringify-tinderbox;64;63;63;63;64;63;63;63;66;63 19:34:57 INFO - PROCESS | 5010 | |10;stanford-crypto-aes;80;75;74;74;76;78;77;75;82;81 19:34:57 INFO - PROCESS | 5010 | |11;stanford-crypto-ccm;127;134;131;123;138;121;123;123;177;124 19:34:57 INFO - PROCESS | 5010 | |12;stanford-crypto-pbkdf2;164;158;156;160;156;158;164;153;158;159 19:34:57 INFO - PROCESS | 5010 | |13;stanford-crypto-sha256-iterative;63;66;64;65;65;63;64;61;71;61 19:34:57 INFO - PROCESS | 5010 | __end_tp_report 19:34:57 INFO - PROCESS | 5010 | __start_cc_report 19:34:57 INFO - PROCESS | 5010 | _x_x_mozilla_cycle_collect,884 19:34:57 INFO - PROCESS | 5010 | __end_cc_report 19:34:57 INFO - PROCESS | 5010 | __startTimestamp1468463697197__endTimestamp 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | ------- Summary: start ------- 19:34:57 INFO - PROCESS | 5010 | Number of tests: 14 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:3.72 (3.3%) stddev-sans-first:2.78 19:34:57 INFO - PROCESS | 5010 | Values: 103.0 114.0 106.0 111.0 115.0 112.0 114.0 110.0 110.0 110.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:145.00 stddev:19.34 (13.3%) stddev-sans-first:20.30 19:34:57 INFO - PROCESS | 5010 | Values: 148.0 118.0 143.0 170.0 125.0 143.0 147.0 119.0 168.0 120.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.66 (1.6%) stddev-sans-first:2.78 19:34:57 INFO - PROCESS | 5010 | Values: 163.0 163.0 163.0 165.0 163.0 165.0 171.0 165.0 162.0 162.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:35.28 (46.4%) stddev-sans-first:36.84 19:34:57 INFO - PROCESS | 5010 | Values: 75.0 75.0 76.0 157.0 77.0 76.0 76.0 76.0 162.0 76.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:83.50 stddev:31.45 (37.7%) stddev-sans-first:32.56 19:34:57 INFO - PROCESS | 5010 | Values: 84.0 83.0 151.0 85.0 83.0 85.0 145.0 85.0 83.0 151.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.50 19:34:57 INFO - PROCESS | 5010 | Values: 120.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 19:34:57 INFO - PROCESS | 5010 | Values: 146.0 149.0 147.0 148.0 147.0 147.0 147.0 146.0 148.0 148.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:95.00 stddev:2.31 (2.4%) stddev-sans-first:2.40 19:34:57 INFO - PROCESS | 5010 | Values: 95.0 100.0 101.0 96.0 96.0 95.0 95.0 96.0 94.0 95.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.37 (6.2%) stddev-sans-first:3.57 19:34:57 INFO - PROCESS | 5010 | Values: 54.0 53.0 54.0 54.0 53.0 64.0 53.0 53.0 54.0 53.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 19:34:57 INFO - PROCESS | 5010 | Values: 64.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 66.0 63.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.50 stddev:2.94 (3.8%) stddev-sans-first:2.93 19:34:57 INFO - PROCESS | 5010 | Values: 80.0 75.0 74.0 74.0 76.0 78.0 77.0 75.0 82.0 81.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:129.00 stddev:16.73 (13.0%) stddev-sans-first:17.64 19:34:57 INFO - PROCESS | 5010 | Values: 127.0 134.0 131.0 123.0 138.0 121.0 123.0 123.0 177.0 124.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:158.50 stddev:3.44 (2.2%) stddev-sans-first:3.04 19:34:57 INFO - PROCESS | 5010 | Values: 164.0 158.0 156.0 160.0 156.0 158.0 164.0 153.0 158.0 159.0 19:34:57 INFO - PROCESS | 5010 | 19:34:57 INFO - PROCESS | 5010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:2.87 (4.4%) stddev-sans-first:3.00 19:34:57 INFO - PROCESS | 5010 | Values: 63.0 66.0 64.0 65.0 65.0 63.0 64.0 61.0 71.0 61.0 19:34:57 INFO - PROCESS | 5010 | -------- Summary: end -------- 19:34:57 INFO - PROCESS | 5010 | 19:34:58 INFO - TEST-INFO | 5010: exit 0 19:34:58 INFO - TEST-OK | kraken | took 61380ms 19:34:58 INFO - SUITE-END | took 1172s 19:34:58 INFO - Completed test suite (00:19:32) 19:34:58 INFO - javascript benchmark 19:34:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7412.318598883416, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.6559578446368, 3130.326979699364, 3149.2284390324376, 3165.5409965554995, 3188.7927284726493, 5592.804251851186, 5622.746976386063, 5664.716764161791, 5695.54435645149, 5705.4294570542925, 5415.296011518507, 5523.558115350772, 5558.722063896809, 5582.581306402016, 5634.661920284786, 5006.249062640606, 5066.74666266687, 5097.541221290083, 5202.661826981234, 5208.5051920067535, 5036.320096786942, 5214.817481388152, 5219.347581552306, 5239.79040838366, 5265.341832270966, 5029.924551131736, 5053.166227572465, 5056.241563765428, 5066.721330326831, 5104.25988231708, 5109.744512774347, 5110.897782044338, 5113.258577506278, 5114.693118412907, 5149.356330458692, 5065.240213967897, 5084.644074914758, 5089.389273287229, 5089.465606111379, 5099.6685215460875, 5473.124300111963, 5482.862928426821, 5528.695921724304, 5555.777768889239, 5582.7766889324375, 5997.610155339889, 5997.790077347316, 6002.789902353396, 6008.579399442041, 6013.75944962201, 5784.971075144597, 5952.285725712899, 6033.245844269466, 6043.456088952015, 6045.576809623328, 5569.610127291091, 5624.971875140639, 5628.915566266468, 5635.126555383922, 5641.323041235037, 6171.0, 6177.382261773877, 6178.4439400453275, 6178.907316390258, 6184.6598437086395, 5709.51469125129, 5769.221155144086, 5773.336066352339, 5902.852428689317, 5911.231539899785, 5933.554983376264, 5936.821895343147, 5952.285725712942, 5953.583249172516, 5975.0, 5856.795012174553, 5892.734826932799, 5914.319853216849, 5932.79235226765, 5964.970175149097, 5799.8550036249435, 5907.822765317047, 5932.644041357532, 5980.820575382745, 5995.370486098984, 4594.862154135381, 4597.149527337453, 4599.08775952739, 4627.861164165013, 4628.768561571908, 4068.1863627274665, 4077.8164982575854, 4080.3063479208604, 4094.181163767199, 4112.383142528644, 5714.371419143891, 5729.054705973551, 5731.8567035824435, 5794.246747922743, 5796.884062318814, 5995.220621319288, 6063.939360606338, 6071.908921366183, 6076.848078797977, 6082.9695851520455, 5649.293838270216, 5795.9420405796245, 5800.506956908625, 5806.04200306953, 5812.854678633068, 5076.949230507722, 5104.132297509433, 5124.666896651705, 5126.666766660155, 5139.997700448376, 6259.561830671901, 6269.62382257066, 6275.968620156961, 6276.937230627726, 6283.748650054038, 5942.019566771607, 6023.879522409615, 6058.091286307089, 6073.483753880793, 6095.878082438415, 6217.502599791916, 6340.1440805490665, 6343.2070991124265, 6363.840903977438, 6372.9362706374195, 5973.283206015306, 5980.9401905980385, 5983.222181116427, 5988.431099045583, 5990.191324171181, 5831.387704290988, 5915.792947246826, 5916.497097746567, 6090.4536654491885, 6093.695315234309, 5647.407022262603, 5793.391693872251, 5843.590948633555, 5847.649141051551, 5890.293164820249, 5810.593258472036, 5822.796202133074, 5831.387704290988, 5834.15404766315, 5859.00396932531, 5630.690312032713, 5756.568257380797, 5783.624064435799, 5792.942070579409, 5827.067669172912, 5872.383399743137, 5894.115882617642, 5955.047192449188, 5965.433283838029, 5966.3735307793795, 5778.479936805707, 5791.536677065909, 5836.212111365081, 5845.210896528914, 5845.41545845412], "value": 5529.236067132826, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.2403263333434, 567.7133047810856, 576.5877397660672, 579.49873359544, 595.9612625179363, 43265.0, 43801.342979855246, 43960.120797584066, 44133.0, 47027.52972470274, 45449.09101817961, 45810.770946145305, 45949.540504594945, 46009.76995115028, 46111.76944115275, 9020.729378118667, 9162.496062716547, 9163.129502697266, 9171.312151588625, 9194.862077068849, 8985.056569060253, 9035.186833185013, 9038.051004644516, 9042.86435703465, 9105.772355691128, 9182.219511341511, 9217.953910230473, 9223.953880230589, 9228.815423691522, 9242.537873106352, 9117.22503587196, 9143.862842057375, 9162.908370916271, 9171.266298696155, 9172.954135229314, 8979.102089791035, 9012.909870901272, 9033.683821066297, 9074.909250907473, 9094.408863423923, 41885.0, 41986.58013419857, 42184.0, 42488.3626745599, 42525.0, 3666.5600127984544, 3692.8522859085606, 3766.6986641068647, 3851.1912498375373, 4203.810828512694, 33395.0, 34039.65960340414, 34143.07354654222, 34244.82877585596, 34271.485927710855, 4428.535003824584, 4437.955620443787, 4453.554644535553, 4558.088382323548, 4601.332806743037, 387431.0, 388697.99999999715, 393198.99999999715, 393334.0, 393899.0, 58430.0, 58442.41557584455, 58603.70698146482, 58648.41351586515, 58803.0, 35457.0, 36385.0, 36574.268514630094, 38097.04757381032, 60724.69637651784, 16097.275622597012, 16118.435854745263, 16149.596260093356, 16161.4343497977, 16288.0, 12158.331291779037, 12246.510139594495, 12325.876741232652, 12327.260364378166, 12363.505459781687, 19241.973825913028, 19637.50906227356, 19670.901645491682, 19717.408477745692, 19808.60382792336, 7203.667321545531, 7308.780736577911, 7404.2595740426605, 7428.893241431589, 7605.771826845093, 986.5954958466995, 1047.669983955067, 1090.9127269818396, 1131.4851742457163, 1148.9827652585218, 32700.0, 32806.0, 33272.66727332744, 33355.332893342, 33939.830300848334, 1136.5624234669713, 1203.7231436769416, 1210.4008515784742, 1217.993910030444, 1228.6805430587933, 16935.66128677444, 17319.740203896952, 17394.391196308323, 17423.912880435517, 17471.12644367802, 162126.0, 164247.0, 164456.0, 166004.0, 166016.0, 59189.408105919254, 59978.40021599728, 60003.39996600065, 60084.39915600875, 60547.69726151341, 1356.9253691047088, 1374.1548947397478, 1380.3719307714966, 1382.377929931535, 1388.902776805614, 30871.0, 32174.0, 32467.0, 32847.83576082104, 33640.1589960253, 52462.21306680326, 55969.0, 57217.427825721206, 57243.42756572381, 61971.380286198364, 427286.0, 429113.0, 432007.0, 432584.0, 432742.0, 42190.57809421989, 42338.15323693571, 42433.0, 42527.14945701131, 42733.35899961565, 47640.52359476499, 48043.0, 48147.0, 48492.51507485021, 49233.26150107823, 39579.406308904814, 40817.79591102026, 41351.58648413477, 41424.37863432111, 41476.79261603673, 39960.4005939917, 40302.0, 41639.37540936949, 42045.78977105095, 42233.36649950192, 40573.79713101416, 42034.78982605068, 42308.36537452002, 42389.78805105955, 45446.0, 38298.0, 39412.802935985135, 39953.0, 40733.38899916445, 40745.01631659757, 29344.706552934196, 29458.703031025205, 29482.852585736935, 29519.0, 29519.55720664149], "value": 20005.227345724703, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.5500696695318, 389.85575337125266, 401.0815233116164, 403.11113993644017, 404.7086098009433, 18534.258629654814, 19727.1122799474, 20037.59924801505, 20243.190272389103, 21261.787382126175, 19750.802491975075, 20207.898960505212, 20836.374908752725, 20931.895340523315, 20957.79042209581, 5693.629914055584, 5745.6265342752795, 5758.827235182951, 5913.763449462016, 5914.0, 5736.512396446286, 5760.855978600526, 5804.419558044204, 5822.505087067604, 5838.9124163137585, 5643.153526970967, 5752.482276595106, 5775.884482310351, 5779.913301300484, 5835.883282334351, 5758.0, 5796.50729687977, 5804.0, 5811.273590801129, 5876.853078673024, 5066.290719299301, 5136.794528218904, 5142.794288228504, 5159.793608255665, 5204.34945631796, 24136.51726965451, 24672.753272467406, 24817.25548233556, 24946.0, 24975.375615609573, 2583.4058166621594, 2654.1639383594297, 2700.7164247754095, 2894.4500544896614, 3203.9199020024453, 14930.25348732559, 15366.0, 15402.460913868073, 15496.147711875843, 15524.534263972098, 1919.443361425185, 1974.7235387045826, 1982.7224188613607, 2041.1325186795552, 2066.4937090412795, 85009.57495212484, 85017.14982850217, 85593.14406855914, 86700.56649716775, 87233.0, 10446.843297350546, 10546.314489558154, 10866.239363244655, 10895.0, 10913.672589822318, 14834.703305933821, 14909.776353354708, 14927.328270227867, 14947.40210391594, 14975.652191302835, 8015.398845086642, 8184.181581841887, 8229.753107406787, 8308.210719981593, 8328.750137495885, 7811.765647030598, 7882.763517094496, 7952.125266220711, 8086.0, 8178.263956243966, 6445.45213656835, 6555.737770489127, 6597.274299827015, 6725.495587830835, 6827.385535301847, 1910.579672472054, 1943.0284857571214, 1986.5728868293386, 2027.523531969986, 2028.1887245102077, 970.834958057132, 1023.6519583341551, 1088.1294964028746, 1125.4429057616533, 1143.274020996673, 19391.70341042026, 20372.592548148954, 20469.795302047085, 20537.2811951581, 21105.26131585418, 1013.4089479517235, 1020.3622735790132, 1038.2109596706557, 1065.8219778468422, 1089.782043591285, 10910.836337454944, 11213.10295176384, 11254.38100904458, 11288.887111128948, 11316.20786544934, 413510.0, 416591.0, 520310.0, 528567.0, 544780.0, 102381.48809255906, 108638.45680771545, 109031.0, 111341.0, 112077.0, 474.87890587899864, 497.5174081141287, 497.6168350370267, 498.80546586831167, 499.5279460909406, 10720.731981700208, 10772.569097236023, 11665.708357291136, 11830.82253766177, 11839.76320473603, 44029.33955990727, 44784.328235075845, 44932.77533612311, 45708.4301817003, 46261.53738462572, 58297.0, 58408.70795646164, 63306.68346658237, 63976.36023639704, 64093.679531603906, 8592.957035214784, 8747.343949203709, 8807.207351338411, 8872.33457490678, 9023.684171053981, 10425.739356516147, 11426.48580813882, 12587.622371328875, 12724.872751272369, 14220.360083796048, 11204.439778010903, 11766.117541184274, 12076.818847717466, 12096.092793040381, 12383.19509231897, 11276.718082048015, 11520.769584608428, 11929.28424294545, 12272.693182670148, 12310.938445307716, 11506.884931150917, 11628.18602697803, 11646.76706465849, 12128.575499857463, 12198.451069701707, 8209.425340226366, 8432.5783710813, 8668.91331086681, 8726.607302671522, 8830.293576513735, 8669.783255418664, 11171.385573793194, 11561.537538498702, 12141.0, 12381.133320667466], "value": 9343.494350091974, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.7435136026877, 1528.3122594832325, 1659.7261751400576, 1805.1966874740745, 1816.2371803842384, 8075.9192408075905, 8749.431286966359, 8777.429467084643, 9359.438433693975, 9391.29565282604, 8881.777955551115, 8961.05908879568, 9093.54532273387, 9204.171624553788, 9214.585343659535, 2305.0318866076245, 2345.7067866516686, 2347.1784875293597, 2348.013834189636, 2355.340504658698, 2317.0, 2326.9185578504757, 2352.200251914349, 2372.4697570067297, 2377.9167729129485, 2234.6759719840616, 2237.1834280487587, 2238.0, 2249.415152060468, 2261.705978222829, 2265.6261716816707, 2274.7611500792345, 2274.795268425841, 2277.191596983064, 2289.9695137188332, 2209.2267706302828, 2210.4363387336125, 2230.721159855018, 2234.910603575855, 2236.575050740354, 9178.357514973955, 9207.125323094295, 9291.953540232324, 9295.953520232422, 9299.721008369692, 5212.452692467275, 5307.6019298552765, 5330.360356757175, 5360.195970604402, 5364.168553874156, 3379.357921994838, 3459.066052165901, 3469.7224222062428, 3492.266624008961, 3551.7158627309755, 1151.683287096047, 1156.7223866272118, 2249.8650080995194, 2308.5686874137973, 2322.4426137726823, 12658.81011784824, 12771.48914043437, 12772.744545109139, 12786.61640150797, 12791.936040319832, 4441.222786012435, 4451.265541185733, 4596.97701511497, 4602.355670206174, 4703.294505824086, 10094.747631309276, 10110.39337639744, 10119.190464762802, 10123.0, 10123.341982771097, 5162.174052151638, 5171.172612382001, 5177.0940085485645, 5208.765605547759, 5216.686998780086, 4269.210196113667, 4661.114388266286, 4777.331173635694, 4789.329493870791, 4818.8795280118275, 3838.5201849768778, 3844.8654297100024, 3889.766614003169, 3954.9604503955165, 3981.482407287034, 1149.2127892393737, 1156.8206927926017, 1167.2121318110242, 1182.467889449751, 1185.0637995983077, 979.3291595257272, 1035.0, 1058.5501162006271, 1060.6393826099163, 1078.428432930548, 6336.271328797156, 6504.577202481823, 6538.0, 6551.0, 6614.305497922745, 436.2692490079105, 440.66729619137345, 446.1523106098439, 448.6724690975606, 452.46609001378687, 4294.141171765659, 4358.4769827620885, 4371.540988196193, 4471.7987690554, 4475.597196252353, 10977.12183025356, 11189.776204475866, 11257.774844503065, 11366.545338186379, 11390.0, 10711.143108551298, 11282.605108821152, 11310.886891131147, 11312.660620181408, 11357.20499565039, 8211.876821847676, 8517.48895066298, 8610.268127209132, 8629.870551941725, 8640.438371505832, 6288.779892703917, 6573.112629794917, 6600.0, 6628.171478565179, 6682.632455214815, 10138.188944884245, 10518.263721539724, 10524.105451036748, 10615.203859710398, 10654.14766818668, 10771.89228107709, 10803.945980270048, 10893.0, 10897.29167604135, 10959.945200273947, 7426.14599321085, 7502.512336698097, 7739.729109481141, 8255.834883302421, 8404.831903362021, 8927.33045021639, 8941.37410381293, 8943.910560894308, 9012.684556040507, 9015.729528114167, 7517.887231691419, 7548.056492938383, 7637.541747495168, 7793.532388056735, 8081.0, 7793.61031948389, 8071.273585377344, 8121.106678265268, 8201.548914809742, 8213.137620549756, 7094.964525177341, 7334.083239595051, 7380.96309518449, 7388.889166662612, 7395.038644976119, 5400.486953739389, 5429.945700542944, 5473.534749546333, 5539.224508568885, 5587.217789509553, 5195.68825870449, 5198.0, 5322.228276899906, 5418.403975562606, 5509.559235261089], "value": 4711.0362293983035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.8995466428075, 319.16856588586734, 320.233041864734, 327.04176762087076, 328.1353633176579, 5609.354924183725, 5615.382307946123, 5683.715814209283, 5690.516306113986, 5692.402297758737, 5572.5263352615075, 5579.609427340088, 5615.522680572156, 5639.125935479997, 5646.830595082144, 4098.344264917607, 4212.368144778293, 4330.5669433056755, 4339.088791353819, 4339.41417908583, 4267.530571637118, 4324.286492728696, 4334.84828031019, 4340.97829510852, 4345.109252603209, 4312.2453570625175, 4327.826886924519, 4349.673774466912, 4351.129774045188, 4351.151525452538, 4219.725717828347, 4294.892627684301, 4301.720388174758, 4306.224879521685, 4310.482742070972, 3766.2655782122497, 3772.7736335819664, 3786.8295926683363, 3788.015116069814, 3795.525559305087, 5375.462453754632, 5463.808766693147, 5464.26232458617, 5481.397046324901, 5496.642718223343, 4892.608591312686, 4935.975320123376, 4938.876528086791, 4944.851654450372, 4999.650024498286, 5768.711564421762, 5824.737886795105, 5835.737391817336, 5843.0, 5874.882502349929, 4159.168166366709, 4161.271777438936, 4173.812178451977, 4178.770167640779, 4187.91624167515, 5872.970635146839, 5960.731767070492, 6000.699965001776, 6014.8496287592725, 6118.736067654996, 4261.998430368861, 4264.530901600821, 4267.551907049778, 4268.765217913045, 4269.612375977757, 4322.200392927319, 4324.221640104748, 4333.371661109121, 4335.783210839445, 4339.045410009856, 4886.3403440535785, 4935.950640493621, 4997.225430058346, 5002.749862506933, 5007.148784706608, 5895.734691938873, 5900.64596124234, 5900.822975310747, 5927.436893495111, 5930.673812940329, 1446.464808021018, 1464.8974571779872, 1470.7132109238596, 1478.8003619511228, 1481.2445652717192, 905.542700936023, 934.8921527989219, 936.8220038192858, 941.9685444438466, 943.5612440215333, 5008.273800298936, 5047.848564543069, 5053.2420136979745, 5074.188129899272, 5099.87250318745, 5246.56034943753, 5279.234510995961, 5308.442613525602, 5331.733413329318, 5339.599530035263, 4991.67554108989, 4995.575376093073, 5363.329583802025, 5805.448482394166, 5813.76744930198, 3210.197450637341, 3229.757768167397, 3235.1750303672884, 3242.4974129010043, 3256.706896379337, 6217.658028808459, 6297.4962003039645, 6308.936910630835, 6357.615894039735, 6385.393387628168, 6082.178905847654, 6111.694415279218, 6146.293176284695, 6186.123452594565, 6189.164462797465, 6298.7795427160745, 6307.2431308242385, 6314.55798094129, 6319.96840015797, 6344.0, 5853.94146058534, 6021.518278537794, 6023.66869822164, 6037.577369584087, 6127.713180232201, 6048.304444988883, 6050.788222412194, 6075.544334175043, 6085.0, 6087.36082711309, 5988.933817832841, 6211.844703882259, 6227.252729672468, 6301.991681331148, 6308.747650094128, 4262.914741705086, 4297.505786834429, 4310.504292006334, 4313.749012786382, 4330.7401555906745, 5886.558508111823, 5915.349311575809, 6048.274207095177, 6141.938580614136, 6174.475169610633, 5884.9705751470965, 5886.735096920564, 5890.322612899571, 5926.199963005111, 5946.810637872356, 5617.887642247214, 5928.288605367211, 5941.613795103304, 5941.792037278848, 5957.255343082114, 5779.162021506942, 5799.188113664006, 5805.970970145122, 5813.476787089182, 5815.738291776965, 5875.970620146872, 5913.34953155144, 5920.940790592039, 5934.43622855828, 5947.364474769473, 5651.915221271602, 5761.596688231783, 5794.246747922743, 5810.4189581041555, 5826.42686474658], "value": 4425.9014979247495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.1220590218293, 760.6348952502802, 765.6248438265249, 769.2615089514067, 817.4114637461028, 14083.859161408396, 15007.549773506786, 15012.174330411823, 15022.173780442085, 15024.924875375607, 12923.418446169944, 14766.187859667714, 14769.704605907902, 14779.704405911876, 14801.851981480182, 793.1632128104861, 809.4536188073027, 809.76516810125, 810.1129263456505, 814.5194335342147, 801.7554645833019, 810.0603300171801, 811.1158836867813, 811.2617518058568, 814.5601375257354, 869.1612593846936, 873.6723728601775, 873.8558137907238, 874.1651722604929, 875.1948207648978, 861.1517655109743, 865.7705707987388, 868.3010176807667, 868.3183700794846, 872.3457406944791, 628.4501061571125, 628.538024551954, 629.5624540944045, 630.593267342566, 633.6831584207896, 12982.935085324607, 13096.410661520255, 13616.93191534046, 13639.659008524766, 13642.658933526742, 13075.738485230242, 13107.14803537767, 13248.602541923758, 13264.204147751167, 13321.13412628176, 11667.474963626657, 11688.47401866918, 11717.296962182296, 11825.935665790033, 11981.041516678644, 3692.8522859085606, 3778.2821263960036, 3830.0616348994395, 3831.770093794353, 3895.1625400538737, 77896.61051694705, 82112.0, 83039.0, 83199.5840020796, 83336.58331708303, 9991.950040249898, 10164.847527287096, 10299.12457441111, 10336.793264134825, 10572.36565806054, 20537.58924821495, 20559.8972005139, 20576.279830205873, 20612.175512979313, 21647.891760541097, 8414.537200454033, 8469.153084691605, 8487.787805304917, 8635.309175265964, 8721.869171962426, 4668.929966050512, 4711.434627844681, 4764.118638051971, 4836.685615434985, 4885.193942999436, 3717.386631205821, 3812.733108682421, 3862.1503269280715, 3867.2845523577666, 3874.438206460104, 703.5743375257895, 708.4651088428204, 711.8576284743073, 718.0952000479433, 724.8803947348629, 705.7036044861171, 748.6593599912027, 760.6919197724931, 761.4441457735884, 762.7482930632989, 10131.290809643402, 10171.54228059739, 10183.075508654187, 10594.379755936912, 10729.517171727135, 673.1787219592089, 745.9351006664685, 759.4038679636459, 771.8572064168147, 778.3111945927894, 4903.141950158708, 5139.331886854759, 5164.096283150434, 5201.869953251124, 5214.13966695491, 126591.0, 128786.0, 129216.35391822981, 130730.0, 136847.0, 82157.58921205356, 92746.36268186563, 93804.53097734468, 94385.0, 119829.0, 56288.71855640777, 56303.71848140815, 91019.0, 92626.0, 94324.0, 9505.619775208914, 9685.661001865183, 10603.787924241318, 10676.359418434919, 10769.838452423062, 52664.21003684871, 52715.472845271055, 53617.46382536281, 53693.73153134209, 53920.73039634777, 71782.64108679423, 71912.64043679748, 79455.0, 81351.0, 81852.18147818446, 13130.474781008652, 13313.600591982256, 13688.794668079787, 13963.301834908418, 14043.508477203657, 13624.93187534056, 13896.096753710977, 14163.787543186654, 15215.08709477435, 15468.381264749283, 14375.568732938029, 14393.352299146354, 14618.195999219719, 15409.84590154129, 15428.84571154319, 13307.334633268492, 14297.356618951964, 14900.180490072717, 14905.701885962437, 14932.701345972802, 14073.788893166406, 14269.857301426853, 14341.498047568284, 14360.138391696531, 14451.421943122157, 10535.883694016333, 10622.36265824053, 10660.573577057141, 11057.281276716987, 11218.66344009681, 11982.820257696316, 12339.197952133083, 12466.501339946662, 12486.250824950532, 12603.306818125091], "value": 7695.6694388773585, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 106.0, 111.0, 115.0, 112.0, 114.0, 110.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 143.0, 170.0, 125.0, 143.0, 147.0, 119.0, 168.0, 120.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 165.0, 163.0, 165.0, 171.0, 165.0, 162.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 157.0, 77.0, 76.0, 76.0, 76.0, 162.0, 76.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 151.0, 85.0, 83.0, 85.0, 145.0, 85.0, 83.0, 151.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 101.0, 96.0, 96.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 53.0, 64.0, 53.0, 53.0, 54.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 66.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 74.0, 74.0, 76.0, 78.0, 77.0, 75.0, 82.0, 81.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 134.0, 131.0, 123.0, 138.0, 121.0, 123.0, 123.0, 177.0, 124.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 156.0, 160.0, 156.0, 158.0, 164.0, 153.0, 158.0, 159.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 65.0, 65.0, 63.0, 64.0, 61.0, 71.0, 61.0], "value": 64.3, "unit": "score"}]}]} 19:34:58 INFO - Return code: 0 19:34:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:34:58 ERROR - # TBPL SUCCESS # 19:34:58 INFO - Running post-action listener: _resource_record_post_action 19:34:58 INFO - ##### 19:34:58 INFO - ##### Finished run-tests step (success) 19:34:58 INFO - ##### 19:34:58 INFO - Running post-run listener: _resource_record_post_run 19:34:58 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 566910976; Read time: 8; Write time: 561084 19:34:58 INFO - TinderboxPrint: CPU usage
13.3% 19:34:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:34:58 INFO - TinderboxPrint: I/O write bytes / time
566,910,976 / 561,084 19:34:58 INFO - TinderboxPrint: CPU idle
8,232.5 (86.7%) 19:34:58 INFO - TinderboxPrint: CPU user
1,207.0 (12.7%) 19:34:58 INFO - TinderboxPrint: Swap in / out
0 / 0 19:34:58 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 264417280; Read time: 0; Write time: 276540 19:34:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297979904; Read time: 0; Write time: 284072 19:34:59 INFO - Running post-run listener: _upload_blobber_files 19:34:59 INFO - Blob upload gear active. 19:34:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:34:59 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 19:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:34:59 INFO - (blobuploader) - INFO - Open directory for files ... 19:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:00 INFO - (blobuploader) - INFO - Done attempting. 19:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:00 INFO - (blobuploader) - INFO - Done attempting. 19:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:04 INFO - (blobuploader) - INFO - Done attempting. 19:35:04 INFO - (blobuploader) - INFO - Iteration through files over. 19:35:04 INFO - Return code: 0 19:35:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:35:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:35:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b027549644a1e08914657f9d485b385b512bab8548912df2cde9fafc6a767454b8ecdcf754016b04cd7d1a1693c6374d905af111365edef24c35baccc2d4c661", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e279014de3737c4c858dc987bac797f929ba0aacf48c02af313d5dc53c6cd9ff5a93175e18e94fce933f092a1653acfe632e63805df2399c3f0761d296e28f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d139d854f6cab7b4c60fe262b2c9b3cd7974e44f5a7dd99d00b81d6bdcdc241677e9a2d4713dc5a03df9ce222d3115795ee0369c08583d3dec8d645a61023f55"} 19:35:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:35:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:35:04 INFO - Contents: 19:35:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b027549644a1e08914657f9d485b385b512bab8548912df2cde9fafc6a767454b8ecdcf754016b04cd7d1a1693c6374d905af111365edef24c35baccc2d4c661", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e279014de3737c4c858dc987bac797f929ba0aacf48c02af313d5dc53c6cd9ff5a93175e18e94fce933f092a1653acfe632e63805df2399c3f0761d296e28f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d139d854f6cab7b4c60fe262b2c9b3cd7974e44f5a7dd99d00b81d6bdcdc241677e9a2d4713dc5a03df9ce222d3115795ee0369c08583d3dec8d645a61023f55"} 19:35:04 INFO - Running post-run listener: copy_logs_to_upload_dir 19:35:04 INFO - Copying logs to upload dir... 19:35:04 INFO - mkdir: /builds/slave/test/build/upload/logs 19:35:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.356209 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-13 19:35:04.250163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 19:35:04.254560) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b027549644a1e08914657f9d485b385b512bab8548912df2cde9fafc6a767454b8ecdcf754016b04cd7d1a1693c6374d905af111365edef24c35baccc2d4c661", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e279014de3737c4c858dc987bac797f929ba0aacf48c02af313d5dc53c6cd9ff5a93175e18e94fce933f092a1653acfe632e63805df2399c3f0761d296e28f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d139d854f6cab7b4c60fe262b2c9b3cd7974e44f5a7dd99d00b81d6bdcdc241677e9a2d4713dc5a03df9ce222d3115795ee0369c08583d3dec8d645a61023f55"} build_url:https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b027549644a1e08914657f9d485b385b512bab8548912df2cde9fafc6a767454b8ecdcf754016b04cd7d1a1693c6374d905af111365edef24c35baccc2d4c661", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e279014de3737c4c858dc987bac797f929ba0aacf48c02af313d5dc53c6cd9ff5a93175e18e94fce933f092a1653acfe632e63805df2399c3f0761d296e28f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d139d854f6cab7b4c60fe262b2c9b3cd7974e44f5a7dd99d00b81d6bdcdc241677e9a2d4713dc5a03df9ce222d3115795ee0369c08583d3dec8d645a61023f55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 19:35:04.286878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:35:04.287244) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468456393.224510-540081515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:35:04.369974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 19:35:04.370351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 19:35:04.370644) ========= ========= Total master_lag: 0.19 =========