builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1467378011.35 results: success (0) buildid: 20160701030235 builduid: 8cdbe4bf704d4acda6e5b754f67536db revision: fdcee57b4e4f66a82831ab01e61500da98a858e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:11.351516) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:11.352002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:11.352280) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:11.369564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:11.369957) ========= 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=923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 06:00:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-07-01 06:00:11 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:11.506676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:11.507218) ========= 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=923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019728 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:11.557441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:11.557801) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fdcee57b4e4f66a82831ab01e61500da98a858e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fdcee57b4e4f66a82831ab01e61500da98a858e8 --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=923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 06:00:11,763 truncating revision to first 12 chars 2016-07-01 06:00:11,763 Setting DEBUG logging. 2016-07-01 06:00:11,763 attempt 1/10 2016-07-01 06:00:11,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fdcee57b4e4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 06:00:12,079 unpacking tar archive at: mozilla-central-fdcee57b4e4f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653452 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:12.224986) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:12.225308) ========= script_repo_revision: fdcee57b4e4f66a82831ab01e61500da98a858e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:12.225709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:12.225991) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 06:00:12.234964) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-01 06:00:12.235355) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:00:12 INFO - MultiFileLogger online at 20160701 06:00:12 in /builds/slave/test 06:00:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:00:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:00:12 INFO - {'append_to_log': False, 06:00:12 INFO - 'base_work_dir': '/builds/slave/test', 06:00:12 INFO - 'blob_upload_branch': 'Firefox', 06:00:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:00:12 INFO - 'branch': 'Firefox', 06:00:12 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:12 INFO - 'config_files': ('talos/linux_config.py',), 06:00:12 INFO - 'default_actions': ('clobber', 06:00:12 INFO - 'read-buildbot-config', 06:00:12 INFO - 'download-and-extract', 06:00:12 INFO - 'populate-webroot', 06:00:12 INFO - 'create-virtualenv', 06:00:12 INFO - 'install', 06:00:12 INFO - 'run-tests'), 06:00:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:12 INFO - 'download_minidump_stackwalk': True, 06:00:12 INFO - 'download_symbols': 'ondemand', 06:00:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:12 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:12 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:12 INFO - 'installer_path': 'installer.exe', 06:00:12 INFO - 'log_level': 'info', 06:00:12 INFO - 'log_name': 'talos', 06:00:12 INFO - 'log_to_console': True, 06:00:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:00:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:00:12 INFO - 'opt_config_files': (), 06:00:12 INFO - 'pip_index': False, 06:00:12 INFO - 'sps_profile': False, 06:00:12 INFO - 'sps_profile_interval': 0, 06:00:12 INFO - 'suite': 'dromaeojs', 06:00:12 INFO - 'system_bits': '32', 06:00:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:12 INFO - 'title': 'talos-linux64-ix-007', 06:00:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:12 INFO - 'use_talos_json': True, 06:00:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:00:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:12 INFO - 'work_dir': 'build'} 06:00:12 INFO - ##### 06:00:12 INFO - ##### Running clobber step. 06:00:12 INFO - ##### 06:00:12 INFO - Running pre-action listener: _resource_record_pre_action 06:00:12 INFO - Running main action method: clobber 06:00:12 INFO - rmtree: /builds/slave/test/build 06:00:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:00:13 INFO - Running post-action listener: _resource_record_post_action 06:00:13 INFO - ##### 06:00:13 INFO - ##### Finished clobber step (success) 06:00:13 INFO - ##### 06:00:13 INFO - ##### 06:00:13 INFO - ##### Running read-buildbot-config step. 06:00:13 INFO - ##### 06:00:13 INFO - Running pre-action listener: _resource_record_pre_action 06:00:13 INFO - Running main action method: read_buildbot_config 06:00:13 INFO - Using buildbot properties: 06:00:13 INFO - { 06:00:13 INFO - "project": "", 06:00:13 INFO - "product": "firefox", 06:00:13 INFO - "script_repo_revision": "production", 06:00:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:00:13 INFO - "repository": "", 06:00:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:00:13 INFO - "buildid": "20160701030235", 06:00:13 INFO - "stage_platform": "linux64-pgo", 06:00:13 INFO - "basedir": "/builds/slave/test", 06:00:13 INFO - "nightly_build": "True", 06:00:13 INFO - "buildnumber": 358, 06:00:13 INFO - "slavename": "talos-linux64-ix-007", 06:00:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:00:13 INFO - "platform": "ubuntu64_hw", 06:00:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:00:13 INFO - "branch": "mozilla-central", 06:00:13 INFO - "repo_path": "mozilla-central", 06:00:13 INFO - "revision": "fdcee57b4e4f66a82831ab01e61500da98a858e8", 06:00:13 INFO - "pgo_build": "True", 06:00:13 INFO - "builduid": "8cdbe4bf704d4acda6e5b754f67536db", 06:00:13 INFO - "slavebuilddir": "test" 06:00:13 INFO - } 06:00:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:00:13 INFO - Running post-action listener: _resource_record_post_action 06:00:13 INFO - ##### 06:00:13 INFO - ##### Finished read-buildbot-config step (success) 06:00:13 INFO - ##### 06:00:13 INFO - ##### 06:00:13 INFO - ##### Running download-and-extract step. 06:00:13 INFO - ##### 06:00:13 INFO - Running pre-action listener: _resource_record_pre_action 06:00:13 INFO - Running main action method: download_and_extract 06:00:13 INFO - mkdir: /builds/slave/test/build/tests 06:00:13 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')]} 06:00:13 INFO - https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:00:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:00:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:00:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:13 INFO - Downloaded 1361 bytes. 06:00:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:00:13 INFO - Using the following test package requirements: 06:00:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:00:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:00:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:13 INFO - u'jsshell-linux-x86_64.zip'], 06:00:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:00:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:00:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:00:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:00:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:00:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:00:13 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')]} 06:00:13 INFO - https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:00:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:00:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:14 INFO - Downloaded 24270534 bytes. 06:00:14 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'] 06:00:14 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 06:00:16 INFO - Return code: 0 06:00:16 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 06:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:16 INFO - https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:17 INFO - Downloaded 24270534 bytes. 06:00:17 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'] 06:00:17 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 06:00:18 INFO - Return code: 0 06:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:18 INFO - https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:19 INFO - Downloaded 14405242 bytes. 06:00:19 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'] 06:00:19 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 06:00:19 INFO - Return code: 0 06:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:19 INFO - https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UGh7v4PyTHe_u70s6Uuhcg/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 06:00:21 INFO - Downloaded 60336112 bytes. 06:00:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:00:21 INFO - mkdir: /builds/slave/test/properties 06:00:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:00:21 INFO - Writing to file /builds/slave/test/properties/build_url 06:00:21 INFO - Contents: 06:00:21 INFO - build_url:https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:00:22 INFO - Running post-action listener: _resource_record_post_action 06:00:22 INFO - Running post-action listener: set_extra_try_arguments 06:00:22 INFO - ##### 06:00:22 INFO - ##### Finished download-and-extract step (success) 06:00:22 INFO - ##### 06:00:22 INFO - ##### 06:00:22 INFO - ##### Running populate-webroot step. 06:00:22 INFO - ##### 06:00:22 INFO - Running pre-action listener: _resource_record_pre_action 06:00:22 INFO - Running main action method: populate_webroot 06:00:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:22 INFO - '--tppagecycles', 06:00:22 INFO - '7'], 06:00:22 INFO - 'tests': ['tsvgm']}}, 06:00:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:00:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:00:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:00:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:22 INFO - 'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:22 INFO - 'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['damp', 'tps']}, 06:00:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:22 INFO - 'tests': ['damp', 'tps']}, 06:00:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['dromaeo_dom']}, 06:00:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['basic_compositor_video']}, 06:00:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:00:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['a11yr', 06:00:22 INFO - 'ts_paint', 06:00:22 INFO - 'tpaint', 06:00:22 INFO - 'sessionrestore', 06:00:22 INFO - 'sessionrestore_no_auto_restore', 06:00:22 INFO - 'tabpaint']}, 06:00:22 INFO - 'other-e10s': {'tests': ['a11yr', 06:00:22 INFO - 'ts_paint', 06:00:22 INFO - 'tpaint', 06:00:22 INFO - 'sessionrestore', 06:00:22 INFO - 'sessionrestore_no_auto_restore', 06:00:22 INFO - 'tabpaint']}, 06:00:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:00:22 INFO - 'ts_paint', 06:00:22 INFO - 'tpaint', 06:00:22 INFO - 'sessionrestore', 06:00:22 INFO - 'sessionrestore_no_auto_restore', 06:00:22 INFO - 'tabpaint']}, 06:00:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:00:22 INFO - 'ts_paint', 06:00:22 INFO - 'tpaint', 06:00:22 INFO - 'sessionrestore', 06:00:22 INFO - 'sessionrestore_no_auto_restore', 06:00:22 INFO - 'tabpaint']}, 06:00:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['a11yr', 06:00:22 INFO - 'ts_paint', 06:00:22 INFO - 'tpaint', 06:00:22 INFO - 'sessionrestore', 06:00:22 INFO - 'sessionrestore_no_auto_restore', 06:00:22 INFO - 'tabpaint']}, 06:00:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['a11yr', 06:00:22 INFO - 'ts_paint', 06:00:22 INFO - 'tpaint', 06:00:22 INFO - 'sessionrestore', 06:00:22 INFO - 'sessionrestore_no_auto_restore', 06:00:22 INFO - 'tabpaint']}, 06:00:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['tsvgx', 06:00:22 INFO - 'tsvgr_opacity', 06:00:22 INFO - 'tart', 06:00:22 INFO - 'tscrollx', 06:00:22 INFO - 'cart']}, 06:00:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:00:22 INFO - 'tsvgr_opacity', 06:00:22 INFO - 'tart', 06:00:22 INFO - 'tscrollx', 06:00:22 INFO - 'cart']}, 06:00:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:22 INFO - 'talos_options': ['--disable-e10s'], 06:00:22 INFO - 'tests': ['tp5o']}, 06:00:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:22 INFO - 'tests': ['tp5o']}, 06:00:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:22 INFO - 'talos_options': ['--disable-e10s', 06:00:22 INFO - '--xperf_path', 06:00:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:22 INFO - 'tests': ['tp5n']}, 06:00:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:22 INFO - 'talos_options': ['--xperf_path', 06:00:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:22 INFO - 'tests': ['tp5n']}}, 06:00:22 INFO - 'talos.zip': {'path': '', 06:00:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:22 INFO - Running post-action listener: _resource_record_post_action 06:00:22 INFO - ##### 06:00:22 INFO - ##### Finished populate-webroot step (success) 06:00:22 INFO - ##### 06:00:22 INFO - ##### 06:00:22 INFO - ##### Running create-virtualenv step. 06:00:22 INFO - ##### 06:00:22 INFO - Running pre-action listener: _resource_record_pre_action 06:00:22 INFO - Running main action method: create_virtualenv 06:00:22 INFO - Creating virtualenv /builds/slave/test/build/venv 06:00:22 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 06:00:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:00:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:22 INFO - Using real prefix '/usr' 06:00:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:00:23 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:25 INFO - Installing pip.................done. 06:00:25 INFO - Return code: 0 06:00:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:25 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 0x1702030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, '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': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', '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 06:00:25 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 06:00:25 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 06:00:25 INFO - Using env: {'DISPLAY': ':0', 06:00:25 INFO - 'HOME': '/home/cltbld', 06:00:25 INFO - 'LANG': 'en_US.UTF-8', 06:00:25 INFO - 'LANGUAGE': 'en_US:en', 06:00:25 INFO - 'LOGNAME': 'cltbld', 06:00:25 INFO - 'MAIL': '/var/mail/cltbld', 06:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:25 INFO - 'MOZ_NO_REMOTE': '1', 06:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:25 INFO - 'NO_EM_RESTART': '1', 06:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:25 INFO - 'PWD': '/builds/slave/test', 06:00:25 INFO - 'SHELL': '/bin/bash', 06:00:25 INFO - 'SHLVL': '1', 06:00:25 INFO - 'TERM': 'linux', 06:00:25 INFO - 'TMOUT': '86400', 06:00:25 INFO - 'USER': 'cltbld', 06:00:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:25 INFO - '_': '/tools/buildbot/bin/python'} 06:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:25 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 06:00:25 INFO - Cleaning up... 06:00:25 INFO - Return code: 0 06:00:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:25 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 0x1702030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, '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': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', '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 06:00:25 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 06:00:25 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 06:00:25 INFO - Using env: {'DISPLAY': ':0', 06:00:25 INFO - 'HOME': '/home/cltbld', 06:00:25 INFO - 'LANG': 'en_US.UTF-8', 06:00:25 INFO - 'LANGUAGE': 'en_US:en', 06:00:25 INFO - 'LOGNAME': 'cltbld', 06:00:25 INFO - 'MAIL': '/var/mail/cltbld', 06:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:25 INFO - 'MOZ_NO_REMOTE': '1', 06:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:25 INFO - 'NO_EM_RESTART': '1', 06:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:25 INFO - 'PWD': '/builds/slave/test', 06:00:25 INFO - 'SHELL': '/bin/bash', 06:00:25 INFO - 'SHLVL': '1', 06:00:25 INFO - 'TERM': 'linux', 06:00:25 INFO - 'TMOUT': '86400', 06:00:25 INFO - 'USER': 'cltbld', 06:00:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:25 INFO - '_': '/tools/buildbot/bin/python'} 06:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:25 INFO - Downloading/unpacking psutil>=3.1.1 06:00:25 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 06:00:25 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 06:00:25 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 06:00:25 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 06:00:25 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 06:00:25 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 06:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:27 INFO - Installing collected packages: psutil 06:00:27 INFO - Running setup.py install for psutil 06:00:27 INFO - building 'psutil._psutil_linux' extension 06:00:27 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 06:00:27 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 06:00:27 INFO - building 'psutil._psutil_posix' extension 06:00:27 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 06:00:28 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 06:00:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:28 INFO - Successfully installed psutil 06:00:28 INFO - Cleaning up... 06:00:28 INFO - Return code: 0 06:00:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:28 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 0x1702030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, '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': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', '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 06:00:28 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 06:00:28 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 06:00:28 INFO - Using env: {'DISPLAY': ':0', 06:00:28 INFO - 'HOME': '/home/cltbld', 06:00:28 INFO - 'LANG': 'en_US.UTF-8', 06:00:28 INFO - 'LANGUAGE': 'en_US:en', 06:00:28 INFO - 'LOGNAME': 'cltbld', 06:00:28 INFO - 'MAIL': '/var/mail/cltbld', 06:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:28 INFO - 'MOZ_NO_REMOTE': '1', 06:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:28 INFO - 'NO_EM_RESTART': '1', 06:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:28 INFO - 'PWD': '/builds/slave/test', 06:00:28 INFO - 'SHELL': '/bin/bash', 06:00:28 INFO - 'SHLVL': '1', 06:00:28 INFO - 'TERM': 'linux', 06:00:28 INFO - 'TMOUT': '86400', 06:00:28 INFO - 'USER': 'cltbld', 06:00:28 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:28 INFO - '_': '/tools/buildbot/bin/python'} 06:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:00:28 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 06:00:28 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 06:00:28 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 06:00:28 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 06:00:28 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 06:00:28 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 06:00:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:00:30 INFO - Installing collected packages: mozsystemmonitor 06:00:30 INFO - Running setup.py install for mozsystemmonitor 06:00:30 INFO - Successfully installed mozsystemmonitor 06:00:30 INFO - Cleaning up... 06:00:30 INFO - Return code: 0 06:00:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:00:30 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')]} 06:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:30 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')]} 06:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:30 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 0x1702030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, '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': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', '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 06:00:30 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 06:00:30 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 06:00:30 INFO - Using env: {'DISPLAY': ':0', 06:00:30 INFO - 'HOME': '/home/cltbld', 06:00:30 INFO - 'LANG': 'en_US.UTF-8', 06:00:30 INFO - 'LANGUAGE': 'en_US:en', 06:00:30 INFO - 'LOGNAME': 'cltbld', 06:00:30 INFO - 'MAIL': '/var/mail/cltbld', 06:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:30 INFO - 'MOZ_NO_REMOTE': '1', 06:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:30 INFO - 'NO_EM_RESTART': '1', 06:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:30 INFO - 'PWD': '/builds/slave/test', 06:00:30 INFO - 'SHELL': '/bin/bash', 06:00:30 INFO - 'SHLVL': '1', 06:00:30 INFO - 'TERM': 'linux', 06:00:30 INFO - 'TMOUT': '86400', 06:00:30 INFO - 'USER': 'cltbld', 06:00:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:30 INFO - '_': '/tools/buildbot/bin/python'} 06:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:30 INFO - Downloading/unpacking jsonschema==2.5.1 06:00:30 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 06:00:30 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 06:00:30 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 06:00:30 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 06:00:30 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 06:00:30 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 06:00:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:00:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:32 INFO - Downloading functools32-3.2.3-2.tar.gz 06:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:00:32 INFO - warning: no files found matching '*.txt' 06:00:32 INFO - no previously-included directories found matching 'build' 06:00:32 INFO - no previously-included directories found matching 'dist' 06:00:32 INFO - no previously-included directories found matching '.git*' 06:00:32 INFO - Installing collected packages: jsonschema, functools32 06:00:32 INFO - Running setup.py install for functools32 06:00:32 INFO - warning: no files found matching '*.txt' 06:00:32 INFO - no previously-included directories found matching 'build' 06:00:32 INFO - no previously-included directories found matching 'dist' 06:00:32 INFO - no previously-included directories found matching '.git*' 06:00:33 INFO - Successfully installed jsonschema functools32 06:00:33 INFO - Cleaning up... 06:00:33 INFO - Return code: 0 06:00:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:00:33 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')]} 06:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:33 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')]} 06:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:33 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 0x1702030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, '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': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', '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 06:00:33 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 06:00:33 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 06:00:33 INFO - Using env: {'DISPLAY': ':0', 06:00:33 INFO - 'HOME': '/home/cltbld', 06:00:33 INFO - 'LANG': 'en_US.UTF-8', 06:00:33 INFO - 'LANGUAGE': 'en_US:en', 06:00:33 INFO - 'LOGNAME': 'cltbld', 06:00:33 INFO - 'MAIL': '/var/mail/cltbld', 06:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:33 INFO - 'MOZ_NO_REMOTE': '1', 06:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:33 INFO - 'NO_EM_RESTART': '1', 06:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:33 INFO - 'PWD': '/builds/slave/test', 06:00:33 INFO - 'SHELL': '/bin/bash', 06:00:33 INFO - 'SHLVL': '1', 06:00:33 INFO - 'TERM': 'linux', 06:00:33 INFO - 'TMOUT': '86400', 06:00:33 INFO - 'USER': 'cltbld', 06:00:33 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:33 INFO - '_': '/tools/buildbot/bin/python'} 06:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:33 INFO - Downloading/unpacking blobuploader==1.2.4 06:00:33 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 06:00:33 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 06:00:33 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 06:00:33 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 06:00:33 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 06:00:33 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 06:00:35 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00:35 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 06:00:35 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 06:00:35 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 06:00:35 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 06:00:35 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 06:00:35 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 06:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:00:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00:35 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 06:00:35 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 06:00:35 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 06:00:35 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 06:00:35 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 06:00:35 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 06:00:35 INFO - Downloading docopt-0.6.1.tar.gz 06:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:35 INFO - Running setup.py install for blobuploader 06:00:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:00:36 INFO - Running setup.py install for requests 06:00:36 INFO - Running setup.py install for docopt 06:00:36 INFO - Successfully installed blobuploader requests docopt 06:00:36 INFO - Cleaning up... 06:00:36 INFO - Return code: 0 06:00:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:36 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 0x1702030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, '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': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', '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 06:00:36 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 06:00:36 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 06:00:36 INFO - Using env: {'DISPLAY': ':0', 06:00:36 INFO - 'HOME': '/home/cltbld', 06:00:36 INFO - 'LANG': 'en_US.UTF-8', 06:00:36 INFO - 'LANGUAGE': 'en_US:en', 06:00:36 INFO - 'LOGNAME': 'cltbld', 06:00:36 INFO - 'MAIL': '/var/mail/cltbld', 06:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:36 INFO - 'MOZ_NO_REMOTE': '1', 06:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:36 INFO - 'NO_EM_RESTART': '1', 06:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:36 INFO - 'PWD': '/builds/slave/test', 06:00:36 INFO - 'SHELL': '/bin/bash', 06:00:36 INFO - 'SHLVL': '1', 06:00:36 INFO - 'TERM': 'linux', 06:00:36 INFO - 'TMOUT': '86400', 06:00:36 INFO - 'USER': 'cltbld', 06:00:36 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:36 INFO - '_': '/tools/buildbot/bin/python'} 06:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:36 INFO - Running setup.py (path:/tmp/pip-3bEP0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:36 INFO - Running setup.py (path:/tmp/pip-zEImRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:36 INFO - Running setup.py (path:/tmp/pip-Uu1B1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:36 INFO - Running setup.py (path:/tmp/pip-VufSqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:37 INFO - Running setup.py (path:/tmp/pip-oAUzIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:37 INFO - Running setup.py (path:/tmp/pip-mULhay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:37 INFO - Running setup.py (path:/tmp/pip-93z2xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:37 INFO - Running setup.py (path:/tmp/pip-rq3ned-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:37 INFO - Running setup.py (path:/tmp/pip-57IZDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:37 INFO - Running setup.py (path:/tmp/pip-DO_r3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:37 INFO - Running setup.py (path:/tmp/pip-3weFeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:37 INFO - Running setup.py (path:/tmp/pip-9tt7lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:37 INFO - Running setup.py (path:/tmp/pip-SpmFCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:37 INFO - Running setup.py (path:/tmp/pip-znNIqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:37 INFO - Running setup.py (path:/tmp/pip-mMEVxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:37 INFO - Running setup.py (path:/tmp/pip-FgZigG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:37 INFO - Running setup.py (path:/tmp/pip-zORKnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:00:37 INFO - Running setup.py install for manifestparser 06:00:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Running setup.py install for mozcrash 06:00:38 INFO - Running setup.py install for mozdebug 06:00:38 INFO - Running setup.py install for mozdevice 06:00:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Running setup.py install for mozfile 06:00:38 INFO - Running setup.py install for mozhttpd 06:00:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Running setup.py install for mozinfo 06:00:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Running setup.py install for mozInstall 06:00:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Running setup.py install for mozleak 06:00:38 INFO - Running setup.py install for mozlog 06:00:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:00:38 INFO - Running setup.py install for moznetwork 06:00:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:00:39 INFO - Running setup.py install for mozprocess 06:00:39 INFO - Running setup.py install for mozprofile 06:00:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:00:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:00:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:00:39 INFO - Running setup.py install for mozrunner 06:00:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:00:39 INFO - Running setup.py install for mozscreenshot 06:00:39 INFO - Running setup.py install for moztest 06:00:39 INFO - Running setup.py install for mozversion 06:00:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:00:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:00:39 INFO - Cleaning up... 06:00:39 INFO - Return code: 0 06:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:39 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 0x1702030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, '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': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', '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 06:00:39 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 06:00:39 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 06:00:39 INFO - Using env: {'DISPLAY': ':0', 06:00:39 INFO - 'HOME': '/home/cltbld', 06:00:39 INFO - 'LANG': 'en_US.UTF-8', 06:00:39 INFO - 'LANGUAGE': 'en_US:en', 06:00:39 INFO - 'LOGNAME': 'cltbld', 06:00:39 INFO - 'MAIL': '/var/mail/cltbld', 06:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:39 INFO - 'MOZ_NO_REMOTE': '1', 06:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:39 INFO - 'NO_EM_RESTART': '1', 06:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:39 INFO - 'PWD': '/builds/slave/test', 06:00:39 INFO - 'SHELL': '/bin/bash', 06:00:39 INFO - 'SHLVL': '1', 06:00:39 INFO - 'TERM': 'linux', 06:00:39 INFO - 'TMOUT': '86400', 06:00:39 INFO - 'USER': 'cltbld', 06:00:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:39 INFO - '_': '/tools/buildbot/bin/python'} 06:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:39 INFO - Running setup.py (path:/tmp/pip-XJf1pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:40 INFO - Running setup.py (path:/tmp/pip-4rjrc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:40 INFO - Running setup.py (path:/tmp/pip-UgXxCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:40 INFO - Running setup.py (path:/tmp/pip-3K3x9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:40 INFO - Running setup.py (path:/tmp/pip-VF2KJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:40 INFO - Running setup.py (path:/tmp/pip-QUDTTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:40 INFO - Running setup.py (path:/tmp/pip-R9hfsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:40 INFO - Running setup.py (path:/tmp/pip-FoRwyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:40 INFO - Running setup.py (path:/tmp/pip-UydEb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:40 INFO - Running setup.py (path:/tmp/pip-S3K1OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:40 INFO - Running setup.py (path:/tmp/pip-zNnxfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:40 INFO - Running setup.py (path:/tmp/pip-TW8g3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:40 INFO - Running setup.py (path:/tmp/pip-iAmIVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:40 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)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:40 INFO - Running setup.py (path:/tmp/pip-4kKwwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:40 INFO - Running setup.py (path:/tmp/pip-ZaCnUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:41 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)) 06:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:41 INFO - Running setup.py (path:/tmp/pip-IvCEQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:41 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)) 06:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:41 INFO - Running setup.py (path:/tmp/pip-xOKSqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:41 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)) 06:00:41 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)) 06:00:41 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)) 06:00:41 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)) 06:00:41 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)) 06:00:41 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)) 06:00:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:00:41 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 06:00:41 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 06:00:41 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 06:00:41 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 06:00:41 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 06:00:41 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 06:00:43 INFO - Downloading blessings-1.6.tar.gz 06:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:00:43 INFO - Installing collected packages: blessings 06:00:43 INFO - Running setup.py install for blessings 06:00:43 INFO - Successfully installed blessings 06:00:43 INFO - Cleaning up... 06:00:43 INFO - Return code: 0 06:00:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:00:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:43 INFO - Reading from file tmpfile_stdout 06:00:43 INFO - Current package versions: 06:00:43 INFO - argparse == 1.2.1 06:00:43 INFO - blessings == 1.6 06:00:43 INFO - blobuploader == 1.2.4 06:00:43 INFO - docopt == 0.6.1 06:00:43 INFO - functools32 == 3.2.3-2 06:00:43 INFO - jsonschema == 2.5.1 06:00:43 INFO - manifestparser == 1.1 06:00:43 INFO - mozInstall == 1.12 06:00:43 INFO - mozcrash == 0.17 06:00:43 INFO - mozdebug == 0.1 06:00:43 INFO - mozdevice == 0.48 06:00:43 INFO - mozfile == 1.2 06:00:43 INFO - mozhttpd == 0.7 06:00:43 INFO - mozinfo == 0.9 06:00:43 INFO - mozleak == 0.1 06:00:43 INFO - mozlog == 3.2 06:00:43 INFO - moznetwork == 0.27 06:00:43 INFO - mozprocess == 0.22 06:00:43 INFO - mozprofile == 0.28 06:00:43 INFO - mozrunner == 6.11 06:00:43 INFO - mozscreenshot == 0.1 06:00:43 INFO - mozsystemmonitor == 0.3 06:00:43 INFO - moztest == 0.7 06:00:43 INFO - mozversion == 1.4 06:00:43 INFO - psutil == 3.1.1 06:00:43 INFO - requests == 1.2.3 06:00:43 INFO - wsgiref == 0.1.2 06:00:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:43 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 0x1702030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, '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': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', '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 06:00:43 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 06:00:43 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 06:00:43 INFO - Using env: {'DISPLAY': ':0', 06:00:43 INFO - 'HOME': '/home/cltbld', 06:00:43 INFO - 'LANG': 'en_US.UTF-8', 06:00:43 INFO - 'LANGUAGE': 'en_US:en', 06:00:43 INFO - 'LOGNAME': 'cltbld', 06:00:43 INFO - 'MAIL': '/var/mail/cltbld', 06:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:43 INFO - 'MOZ_NO_REMOTE': '1', 06:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:43 INFO - 'NO_EM_RESTART': '1', 06:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:43 INFO - 'PWD': '/builds/slave/test', 06:00:43 INFO - 'SHELL': '/bin/bash', 06:00:43 INFO - 'SHLVL': '1', 06:00:43 INFO - 'TERM': 'linux', 06:00:43 INFO - 'TMOUT': '86400', 06:00:43 INFO - 'USER': 'cltbld', 06:00:43 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:43 INFO - '_': '/tools/buildbot/bin/python'} 06:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:43 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)) 06:00:43 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)) 06:00:43 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)) 06:00:43 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)) 06:00:43 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)) 06:00:43 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)) 06:00:43 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)) 06:00:43 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)) 06:00:43 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)) 06:00:43 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)) 06:00:43 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)) 06:00:43 INFO - Cleaning up... 06:00:43 INFO - Return code: 0 06:00:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:43 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 0x1702030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, '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': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', '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 06:00:43 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 06:00:43 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 06:00:43 INFO - Using env: {'DISPLAY': ':0', 06:00:43 INFO - 'HOME': '/home/cltbld', 06:00:43 INFO - 'LANG': 'en_US.UTF-8', 06:00:43 INFO - 'LANGUAGE': 'en_US:en', 06:00:43 INFO - 'LOGNAME': 'cltbld', 06:00:43 INFO - 'MAIL': '/var/mail/cltbld', 06:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:43 INFO - 'MOZ_NO_REMOTE': '1', 06:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:43 INFO - 'NO_EM_RESTART': '1', 06:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:43 INFO - 'PWD': '/builds/slave/test', 06:00:43 INFO - 'SHELL': '/bin/bash', 06:00:43 INFO - 'SHLVL': '1', 06:00:43 INFO - 'TERM': 'linux', 06:00:43 INFO - 'TMOUT': '86400', 06:00:43 INFO - 'USER': 'cltbld', 06:00:43 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:43 INFO - '_': '/tools/buildbot/bin/python'} 06:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:00:43 INFO - Cleaning up... 06:00:43 INFO - Return code: 0 06:00:43 INFO - Running post-action listener: _resource_record_post_action 06:00:43 INFO - Running post-action listener: _start_resource_monitoring 06:00:44 INFO - Starting resource monitoring. 06:00:44 INFO - ##### 06:00:44 INFO - ##### Finished create-virtualenv step (success) 06:00:44 INFO - ##### 06:00:44 INFO - ##### 06:00:44 INFO - ##### Running install step. 06:00:44 INFO - ##### 06:00:44 INFO - Running pre-action listener: _resource_record_pre_action 06:00:44 INFO - Running main action method: install 06:00:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:44 INFO - Reading from file tmpfile_stdout 06:00:44 INFO - Detecting whether we're running mozinstall >=1.0... 06:00:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:00:44 INFO - Reading from file tmpfile_stdout 06:00:44 INFO - Output received: 06:00:44 INFO - Usage: mozinstall [options] installer 06:00:44 INFO - Options: 06:00:44 INFO - -h, --help show this help message and exit 06:00:44 INFO - -d DEST, --destination=DEST 06:00:44 INFO - Directory to install application into. [default: 06:00:44 INFO - "/builds/slave/test"] 06:00:44 INFO - --app=APP Application being installed. [default: firefox] 06:00:44 INFO - mkdir: /builds/slave/test/build/application 06:00:44 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'] 06:00:44 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 06:01:01 INFO - Reading from file tmpfile_stdout 06:01:01 INFO - Output received: 06:01:01 INFO - /builds/slave/test/build/application/firefox/firefox 06:01:01 INFO - Running post-action listener: _resource_record_post_action 06:01:01 INFO - ##### 06:01:01 INFO - ##### Finished install step (success) 06:01:01 INFO - ##### 06:01:01 INFO - ##### 06:01:01 INFO - ##### Running run-tests step. 06:01:01 INFO - ##### 06:01:01 INFO - Running pre-action listener: _resource_record_pre_action 06:01:01 INFO - Running main action method: run_tests 06:01:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:01 INFO - Python 2.7.3 06:01:01 INFO - Return code: 0 06:01:01 INFO - grabbing minidump binary from tooltool 06:01:01 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')]} 06:01:01 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 0x19c13b0>, '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 0x19c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:01 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 06:01:01 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 06:01:01 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 06:01:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:01 INFO - Return code: 0 06:01:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:01:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:01:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:01:01 INFO - Using env: {'DISPLAY': ':0', 06:01:01 INFO - 'HOME': '/home/cltbld', 06:01:01 INFO - 'LANG': 'en_US.UTF-8', 06:01:01 INFO - 'LANGUAGE': 'en_US:en', 06:01:01 INFO - 'LOGNAME': 'cltbld', 06:01:01 INFO - 'MAIL': '/var/mail/cltbld', 06:01:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:01 INFO - 'MOZ_NO_REMOTE': '1', 06:01:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:01 INFO - 'NO_EM_RESTART': '1', 06:01:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:01 INFO - 'PWD': '/builds/slave/test', 06:01:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:01 INFO - 'SHELL': '/bin/bash', 06:01:01 INFO - 'SHLVL': '1', 06:01:01 INFO - 'TERM': 'linux', 06:01:01 INFO - 'TMOUT': '86400', 06:01:01 INFO - 'USER': 'cltbld', 06:01:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160', 06:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:01 INFO - '_': '/tools/buildbot/bin/python'} 06:01:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:01:01 INFO - mozversion application_buildid: 20160701030235 06:01:01 INFO - mozversion application_changeset: fdcee57b4e4f66a82831ab01e61500da98a858e8 06:01:01 INFO - mozversion application_display_name: Nightly 06:01:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:01 INFO - mozversion application_name: Firefox 06:01:01 INFO - mozversion application_remotingname: firefox 06:01:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:01:01 INFO - mozversion application_vendor: Mozilla 06:01:01 INFO - mozversion application_version: 50.0a1 06:01:01 INFO - mozversion platform_buildid: 20160701030235 06:01:01 INFO - mozversion platform_changeset: fdcee57b4e4f66a82831ab01e61500da98a858e8 06:01:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:01:01 INFO - mozversion platform_version: 50.0a1 06:01:01 INFO - using testdate: 1467378061 06:01:01 INFO - actual date: 1467378061 06:01:01 INFO - starting webserver on 'localhost:41638' 06:01:01 INFO - SUITE-START | Running 2 tests 06:01:01 INFO - TEST-START | dromaeo_css 06:01:01 INFO - operating with platform_type : linux_ 06:01:01 INFO - Initialising browser for dromaeo_css test... 06:01:01 INFO - TEST-INFO | started process 1164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHD482r/profile http://localhost:41638/getInfo.html) 06:01:05 INFO - PROCESS | 1164 | __metrics Screen width/height:1600/1200 06:01:05 INFO - PROCESS | 1164 | colorDepth:24 06:01:05 INFO - PROCESS | 1164 | Browser inner width/height: 1024/697 06:01:05 INFO - PROCESS | 1164 | __metrics 06:01:06 INFO - PROCESS | 1164 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:06 INFO - TEST-INFO | 1164: exit 0 06:01:06 INFO - Browser initialized. 06:01:06 INFO - Running cycle 1/1 for dromaeo_css test... 06:01:06 INFO - TEST-INFO | started process 1315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHD482r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:18 INFO - PROCESS | 1315 | RSS: Main: 156364800 06:01:18 INFO - PROCESS | 1315 | 06:02:09 INFO - PROCESS | 1315 | 1467378129448 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] 06:04:18 INFO - PROCESS | 1315 | Cycle 1(1): loaded http://localhost:41638/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41638/tests/dromaeo/cssquery-ext.html) 06:04:19 INFO - PROCESS | 1315 | RSS: Main: 290705408 06:04:19 INFO - PROCESS | 1315 | 06:07:22 INFO - PROCESS | 1315 | Cycle 1(1): loaded http://localhost:41638/tests/dromaeo/cssquery-ext.html (next: http://localhost:41638/tests/dromaeo/cssquery-jquery.html) 06:07:22 INFO - PROCESS | 1315 | RSS: Main: 239210496 06:07:22 INFO - PROCESS | 1315 | 06:10:24 INFO - PROCESS | 1315 | Cycle 1(1): loaded http://localhost:41638/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41638/tests/dromaeo/cssquery-mootools.html) 06:10:25 INFO - PROCESS | 1315 | RSS: Main: 246063104 06:10:25 INFO - PROCESS | 1315 | 06:13:27 INFO - PROCESS | 1315 | Cycle 1(1): loaded http://localhost:41638/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41638/tests/dromaeo/cssquery-prototype.html) 06:13:28 INFO - PROCESS | 1315 | RSS: Main: 244924416 06:13:28 INFO - PROCESS | 1315 | 06:16:30 INFO - PROCESS | 1315 | Cycle 1(1): loaded http://localhost:41638/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41638/tests/dromaeo/cssquery-yui.html) 06:16:31 INFO - PROCESS | 1315 | RSS: Main: 223674368 06:16:31 INFO - PROCESS | 1315 | 06:19:34 INFO - PROCESS | 1315 | Cycle 1(1): loaded http://localhost:41638/tests/dromaeo/cssquery-yui.html (next: http://localhost:41638/tests/dromaeo/cssquery-dojo.html) 06:19:34 INFO - PROCESS | 1315 | RSS: Main: 274677760 06:19:34 INFO - PROCESS | 1315 | 06:19:34 INFO - PROCESS | 1315 | __start_tp_report 06:19:34 INFO - PROCESS | 1315 | _x_x_mozilla_page_load 06:19:34 INFO - PROCESS | 1315 | _x_x_mozilla_page_load_details 06:19:34 INFO - PROCESS | 1315 | |i|pagename|runs| 06:19:34 INFO - PROCESS | 1315 | |0;dojo.html;3150.763692723046;3154.9842250788743;3175.6506784253734;3189.952150717741;3218.8229647369385;5410.621256512036;5443.074677304858;5481.890362192754;5534.418886016965;5585.525230355424;5502.8349149525475;5506.834794956148;5554.7222638868;5562.916556251659;5590.720463976805;4923.778429970651;4999.125153098212;5025.84922452327;5035.62232832539;5136.126858434075;5047.570956468705;5051.772670229849;5089.338386009814;5105.489451054902;5112.386513618371;4868.196747536652;4893.779779909894;4932.112219800434;5001.574866136383;5023.773930173151;4925.507449255082;4931.284963680247;4941.061198372297;4951.03454826309;4988.800447982077;4922.556969872729;4972.353594032753;4990.675606085593;5000.7249601271915;5007.574356179729;5401.70290634015;5465.754041068161;5532.5573954083575;5554.9722251388885;5558.527525160326;5899.056151015817;5994.190784244159;6000.489958353545;6006.279246490405;6013.609115407485;6057.061155520902;6081.787137450168;6083.17877086592;6087.026075827891;6091.756329746849;5427.810026649087;5509.47659972306;5579.0515612346;5592.189132575753;5686.289213848269;6118.510519158456;6126.387361263927;6133.877322453526;6142.508599312045;6145.354737752561;5898.351181370046;5947.910781338283;5958.612690175125;5959.642421454727;5961.5826892118;5786.508146807484;5792.623479473905;5829.76680932758;5837.036888913367;5884.676342801102;5795.333536643256;5832.50423713989;5841.41585841421;5845.064789633639;5845.766169353264;5676.120201368794;5791.652500849962;5828.271466066742;5836;5855.619384739978;4389.978050109793;4409.691321607456;4455.287154055336;4468.955310446854;4472.865814025585;3967.781772002568;3969.6824254059607;3978.960210397859;4006.09862780872;4014.879553613396;5395.05586522357;5519.2824932758485;5523.751431185607;5523.917141242885;5527.281453411031;5836.591438599257;5876.118582212703;5919.467247947619;5938.792142275;5965.79119730816;5558.805441809517;5561.749721262553;5562.443755624405;5569.136783798518;5570.442955704397;4965.4041515018425;5025.572826309732;5106.642535022513;5112.897742045138;5157.948420515821;6058.242719660043;6118.680093383066;6123.1606109212;6123.496151642696;6124.960759790135;5915.763369465345;5920.111983202381;5920.555958303231;5922.407759224043;5961.493273071664;5962.5528085394635;5972.372900845348;5987.34139244674;6109.84725381869;6121.908171377344;5776.19133321327;5785.27684039495;5787.94212057874;5790.420957904176;5825.126231065374;5802.303723553201;5810.866880958172;5832.679202643895;5857.882842343044;5876.676782776988;5578.63738856973;5646.661200327993;5684.602077854511;5686.374498805211;5704.914426283526;5724.227229323988;5728.598998070262;5729.570282228933;5731.541476681939;5732.369439361751;5625.437456254342;5666.829995100154;5667.291588551431;5668.51817595509;5670.546356291569;5608.10270356741;5660.773569057356;5734.569907256889;5807.070868660994;5807.448292412214;5507.586930980113;5535.833924982257;5569.220309156803;5572.916406253828;5575.944240557543 06:19:34 INFO - PROCESS | 1315 | |1;ext.html;571.3914680864881;601.2454369765945;613.8496068463227;615.923009623797;616.1558664629457;42927.570724292746;44306;44329.77835110824;47780;47870.76064619681;45465;45844.33245340365;45862.541374586326;45896.541034589645;45918.54081459184;8992.370534062618;9156.587953542106;9165.908340916572;9169.54152292386;9170.358074934757;8997.595108220146;9065.04816994216;9082;9086.454812711225;9089.136532029446;9095.909040909606;9099.272058235325;9122.133397327276;9131.726048218565;9131.817363652723;8991.14584114508;9054.230390416822;9072.138146876036;9093.272538196929;9104.13510716481;8945.284377249804;8996.77508062297;9015.14356136166;9028;9032.638694452215;42202.78898605518;42252;42359;42463.15073698509;42478;3498.982505087484;3601.423772196436;3612.963870361289;3795.3168429682646;4333.4366532350905;32244;32657.020289391356;32687.509687354708;32735.83632081824;34219.6578034219;3128.984355078233;3139.7331226845745;3202.7758056936023;3249.6262929763143;3336.51620515024;322569;324164.9999999976;327062;331979;332960;49686.75156624194;55671.72164139153;55801.162982555295;58270;59935.400645993854;60223;60250.397496025354;60387.39612603906;60436;60444.39555604476;16978.49064528066;17256;17367.04481253543;17373.913130434266;17388.391406300718;12430.937845310715;12879.806802897963;13583.185008899498;13838;13846.446142154402;15358.078515289119;16025.599360016093;16184.919075404548;16248.106354150636;16300.266488008068;6599.175103112111;6728.932710672831;6749.59502429846;6830.624315662587;6912.861742765116;1000.8398656214971;1044.8380501022355;1091.170710260208;1110.245033377295;1144.4792619358172;31833.84083079616;31850.36299274048;31887.52168717471;31998.200044998597;32415.675843241264;1121.9270747401392;1146.5585749486509;1157.1784033336257;1227.96930076747;1237.3874931908763;16717.498475045526;17103.82896171047;17200.483985480205;17347.04570290865;17367.47897563075;500234;502608;504259;507581;507593;58414.7079264601;58513.41486585165;58516.414835851094;58570.70714646485;58591.41408585945;1257.2959142880015;1364.843043050042;1412.540530848264;1412.576227131877;1415.6531649745673;31796.36407271888;33063;33410.624469348026;33643.327133457686;33934.49098263479;49062;49466;49610.25584616306;49663.25505117499;49741.502584973685;298956;300162;300317;300390;301521;32594.51108233426;32799.180020499676;39959.2008159841;42908.78545607252;44244.778776105915;45495.54504454913;45887.77056114698;46599.30101048555;47044.7647761759;47350;37779;40286;41344.37983430311;41911;42248;39805.80097099496;40473.595264046984;40506.39240411337;41003.58996409998;41436;39994.60005400025;40228.597714022486;40252.597474024886;40840.79579602083;41185.79407103065;35055;36261;37030.6296937038;37049.44425833668;37079;27135.86432067827;27252.45495090127;27592.586111208748;27593.448131036865;27864.860675697302 06:19:34 INFO - PROCESS | 1315 | |2;jquery.html;403.77388662349085;411.3418530351438;412.72141304619413;413.5037954454653;435.68412900647036;18316.358927437526;19584.9020754896;20048.198072077117;20074.799252007477;20501.282455114073;19240.134193961272;19442;20178.091985860636;20186.49533761657;20201;4980.40235171779;5273.367195936493;5276.657017293883;5305.549028332596;5308.256844041837;5190.636655434121;5222.582193424536;5271.525562699357;5338.386085600167;5404.648697834628;5480.698561579112;5494.406622079592;5502.752376143083;5523.502884740373;5525.171224316365;5394.244805727201;5442.91835622466;5470.8085217017215;5494.148406996902;5495.340559132889;5338.466153384669;5341.0653135701095;5345.7594408251725;5350.9732451337495;5356.517913387775;23121.3063608092;23888.28335149931;24473.265802025966;24633.876830615733;24894.12870549522;2130.754963179223;2212.358416059341;2336.100601268507;2589.8705064746687;2610.908618198373;10321.535530901128;10467.685969420929;10643.361398316049;10667.253292269545;10925.672229833117;1949.2495389275232;1949.541857663448;1963.5680150366895;1965.1648049579014;2033.176563491788;77803.61098194473;81938.59030704809;83633;83865.58067209685;84186.15813841844;11339.262947908359;11426.942865285786;11584.536618535332;11720.765584688259;11906.940465297617;16507;16527.83472165263;16603.750943735853;16605.91697041507;16623.50129496117;8017.318527925192;8177.754667359989;8243.134470880592;8344.08215096339;8380.24577788002;7698.692052317957;7723.9227607723205;7724.188960159215;7913.32736717374;7961.601919903982;4807.846116931911;4867.269909513601;4977.32806071183;5210.348706411699;5216.66091704038;2035.5114772454504;2071.2129390831687;2095.1514636572215;2099.3443294232807;2132.5095228097316;905.9139381758722;977.2572844638127;1007.6422869881234;1025.9025392587691;1049.1659130990881;19145.712814307797;19495.317663881695;19831;20030.599388012448;20074;993.4188499727741;1005.4369553050316;1037.896210378956;1046.4453839465095;1062.8724553053682;10659.934006599433;10947.781044379068;11289.774204516028;11294.491747871365;11325.433728313552;462913;463014;464640;466653;470188;94657.526712366;99117;99889.50055249677;99989;100459.49770251101;949.2832911152174;961.293449314753;979.8677178580942;990.1979396688562;997.755549890267;15787.447439340027;17866.642667146843;18022.459326220236;18033.36883209134;18136;43739;44612;44621.33068003917;45283.773581131885;46112.308315375965;61653;61807;65018.674906625165;65670;66021;7529.623518823927;8335.95832020836;8627.6980305689;8689.826203475768;8769.693060742844;12118.515259389878;14184.219867907364;14268.571942841316;14516.129032258099;14521.419143234152;12124.151309408257;12156.452959616661;12211.572594959134;12225;12399.876001239872;12282.201656892274;12329.445174966968;12421.19262247951;12455.750884982068;12519.874801251872;11016.614418495314;11046.613368532384;11809.763804724029;12302.630921072383;12354.876451235372;8318;8423.70517031901;8544.530050847263;8641.444539982613;8781.956090219508;10592.629257975934;11432.714182145513;11503.884961150281;11523.366214858263;11621.477033533341 06:19:34 INFO - PROCESS | 1315 | |3;mootools.html;1323.0870699217546;1410.2525661399459;1483.3399137383865;1575.4485929924522;1783.420388373779;8635.611397487113;8967.506787126713;9001.684941027073;9216.631334746618;9256.722298331044;8963.372563920528;9135.451872887616;9173.082691730824;9188.44869307842;9188.954055229715;2102.7897210278925;2297.7587353327913;2367;2402.759724027601;2441.2066078524463;2393.7366889642126;2404.5311164322966;2404.7354790972977;2407.229686500312;2409.578323793329;2307.4231442139467;2345.061975209921;2386.9522609547885;2388.581998150317;2389.2712722619594;2030.786767389425;2220.455988282865;2287.611106111948;2293.38078718745;2313.0400883633274;2358.5872472317446;2363.7163540375095;2366.9881650591637;2371.2649078785457;2375.845570037942;9026.954865225633;9050.592723327467;9068.68259610917;9088.182063614306;9088.863667045;5197.480251974772;5318.335208098988;5325.387580428262;5325.813596524142;5335.573154147659;3302.8678852846097;3312.403767321881;3453.6028356738793;3480.617132115465;3483.4600636901323;1047.706642140202;1082.6751974407725;1096.5832983466232;1100.3672888089382;1104.8784633690289;12575.811362829474;12714.046446516548;12717.17338373012;12740.36298185087;12751.171173873669;4555.5899969002285;4585.403897493305;4753.859073822257;4763.285507173951;4790.449098353734;10520.105791007696;10524.158067354594;10542.894571054192;10548.578056877792;10555.208359373079;5424.647397919122;5428.83713488596;5433.076377015837;5433.646812957145;5434.728263586805;4409.184300904343;4787.2101103318255;4889.584385327216;4891.3396691446915;4999.150144475448;4101.384792281182;4140.68944829139;4234.174336004449;4264.125854199881;4265.701400901907;1215.6535387414544;1295.5400832704443;1326.2241588670736;1341.6914109754812;1349.2174538767492;826.6362800367818;901.2879824938357;901.963921443148;921.9446833189896;945.4421891084156;6110.969445152746;6140.969295153585;6195.473384762256;6270.895906526299;6285;953.9236861051238;991.1822746234385;998.2114129837493;1013.9442330671736;1032.4734385463469;3972.7020473464604;4155.168966206771;4184;4184.602462766033;4201.222773786859;11402.429878506042;11628.709282267842;11732.296062236293;11733.061355091571;11740.765184696429;11590.304581725124;11625.941870290595;11696.824547631792;11700.473478693479;11717.00405465545;8174.509529428254;8469.830603387898;8476.364272679573;8504.31965442763;8658.696945606873;5775.768969241351;5935.287765467999;6166.290876549254;6191.752329906753;6373.267074286331;10355.223358248011;10529.78940421172;10776.622818201326;10791.460426978776;10792.298500597437;10654.520546575268;10945.343279403261;11005.119590432907;11019.83470247963;11024.338539687644;8172.305354044735;8183.95908020456;8273.958630206811;8285.751427457186;8355.916440835757;8927.107289271022;8930.598123084606;8983.505907175168;8994.685186018458;8994.775130621787;7751.573663448565;7896.921030789618;7929.603519824101;8133.877991830245;8310.293625041697;7662.195469475625;7692;7718.382529397522;7843.529388236724;7872.72445464406;7133.037039999534;7147.3210045045635;7189.065421495172;7205.099362579677;7219.711211551479;5225.869353266199;5384.6499977501335;5429.864253393696;5514.035043867227;5582.27430434041;5378.623496355218;5465.699386533779;5485.643433176991;5491.615586908878;5680.943190568207 06:19:34 INFO - PROCESS | 1315 | |4;prototype.html;337.78550620356066;341.67028817191414;348.1939310496201;350.5355404089582;350.8403676327271;5328.786848526054;5387.838364849061;5397.649152805065;5403.162509810976;5409.864753381167;5246.265522826808;5296.364436267643;5317.760700768465;5340.332458442695;5373.543248823855;4016.6786657067364;4027.0335119571237;4047.6964227682893;4061.6953728470335;4123.484564429446;4061.8375264989363;4119.773412462313;4125.484314460692;4144;4159.355299928516;4074.207348766548;4116.9794151029355;4120.752754834704;4120.752754834704;4122.340425531916;3954.387070004154;3959.7228194026284;4118.5057793065025;4130.504339479252;4194.874153775391;3719.163188282642;3721.9813900930594;3728.366177749789;3738.12154143776;3745.9625403745886;5128.076946149691;5143.588512918957;5180.922286165711;5208.479152084799;5236.633435659505;4584.816607335702;4804.903901921977;4816.133096042711;4833.29917162013;4852.17513022787;5539.750711218005;5555.527780138693;5579.38626751057;5598.44015598441;5600.467955544217;4038.3336749436603;4053.148838743867;4068.816903239361;4071.572484889103;4088.325426304656;5549.667019978814;5766.394528574523;5819.13787587972;5829.621074630136;5887.646741195542;4109.3425051991535;4114.177164567099;4132.834686612502;4136.751794892316;4163.5836416358125;4192.3082691355585;4193.4693836749975;4195.510593739179;4198.454200953917;4206.390073439334;4691.413573303337;4706.458757242961;4759.571638552547;4760.404949381327;4801.879953001203;5576.665400076008;5584.4136365681015;5606.21512988182;5624.859378515488;5631.7184140793615;1424.8218972628422;1438.8201474815648;1447.5223176351778;1451.3686546352371;1455.1341951538818;898.7589037311855;929.3448119076036;940.6548635451234;954.8376775948105;1015.9484933094212;5239.240310155006;5310.309659744208;5319.7340132993195;5346.518813306821;5377.838664840061;5687.3459552152035;5688.800891968844;5695.288088988877;5724.856878577985;5728.255326807488;5145.382554093533;5288.0745869472685;5324.722066703963;5358.46415358461;5366.812161574326;3018.833964131994;3018.969810301869;3047.5123980163066;3051.4965030769677;3069.98465007678;5647.37878833328;5858.091995740667;5877.265341832271;5881.6473410635235;5887.823365298962;5804.187413762077;5808.332041815161;5815.912761308584;5816.422899916521;5840.386759390203;5725;5800.187973683687;5810.331811841692;5898.8230353089475;5902.144189092557;5355.22349259363;5639.154126881001;5655.321361436654;5671.347795003628;5745.971270143623;5587.385387607441;5611.382747897646;5636.210930469655;5640.520555752642;5672.716364181857;5705.429457054262;5797.391273916347;5873.853153671193;5907.822765317047;5974.910376344272;4125.711200216077;4177.185448837447;4180.289350810309;4205.894852628709;4220.409142720083;5584.972075139598;5643.322801263875;5658.236138121466;5663.7451314690115;5723.828285151452;5272.209168624737;5462.9726851365485;5540.335159780852;5551.333839939233;5601.187827764869;5574.9721251393485;5577.860553486195;5588.916166257428;5612.579056570692;5622.7750889963945;5339.572834173335;5398.46015398457;5517.944820551743;5527.640703354269;5530.55755539564;5659.85850353728;5682.744276507649;5690.317161940594;5690.402507736793;5691.117876729114;5476.479734425223;5550.361708403585;5554.638948468337;5598.076317407745;5618.943810562006 06:19:34 INFO - PROCESS | 1315 | |5;yui.html;730.5235252494047;770.4375805661866;813.9023317201929;827.5820710541177;860.2300940658109;15096;16532.09073500957;16551;16583.917080414612;16646;14766.704665906675;14848.851511484881;14876.479323223663;14880.255987200651;14895.180765057918;653.4935425045604;786.2766255045372;796.0725754496005;799.1129845871108;800.779785558973;800.3957012455588;805.8912046873655;807.3783186946048;807.7859367267679;808.1433680298902;862.1593945902757;868.3921255121409;868.4094815525472;869.0397111192136;869.5521806269776;687.3092541995288;838.9748307550783;841.5329492131864;844.7001314533375;861.1904809479101;620.1008537620423;620.3548309757847;620.3858180401415;620.5470006894992;620.5811077522699;15095.094294342265;15103.622409439742;15136;15141.470048548357;15144.318505667272;14493.42026318946;14596.708065838624;14627.414903403851;14635.853641463556;14649.780253296209;12812.10315277931;13431.194128352232;13608.251546164956;13654.180749155083;14209.928950355285;4414;4432.689711720181;4467.798949047268;4538.432695913011;4641.118187544355;64009.67995160041;66843.99999999952;77525.61237193835;77609.22390776133;78678.21321786765;10833.133349332193;11244.231363441664;11647.301161930141;11688.824667629993;11866.644000679993;21637.13451461924;21665.24171654016;21670;21719.67420488694;21766.782332176477;8710.912890871137;8862.734117976472;8888.688895888612;8941.284697224206;9001.369904106781;4565.315202719618;4656.301554766812;4729.125111854318;4763.809447622057;4893.681910675795;3447.87932422369;3539.6991255743037;3541.8052007139854;3547.911302217465;3548.3790336690977;625.9593126446766;636.5957616913294;637.6238019568384;647.2427260105687;656.5108993799649;707.1514182980444;761.2691815856729;779.1351599724414;785.721069020501;803.269025187077;10100.747481313027;10169.644062457779;10307;10321.071103600712;10409.063184313296;630.2437075509407;679.6771533521538;711.4059760100271;759.787259567322;793.6270252463271;4757.5718185363485;4950.579200767903;5053.494650534917;5184.662996905189;5197.8180763673845;88639;90820.54589727009;91209;107398;109643.45178274058;95506;98025.50987245161;98272;99165;100330.49834750926;85466.43600691989;85636;86447;89197;90176;9923.454210018519;9971.900280997097;10023.649172278936;10101.949490252502;10280.331778434378;50627;50880.745596273264;51767;52016;52290.21564676609;47439.52560474489;58423.4157658435;74687.62656186684;76605;77690.6115469419;13554.525591604246;13594.93202533981;13711.382987765774;13715.148454958453;13958.511452099128;14284.082159799154;14650.413983440969;15043.022203556733;15195.772063418837;15204.771928420862;14227.430902764188;14609.780853286997;15106.244687765788;15168.31742571609;15711.292991815624;13310.733785324046;13835.515756948862;14171.929140354232;14443.35004924802;14731.189784561524;14189.361478733275;14189.930271222529;14537.41850325975;14561.126332420088;14806.925965370105;10883.891161088288;11304.43477826089;11383.430828458379;11405;11858.584949526725;10868.782624347627;11283.379414131974;11818;11988.220765650205;12101.213421127599 06:19:34 INFO - PROCESS | 1315 | __end_tp_report 06:19:34 INFO - PROCESS | 1315 | __start_cc_report 06:19:34 INFO - PROCESS | 1315 | _x_x_mozilla_cycle_collect,1241 06:19:34 INFO - PROCESS | 1315 | __end_cc_report 06:19:34 INFO - PROCESS | 1315 | __startTimestamp1467379174534__endTimestamp 06:19:34 INFO - PROCESS | 1315 | 06:19:34 INFO - PROCESS | 1315 | ------- Summary: start ------- 06:19:34 INFO - PROCESS | 1315 | Number of tests: 6 06:19:34 INFO - PROCESS | 1315 | 06:19:34 INFO - PROCESS | 1315 | [#0] dojo.html Cycles:165 Average:5464.85 Median:5646.66 stddev:632.88 (11.2%) stddev-sans-first:608.23 06:19:34 INFO - PROCESS | 1315 | Values: 3150.8 3155.0 3175.7 3190.0 3218.8 5410.6 5443.1 5481.9 5534.4 5585.5 5502.8 5506.8 5554.7 5562.9 5590.7 4923.8 4999.1 5025.8 5035.6 5136.1 5047.6 5051.8 5089.3 5105.5 5112.4 4868.2 4893.8 4932.1 5001.6 5023.8 4925.5 4931.3 4941.1 4951.0 4988.8 4922.6 4972.4 4990.7 5000.7 5007.6 5401.7 5465.8 5532.6 5555.0 5558.5 5899.1 5994.2 6000.5 6006.3 6013.6 6057.1 6081.8 6083.2 6087.0 6091.8 5427.8 5509.5 5579.1 5592.2 5686.3 6118.5 6126.4 6133.9 6142.5 6145.4 5898.4 5947.9 5958.6 5959.6 5961.6 5786.5 5792.6 5829.8 5837.0 5884.7 5795.3 5832.5 5841.4 5845.1 5845.8 5676.1 5791.7 5828.3 5836.0 5855.6 4390.0 4409.7 4455.3 4469.0 4472.9 3967.8 3969.7 3979.0 4006.1 4014.9 5395.1 5519.3 5523.8 5523.9 5527.3 5836.6 5876.1 5919.5 5938.8 5965.8 5558.8 5561.7 5562.4 5569.1 5570.4 4965.4 5025.6 5106.6 5112.9 5157.9 6058.2 6118.7 6123.2 6123.5 6125.0 5915.8 5920.1 5920.6 5922.4 5961.5 5962.6 5972.4 5987.3 6109.8 6121.9 5776.2 5785.3 5787.9 5790.4 5825.1 5802.3 5810.9 5832.7 5857.9 5876.7 5578.6 5646.7 5684.6 5686.4 5704.9 5724.2 5728.6 5729.6 5731.5 5732.4 5625.4 5666.8 5667.3 5668.5 5670.5 5608.1 5660.8 5734.6 5807.1 5807.4 5507.6 5535.8 5569.2 5572.9 5575.9 06:19:34 INFO - PROCESS | 1315 | 06:19:34 INFO - PROCESS | 1315 | [#1] ext.html Cycles:180 Average:55175.60 Median:40922.19 stddev:102554.82 (250.6%) stddev-sans-first:102760.57 06:19:34 INFO - PROCESS | 1315 | Values: 571.4 601.2 613.8 615.9 616.2 42927.6 44306.0 44329.8 47780.0 47870.8 45465.0 45844.3 45862.5 45896.5 45918.5 8992.4 9156.6 9165.9 9169.5 9170.4 8997.6 9065.0 9082.0 9086.5 9089.1 9095.9 9099.3 9122.1 9131.7 9131.8 8991.1 9054.2 9072.1 9093.3 9104.1 8945.3 8996.8 9015.1 9028.0 9032.6 42202.8 42252.0 42359.0 42463.2 42478.0 3499.0 3601.4 3613.0 3795.3 4333.4 32244.0 32657.0 32687.5 32735.8 34219.7 3129.0 3139.7 3202.8 3249.6 3336.5 322569.0 324165.0 327062.0 331979.0 332960.0 49686.8 55671.7 55801.2 58270.0 59935.4 60223.0 60250.4 60387.4 60436.0 60444.4 16978.5 17256.0 17367.0 17373.9 17388.4 12430.9 12879.8 13583.2 13838.0 13846.4 15358.1 16025.6 16184.9 16248.1 16300.3 6599.2 6728.9 6749.6 6830.6 6912.9 1000.8 1044.8 1091.2 1110.2 1144.5 31833.8 31850.4 31887.5 31998.2 32415.7 1121.9 1146.6 1157.2 1228.0 1237.4 16717.5 17103.8 17200.5 17347.0 17367.5 500234.0 502608.0 504259.0 507581.0 507593.0 58414.7 58513.4 58516.4 58570.7 58591.4 1257.3 1364.8 1412.5 1412.6 1415.7 31796.4 33063.0 33410.6 33643.3 33934.5 49062.0 49466.0 49610.3 49663.3 49741.5 298956.0 300162.0 300317.0 300390.0 301521.0 32594.5 32799.2 39959.2 42908.8 44244.8 45495.5 45887.8 46599.3 47044.8 47350.0 37779.0 40286.0 41344.4 41911.0 42248.0 39805.8 40473.6 40506.4 41003.6 41436.0 39994.6 40228.6 40252.6 40840.8 41185.8 35055.0 36261.0 37030.6 37049.4 37079.0 27135.9 27252.5 27592.6 27593.4 27864.9 06:19:34 INFO - PROCESS | 1315 | 06:19:34 INFO - PROCESS | 1315 | [#2] jquery.html Cycles:180 Average:28962.87 Median:13742.00 stddev:77149.31 (561.4%) stddev-sans-first:77335.93 06:19:34 INFO - PROCESS | 1315 | Values: 403.8 411.3 412.7 413.5 435.7 18316.4 19584.9 20048.2 20074.8 20501.3 19240.1 19442.0 20178.1 20186.5 20201.0 4980.4 5273.4 5276.7 5305.5 5308.3 5190.6 5222.6 5271.5 5338.4 5404.6 5480.7 5494.4 5502.8 5523.5 5525.2 5394.2 5442.9 5470.8 5494.1 5495.3 5338.5 5341.1 5345.8 5351.0 5356.5 23121.3 23888.3 24473.3 24633.9 24894.1 2130.8 2212.4 2336.1 2589.9 2610.9 10321.5 10467.7 10643.4 10667.3 10925.7 1949.2 1949.5 1963.6 1965.2 2033.2 77803.6 81938.6 83633.0 83865.6 84186.2 11339.3 11426.9 11584.5 11720.8 11906.9 16507.0 16527.8 16603.8 16605.9 16623.5 8017.3 8177.8 8243.1 8344.1 8380.2 7698.7 7723.9 7724.2 7913.3 7961.6 4807.8 4867.3 4977.3 5210.3 5216.7 2035.5 2071.2 2095.2 2099.3 2132.5 905.9 977.3 1007.6 1025.9 1049.2 19145.7 19495.3 19831.0 20030.6 20074.0 993.4 1005.4 1037.9 1046.4 1062.9 10659.9 10947.8 11289.8 11294.5 11325.4 462913.0 463014.0 464640.0 466653.0 470188.0 94657.5 99117.0 99889.5 99989.0 100459.5 949.3 961.3 979.9 990.2 997.8 15787.4 17866.6 18022.5 18033.4 18136.0 43739.0 44612.0 44621.3 45283.8 46112.3 61653.0 61807.0 65018.7 65670.0 66021.0 7529.6 8336.0 8627.7 8689.8 8769.7 12118.5 14184.2 14268.6 14516.1 14521.4 12124.2 12156.5 12211.6 12225.0 12399.9 12282.2 12329.4 12421.2 12455.8 12519.9 11016.6 11046.6 11809.8 12302.6 12354.9 8318.0 8423.7 8544.5 8641.4 8782.0 10592.6 11432.7 11503.9 11523.4 11621.5 06:19:34 INFO - PROCESS | 1315 | 06:19:34 INFO - PROCESS | 1315 | [#3] mootools.html Cycles:180 Average:6017.51 Median:4758.57 stddev:3485.60 (73.2%) stddev-sans-first:3477.52 06:19:34 INFO - PROCESS | 1315 | Values: 1323.1 1410.3 1483.3 1575.4 1783.4 8635.6 8967.5 9001.7 9216.6 9256.7 8963.4 9135.5 9173.1 9188.4 9189.0 2102.8 2297.8 2367.0 2402.8 2441.2 2393.7 2404.5 2404.7 2407.2 2409.6 2307.4 2345.1 2387.0 2388.6 2389.3 2030.8 2220.5 2287.6 2293.4 2313.0 2358.6 2363.7 2367.0 2371.3 2375.8 9027.0 9050.6 9068.7 9088.2 9088.9 5197.5 5318.3 5325.4 5325.8 5335.6 3302.9 3312.4 3453.6 3480.6 3483.5 1047.7 1082.7 1096.6 1100.4 1104.9 12575.8 12714.0 12717.2 12740.4 12751.2 4555.6 4585.4 4753.9 4763.3 4790.4 10520.1 10524.2 10542.9 10548.6 10555.2 5424.6 5428.8 5433.1 5433.6 5434.7 4409.2 4787.2 4889.6 4891.3 4999.2 4101.4 4140.7 4234.2 4264.1 4265.7 1215.7 1295.5 1326.2 1341.7 1349.2 826.6 901.3 902.0 921.9 945.4 6111.0 6141.0 6195.5 6270.9 6285.0 953.9 991.2 998.2 1013.9 1032.5 3972.7 4155.2 4184.0 4184.6 4201.2 11402.4 11628.7 11732.3 11733.1 11740.8 11590.3 11625.9 11696.8 11700.5 11717.0 8174.5 8469.8 8476.4 8504.3 8658.7 5775.8 5935.3 6166.3 6191.8 6373.3 10355.2 10529.8 10776.6 10791.5 10792.3 10654.5 10945.3 11005.1 11019.8 11024.3 8172.3 8184.0 8274.0 8285.8 8355.9 8927.1 8930.6 8983.5 8994.7 8994.8 7751.6 7896.9 7929.6 8133.9 8310.3 7662.2 7692.0 7718.4 7843.5 7872.7 7133.0 7147.3 7189.1 7205.1 7219.7 5225.9 5384.6 5429.9 5514.0 5582.3 5378.6 5465.7 5485.6 5491.6 5680.9 06:19:34 INFO - PROCESS | 1315 | 06:19:34 INFO - PROCESS | 1315 | [#4] prototype.html Cycles:180 Average:4697.98 Median:5356.84 stddev:1370.04 (25.6%) stddev-sans-first:1334.22 06:19:34 INFO - PROCESS | 1315 | Values: 337.8 341.7 348.2 350.5 350.8 5328.8 5387.8 5397.6 5403.2 5409.9 5246.3 5296.4 5317.8 5340.3 5373.5 4016.7 4027.0 4047.7 4061.7 4123.5 4061.8 4119.8 4125.5 4144.0 4159.4 4074.2 4117.0 4120.8 4120.8 4122.3 3954.4 3959.7 4118.5 4130.5 4194.9 3719.2 3722.0 3728.4 3738.1 3746.0 5128.1 5143.6 5180.9 5208.5 5236.6 4584.8 4804.9 4816.1 4833.3 4852.2 5539.8 5555.5 5579.4 5598.4 5600.5 4038.3 4053.1 4068.8 4071.6 4088.3 5549.7 5766.4 5819.1 5829.6 5887.6 4109.3 4114.2 4132.8 4136.8 4163.6 4192.3 4193.5 4195.5 4198.5 4206.4 4691.4 4706.5 4759.6 4760.4 4801.9 5576.7 5584.4 5606.2 5624.9 5631.7 1424.8 1438.8 1447.5 1451.4 1455.1 898.8 929.3 940.7 954.8 1015.9 5239.2 5310.3 5319.7 5346.5 5377.8 5687.3 5688.8 5695.3 5724.9 5728.3 5145.4 5288.1 5324.7 5358.5 5366.8 3018.8 3019.0 3047.5 3051.5 3070.0 5647.4 5858.1 5877.3 5881.6 5887.8 5804.2 5808.3 5815.9 5816.4 5840.4 5725.0 5800.2 5810.3 5898.8 5902.1 5355.2 5639.2 5655.3 5671.3 5746.0 5587.4 5611.4 5636.2 5640.5 5672.7 5705.4 5797.4 5873.9 5907.8 5974.9 4125.7 4177.2 4180.3 4205.9 4220.4 5585.0 5643.3 5658.2 5663.7 5723.8 5272.2 5463.0 5540.3 5551.3 5601.2 5575.0 5577.9 5588.9 5612.6 5622.8 5339.6 5398.5 5517.9 5527.6 5530.6 5659.9 5682.7 5690.3 5690.4 5691.1 5476.5 5550.4 5554.6 5598.1 5618.9 06:19:34 INFO - PROCESS | 1315 | 06:19:34 INFO - PROCESS | 1315 | [#5] yui.html Cycles:180 Average:20305.95 Median:4603.22 stddev:28007.00 (608.4%) stddev-sans-first:28046.99 06:19:34 INFO - PROCESS | 1315 | Values: 730.5 770.4 813.9 827.6 860.2 15096.0 16532.1 16551.0 16583.9 16646.0 14766.7 14848.9 14876.5 14880.3 14895.2 653.5 786.3 796.1 799.1 800.8 800.4 805.9 807.4 807.8 808.1 862.2 868.4 868.4 869.0 869.6 687.3 839.0 841.5 844.7 861.2 620.1 620.4 620.4 620.5 620.6 15095.1 15103.6 15136.0 15141.5 15144.3 14493.4 14596.7 14627.4 14635.9 14649.8 12812.1 13431.2 13608.3 13654.2 14209.9 4414.0 4432.7 4467.8 4538.4 4641.1 64009.7 66844.0 77525.6 77609.2 78678.2 10833.1 11244.2 11647.3 11688.8 11866.6 21637.1 21665.2 21670.0 21719.7 21766.8 8710.9 8862.7 8888.7 8941.3 9001.4 4565.3 4656.3 4729.1 4763.8 4893.7 3447.9 3539.7 3541.8 3547.9 3548.4 626.0 636.6 637.6 647.2 656.5 707.2 761.3 779.1 785.7 803.3 10100.7 10169.6 10307.0 10321.1 10409.1 630.2 679.7 711.4 759.8 793.6 4757.6 4950.6 5053.5 5184.7 5197.8 88639.0 90820.5 91209.0 107398.0 109643.5 95506.0 98025.5 98272.0 99165.0 100330.5 85466.4 85636.0 86447.0 89197.0 90176.0 9923.5 9971.9 10023.6 10101.9 10280.3 50627.0 50880.7 51767.0 52016.0 52290.2 47439.5 58423.4 74687.6 76605.0 77690.6 13554.5 13594.9 13711.4 13715.1 13958.5 14284.1 14650.4 15043.0 15195.8 15204.8 14227.4 14609.8 15106.2 15168.3 15711.3 13310.7 13835.5 14171.9 14443.4 14731.2 14189.4 14189.9 14537.4 14561.1 14806.9 10883.9 11304.4 11383.4 11405.0 11858.6 10868.8 11283.4 11818.0 11988.2 12101.2 06:19:34 INFO - PROCESS | 1315 | -------- Summary: end -------- 06:19:34 INFO - PROCESS | 1315 | 06:19:35 INFO - TEST-INFO | 1315: exit 0 06:19:35 INFO - TEST-OK | dromaeo_css | took 1113469ms 06:19:35 INFO - TEST-START | kraken 06:19:35 INFO - operating with platform_type : linux_ 06:19:35 INFO - Initialising browser for kraken test... 06:19:35 INFO - TEST-INFO | started process 1520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBFHuTw/profile http://localhost:41638/getInfo.html) 06:19:38 INFO - PROCESS | 1520 | __metrics Screen width/height:1600/1200 06:19:38 INFO - PROCESS | 1520 | colorDepth:24 06:19:38 INFO - PROCESS | 1520 | Browser inner width/height: 1024/697 06:19:38 INFO - PROCESS | 1520 | __metrics 06:19:39 INFO - PROCESS | 1520 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:40 INFO - TEST-INFO | 1520: exit 0 06:19:40 INFO - Browser initialized. 06:19:40 INFO - Running cycle 1/1 for kraken test... 06:19:40 INFO - TEST-INFO | started process 1600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBFHuTw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:52 INFO - PROCESS | 1600 | RSS: Main: 157679616 06:19:52 INFO - PROCESS | 1600 | 06:19:54 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41638/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:55 INFO - PROCESS | 1600 | RSS: Main: 215683072 06:19:55 INFO - PROCESS | 1600 | 06:19:58 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41638/tests/kraken/driver.html?testName=audio-dft) 06:19:58 INFO - PROCESS | 1600 | RSS: Main: 204312576 06:19:58 INFO - PROCESS | 1600 | 06:20:02 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41638/tests/kraken/driver.html?testName=audio-fft) 06:20:02 INFO - PROCESS | 1600 | RSS: Main: 269254656 06:20:02 INFO - PROCESS | 1600 | 06:20:04 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41638/tests/kraken/driver.html?testName=audio-oscillator) 06:20:05 INFO - PROCESS | 1600 | RSS: Main: 180633600 06:20:05 INFO - PROCESS | 1600 | 06:20:07 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41638/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:08 INFO - PROCESS | 1600 | RSS: Main: 184934400 06:20:08 INFO - PROCESS | 1600 | 06:20:11 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41638/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:11 INFO - PROCESS | 1600 | RSS: Main: 218820608 06:20:11 INFO - PROCESS | 1600 | 06:20:15 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41638/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:15 INFO - PROCESS | 1600 | RSS: Main: 221044736 06:20:15 INFO - PROCESS | 1600 | 06:20:18 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41638/tests/kraken/driver.html?testName=json-parse-financial) 06:20:19 INFO - PROCESS | 1600 | RSS: Main: 221122560 06:20:19 INFO - PROCESS | 1600 | 06:20:20 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41638/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:21 INFO - PROCESS | 1600 | RSS: Main: 208531456 06:20:21 INFO - PROCESS | 1600 | 06:20:22 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41638/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:23 INFO - PROCESS | 1600 | RSS: Main: 211881984 06:20:23 INFO - PROCESS | 1600 | 06:20:25 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41638/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:26 INFO - PROCESS | 1600 | RSS: Main: 213884928 06:20:26 INFO - PROCESS | 1600 | 06:20:28 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:29 INFO - PROCESS | 1600 | RSS: Main: 225599488 06:20:29 INFO - PROCESS | 1600 | 06:20:32 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:32 INFO - PROCESS | 1600 | RSS: Main: 225124352 06:20:32 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | Cycle 1(1): loaded http://localhost:41638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41638/tests/kraken/driver.html?testName=ai-astar) 06:20:34 INFO - PROCESS | 1600 | RSS: Main: 267415552 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | __start_tp_report 06:20:34 INFO - PROCESS | 1600 | _x_x_mozilla_page_load 06:20:34 INFO - PROCESS | 1600 | _x_x_mozilla_page_load_details 06:20:34 INFO - PROCESS | 1600 | |i|pagename|runs| 06:20:34 INFO - PROCESS | 1600 | |0;ai-astar;101;110;111;111;112;113;109;111;111;109 06:20:34 INFO - PROCESS | 1600 | |1;audio-beat-detection;144;118;128;172;116;119;151;123;156;115 06:20:34 INFO - PROCESS | 1600 | |2;audio-dft;160;163;159;160;160;160;161;159;160;160 06:20:34 INFO - PROCESS | 1600 | |3;audio-fft;73;76;75;121;74;75;74;74;111;74 06:20:34 INFO - PROCESS | 1600 | |4;audio-oscillator;83;83;110;84;84;84;121;84;84;129 06:20:34 INFO - PROCESS | 1600 | |5;imaging-gaussian-blur;116;116;117;117;116;116;116;116;117;117 06:20:34 INFO - PROCESS | 1600 | |6;imaging-darkroom;147;147;147;147;147;148;147;146;146;145 06:20:34 INFO - PROCESS | 1600 | |7;imaging-desaturate;97;96;100;95;95;95;96;96;95;95 06:20:34 INFO - PROCESS | 1600 | |8;json-parse-financial;54;55;54;53;53;53;54;54;54;53 06:20:34 INFO - PROCESS | 1600 | |9;json-stringify-tinderbox;61;60;60;60;61;61;61;61;60;60 06:20:34 INFO - PROCESS | 1600 | |10;stanford-crypto-aes;75;74;73;83;76;74;73;82;75;82 06:20:34 INFO - PROCESS | 1600 | |11;stanford-crypto-ccm;127;116;117;118;117;118;120;124;159;121 06:20:34 INFO - PROCESS | 1600 | |12;stanford-crypto-pbkdf2;159;167;163;163;163;159;160;163;163;161 06:20:34 INFO - PROCESS | 1600 | |13;stanford-crypto-sha256-iterative;64;66;65;63;64;65;66;63;63;64 06:20:34 INFO - PROCESS | 1600 | __end_tp_report 06:20:34 INFO - PROCESS | 1600 | __start_cc_report 06:20:34 INFO - PROCESS | 1600 | _x_x_mozilla_cycle_collect,1654 06:20:34 INFO - PROCESS | 1600 | __end_cc_report 06:20:34 INFO - PROCESS | 1600 | __startTimestamp1467379234687__endTimestamp 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | ------- Summary: start ------- 06:20:34 INFO - PROCESS | 1600 | Number of tests: 14 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.33 (3.0%) stddev-sans-first:1.30 06:20:34 INFO - PROCESS | 1600 | Values: 101.0 110.0 111.0 111.0 112.0 113.0 109.0 111.0 111.0 109.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:136.00 stddev:20.11 (14.8%) stddev-sans-first:21.01 06:20:34 INFO - PROCESS | 1600 | Values: 144.0 118.0 128.0 172.0 116.0 119.0 151.0 123.0 156.0 115.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 06:20:34 INFO - PROCESS | 1600 | Values: 160.0 163.0 159.0 160.0 160.0 160.0 161.0 159.0 160.0 160.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#3] audio-fft Cycles:10 Average:82.70 Median:74.00 stddev:17.73 (24.0%) stddev-sans-first:18.45 06:20:34 INFO - PROCESS | 1600 | Values: 73.0 76.0 75.0 121.0 74.0 75.0 74.0 74.0 111.0 74.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:18.10 (21.5%) stddev-sans-first:18.70 06:20:34 INFO - PROCESS | 1600 | Values: 83.0 83.0 110.0 84.0 84.0 84.0 121.0 84.0 84.0 129.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:20:34 INFO - PROCESS | 1600 | Values: 116.0 116.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 06:20:34 INFO - PROCESS | 1600 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 147.0 146.0 146.0 145.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.50 stddev:1.56 (1.6%) stddev-sans-first:1.62 06:20:34 INFO - PROCESS | 1600 | Values: 97.0 96.0 100.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 06:20:34 INFO - PROCESS | 1600 | Values: 54.0 55.0 54.0 53.0 53.0 53.0 54.0 54.0 54.0 53.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 06:20:34 INFO - PROCESS | 1600 | Values: 61.0 60.0 60.0 60.0 61.0 61.0 61.0 61.0 60.0 60.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:75.50 stddev:4.00 (5.3%) stddev-sans-first:4.20 06:20:34 INFO - PROCESS | 1600 | Values: 75.0 74.0 73.0 83.0 76.0 74.0 73.0 82.0 75.0 82.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:120.50 stddev:12.88 (10.7%) stddev-sans-first:13.60 06:20:34 INFO - PROCESS | 1600 | Values: 127.0 116.0 117.0 118.0 117.0 118.0 120.0 124.0 159.0 121.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:163.00 stddev:2.42 (1.5%) stddev-sans-first:2.30 06:20:34 INFO - PROCESS | 1600 | Values: 159.0 167.0 163.0 163.0 163.0 159.0 160.0 163.0 163.0 161.0 06:20:34 INFO - PROCESS | 1600 | 06:20:34 INFO - PROCESS | 1600 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:1.16 (1.8%) stddev-sans-first:1.22 06:20:34 INFO - PROCESS | 1600 | Values: 64.0 66.0 65.0 63.0 64.0 65.0 66.0 63.0 63.0 64.0 06:20:34 INFO - PROCESS | 1600 | -------- Summary: end -------- 06:20:34 INFO - PROCESS | 1600 | 06:20:35 INFO - TEST-INFO | 1600: exit 0 06:20:35 INFO - TEST-OK | kraken | took 60486ms 06:20:35 INFO - SUITE-END | took 1173s 06:20:35 INFO - Completed test suite (00:19:34) 06:20:35 INFO - javascript benchmark 06:20:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.763692723046, 3154.9842250788743, 3175.6506784253734, 3189.952150717741, 3218.8229647369385, 5410.621256512036, 5443.074677304858, 5481.890362192754, 5534.418886016965, 5585.525230355424, 5502.8349149525475, 5506.834794956148, 5554.7222638868, 5562.916556251659, 5590.720463976805, 4923.778429970651, 4999.125153098212, 5025.84922452327, 5035.62232832539, 5136.126858434075, 5047.570956468705, 5051.772670229849, 5089.338386009814, 5105.489451054902, 5112.386513618371, 4868.196747536652, 4893.779779909894, 4932.112219800434, 5001.574866136383, 5023.773930173151, 4925.507449255082, 4931.284963680247, 4941.061198372297, 4951.03454826309, 4988.800447982077, 4922.556969872729, 4972.353594032753, 4990.675606085593, 5000.7249601271915, 5007.574356179729, 5401.70290634015, 5465.754041068161, 5532.5573954083575, 5554.9722251388885, 5558.527525160326, 5899.056151015817, 5994.190784244159, 6000.489958353545, 6006.279246490405, 6013.609115407485, 6057.061155520902, 6081.787137450168, 6083.17877086592, 6087.026075827891, 6091.756329746849, 5427.810026649087, 5509.47659972306, 5579.0515612346, 5592.189132575753, 5686.289213848269, 6118.510519158456, 6126.387361263927, 6133.877322453526, 6142.508599312045, 6145.354737752561, 5898.351181370046, 5947.910781338283, 5958.612690175125, 5959.642421454727, 5961.5826892118, 5786.508146807484, 5792.623479473905, 5829.76680932758, 5837.036888913367, 5884.676342801102, 5795.333536643256, 5832.50423713989, 5841.41585841421, 5845.064789633639, 5845.766169353264, 5676.120201368794, 5791.652500849962, 5828.271466066742, 5836.0, 5855.619384739978, 4389.978050109793, 4409.691321607456, 4455.287154055336, 4468.955310446854, 4472.865814025585, 3967.781772002568, 3969.6824254059607, 3978.960210397859, 4006.09862780872, 4014.879553613396, 5395.05586522357, 5519.2824932758485, 5523.751431185607, 5523.917141242885, 5527.281453411031, 5836.591438599257, 5876.118582212703, 5919.467247947619, 5938.792142275, 5965.79119730816, 5558.805441809517, 5561.749721262553, 5562.443755624405, 5569.136783798518, 5570.442955704397, 4965.4041515018425, 5025.572826309732, 5106.642535022513, 5112.897742045138, 5157.948420515821, 6058.242719660043, 6118.680093383066, 6123.1606109212, 6123.496151642696, 6124.960759790135, 5915.763369465345, 5920.111983202381, 5920.555958303231, 5922.407759224043, 5961.493273071664, 5962.5528085394635, 5972.372900845348, 5987.34139244674, 6109.84725381869, 6121.908171377344, 5776.19133321327, 5785.27684039495, 5787.94212057874, 5790.420957904176, 5825.126231065374, 5802.303723553201, 5810.866880958172, 5832.679202643895, 5857.882842343044, 5876.676782776988, 5578.63738856973, 5646.661200327993, 5684.602077854511, 5686.374498805211, 5704.914426283526, 5724.227229323988, 5728.598998070262, 5729.570282228933, 5731.541476681939, 5732.369439361751, 5625.437456254342, 5666.829995100154, 5667.291588551431, 5668.51817595509, 5670.546356291569, 5608.10270356741, 5660.773569057356, 5734.569907256889, 5807.070868660994, 5807.448292412214, 5507.586930980113, 5535.833924982257, 5569.220309156803, 5572.916406253828, 5575.944240557543], "value": 5421.333075478979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.3914680864881, 601.2454369765945, 613.8496068463227, 615.923009623797, 616.1558664629457, 42927.570724292746, 44306.0, 44329.77835110824, 47780.0, 47870.76064619681, 45465.0, 45844.33245340365, 45862.541374586326, 45896.541034589645, 45918.54081459184, 8992.370534062618, 9156.587953542106, 9165.908340916572, 9169.54152292386, 9170.358074934757, 8997.595108220146, 9065.04816994216, 9082.0, 9086.454812711225, 9089.136532029446, 9095.909040909606, 9099.272058235325, 9122.133397327276, 9131.726048218565, 9131.817363652723, 8991.14584114508, 9054.230390416822, 9072.138146876036, 9093.272538196929, 9104.13510716481, 8945.284377249804, 8996.77508062297, 9015.14356136166, 9028.0, 9032.638694452215, 42202.78898605518, 42252.0, 42359.0, 42463.15073698509, 42478.0, 3498.982505087484, 3601.423772196436, 3612.963870361289, 3795.3168429682646, 4333.4366532350905, 32244.0, 32657.020289391356, 32687.509687354708, 32735.83632081824, 34219.6578034219, 3128.984355078233, 3139.7331226845745, 3202.7758056936023, 3249.6262929763143, 3336.51620515024, 322569.0, 324164.9999999976, 327062.0, 331979.0, 332960.0, 49686.75156624194, 55671.72164139153, 55801.162982555295, 58270.0, 59935.400645993854, 60223.0, 60250.397496025354, 60387.39612603906, 60436.0, 60444.39555604476, 16978.49064528066, 17256.0, 17367.04481253543, 17373.913130434266, 17388.391406300718, 12430.937845310715, 12879.806802897963, 13583.185008899498, 13838.0, 13846.446142154402, 15358.078515289119, 16025.599360016093, 16184.919075404548, 16248.106354150636, 16300.266488008068, 6599.175103112111, 6728.932710672831, 6749.59502429846, 6830.624315662587, 6912.861742765116, 1000.8398656214971, 1044.8380501022355, 1091.170710260208, 1110.245033377295, 1144.4792619358172, 31833.84083079616, 31850.36299274048, 31887.52168717471, 31998.200044998597, 32415.675843241264, 1121.9270747401392, 1146.5585749486509, 1157.1784033336257, 1227.96930076747, 1237.3874931908763, 16717.498475045526, 17103.82896171047, 17200.483985480205, 17347.04570290865, 17367.47897563075, 500234.0, 502608.0, 504259.0, 507581.0, 507593.0, 58414.7079264601, 58513.41486585165, 58516.414835851094, 58570.70714646485, 58591.41408585945, 1257.2959142880015, 1364.843043050042, 1412.540530848264, 1412.576227131877, 1415.6531649745673, 31796.36407271888, 33063.0, 33410.624469348026, 33643.327133457686, 33934.49098263479, 49062.0, 49466.0, 49610.25584616306, 49663.25505117499, 49741.502584973685, 298956.0, 300162.0, 300317.0, 300390.0, 301521.0, 32594.51108233426, 32799.180020499676, 39959.2008159841, 42908.78545607252, 44244.778776105915, 45495.54504454913, 45887.77056114698, 46599.30101048555, 47044.7647761759, 47350.0, 37779.0, 40286.0, 41344.37983430311, 41911.0, 42248.0, 39805.80097099496, 40473.595264046984, 40506.39240411337, 41003.58996409998, 41436.0, 39994.60005400025, 40228.597714022486, 40252.597474024886, 40840.79579602083, 41185.79407103065, 35055.0, 36261.0, 37030.6296937038, 37049.44425833668, 37079.0, 27135.86432067827, 27252.45495090127, 27592.586111208748, 27593.448131036865, 27864.860675697302], "value": 19929.223892745347, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.77388662349085, 411.3418530351438, 412.72141304619413, 413.5037954454653, 435.68412900647036, 18316.358927437526, 19584.9020754896, 20048.198072077117, 20074.799252007477, 20501.282455114073, 19240.134193961272, 19442.0, 20178.091985860636, 20186.49533761657, 20201.0, 4980.40235171779, 5273.367195936493, 5276.657017293883, 5305.549028332596, 5308.256844041837, 5190.636655434121, 5222.582193424536, 5271.525562699357, 5338.386085600167, 5404.648697834628, 5480.698561579112, 5494.406622079592, 5502.752376143083, 5523.502884740373, 5525.171224316365, 5394.244805727201, 5442.91835622466, 5470.8085217017215, 5494.148406996902, 5495.340559132889, 5338.466153384669, 5341.0653135701095, 5345.7594408251725, 5350.9732451337495, 5356.517913387775, 23121.3063608092, 23888.28335149931, 24473.265802025966, 24633.876830615733, 24894.12870549522, 2130.754963179223, 2212.358416059341, 2336.100601268507, 2589.8705064746687, 2610.908618198373, 10321.535530901128, 10467.685969420929, 10643.361398316049, 10667.253292269545, 10925.672229833117, 1949.2495389275232, 1949.541857663448, 1963.5680150366895, 1965.1648049579014, 2033.176563491788, 77803.61098194473, 81938.59030704809, 83633.0, 83865.58067209685, 84186.15813841844, 11339.262947908359, 11426.942865285786, 11584.536618535332, 11720.765584688259, 11906.940465297617, 16507.0, 16527.83472165263, 16603.750943735853, 16605.91697041507, 16623.50129496117, 8017.318527925192, 8177.754667359989, 8243.134470880592, 8344.08215096339, 8380.24577788002, 7698.692052317957, 7723.9227607723205, 7724.188960159215, 7913.32736717374, 7961.601919903982, 4807.846116931911, 4867.269909513601, 4977.32806071183, 5210.348706411699, 5216.66091704038, 2035.5114772454504, 2071.2129390831687, 2095.1514636572215, 2099.3443294232807, 2132.5095228097316, 905.9139381758722, 977.2572844638127, 1007.6422869881234, 1025.9025392587691, 1049.1659130990881, 19145.712814307797, 19495.317663881695, 19831.0, 20030.599388012448, 20074.0, 993.4188499727741, 1005.4369553050316, 1037.896210378956, 1046.4453839465095, 1062.8724553053682, 10659.934006599433, 10947.781044379068, 11289.774204516028, 11294.491747871365, 11325.433728313552, 462913.0, 463014.0, 464640.0, 466653.0, 470188.0, 94657.526712366, 99117.0, 99889.50055249677, 99989.0, 100459.49770251101, 949.2832911152174, 961.293449314753, 979.8677178580942, 990.1979396688562, 997.755549890267, 15787.447439340027, 17866.642667146843, 18022.459326220236, 18033.36883209134, 18136.0, 43739.0, 44612.0, 44621.33068003917, 45283.773581131885, 46112.308315375965, 61653.0, 61807.0, 65018.674906625165, 65670.0, 66021.0, 7529.623518823927, 8335.95832020836, 8627.6980305689, 8689.826203475768, 8769.693060742844, 12118.515259389878, 14184.219867907364, 14268.571942841316, 14516.129032258099, 14521.419143234152, 12124.151309408257, 12156.452959616661, 12211.572594959134, 12225.0, 12399.876001239872, 12282.201656892274, 12329.445174966968, 12421.19262247951, 12455.750884982068, 12519.874801251872, 11016.614418495314, 11046.613368532384, 11809.763804724029, 12302.630921072383, 12354.876451235372, 8318.0, 8423.70517031901, 8544.530050847263, 8641.444539982613, 8781.956090219508, 10592.629257975934, 11432.714182145513, 11503.884961150281, 11523.366214858263, 11621.477033533341], "value": 9365.5422507402, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.0870699217546, 1410.2525661399459, 1483.3399137383865, 1575.4485929924522, 1783.420388373779, 8635.611397487113, 8967.506787126713, 9001.684941027073, 9216.631334746618, 9256.722298331044, 8963.372563920528, 9135.451872887616, 9173.082691730824, 9188.44869307842, 9188.954055229715, 2102.7897210278925, 2297.7587353327913, 2367.0, 2402.759724027601, 2441.2066078524463, 2393.7366889642126, 2404.5311164322966, 2404.7354790972977, 2407.229686500312, 2409.578323793329, 2307.4231442139467, 2345.061975209921, 2386.9522609547885, 2388.581998150317, 2389.2712722619594, 2030.786767389425, 2220.455988282865, 2287.611106111948, 2293.38078718745, 2313.0400883633274, 2358.5872472317446, 2363.7163540375095, 2366.9881650591637, 2371.2649078785457, 2375.845570037942, 9026.954865225633, 9050.592723327467, 9068.68259610917, 9088.182063614306, 9088.863667045, 5197.480251974772, 5318.335208098988, 5325.387580428262, 5325.813596524142, 5335.573154147659, 3302.8678852846097, 3312.403767321881, 3453.6028356738793, 3480.617132115465, 3483.4600636901323, 1047.706642140202, 1082.6751974407725, 1096.5832983466232, 1100.3672888089382, 1104.8784633690289, 12575.811362829474, 12714.046446516548, 12717.17338373012, 12740.36298185087, 12751.171173873669, 4555.5899969002285, 4585.403897493305, 4753.859073822257, 4763.285507173951, 4790.449098353734, 10520.105791007696, 10524.158067354594, 10542.894571054192, 10548.578056877792, 10555.208359373079, 5424.647397919122, 5428.83713488596, 5433.076377015837, 5433.646812957145, 5434.728263586805, 4409.184300904343, 4787.2101103318255, 4889.584385327216, 4891.3396691446915, 4999.150144475448, 4101.384792281182, 4140.68944829139, 4234.174336004449, 4264.125854199881, 4265.701400901907, 1215.6535387414544, 1295.5400832704443, 1326.2241588670736, 1341.6914109754812, 1349.2174538767492, 826.6362800367818, 901.2879824938357, 901.963921443148, 921.9446833189896, 945.4421891084156, 6110.969445152746, 6140.969295153585, 6195.473384762256, 6270.895906526299, 6285.0, 953.9236861051238, 991.1822746234385, 998.2114129837493, 1013.9442330671736, 1032.4734385463469, 3972.7020473464604, 4155.168966206771, 4184.0, 4184.602462766033, 4201.222773786859, 11402.429878506042, 11628.709282267842, 11732.296062236293, 11733.061355091571, 11740.765184696429, 11590.304581725124, 11625.941870290595, 11696.824547631792, 11700.473478693479, 11717.00405465545, 8174.509529428254, 8469.830603387898, 8476.364272679573, 8504.31965442763, 8658.696945606873, 5775.768969241351, 5935.287765467999, 6166.290876549254, 6191.752329906753, 6373.267074286331, 10355.223358248011, 10529.78940421172, 10776.622818201326, 10791.460426978776, 10792.298500597437, 10654.520546575268, 10945.343279403261, 11005.119590432907, 11019.83470247963, 11024.338539687644, 8172.305354044735, 8183.95908020456, 8273.958630206811, 8285.751427457186, 8355.916440835757, 8927.107289271022, 8930.598123084606, 8983.505907175168, 8994.685186018458, 8994.775130621787, 7751.573663448565, 7896.921030789618, 7929.603519824101, 8133.877991830245, 8310.293625041697, 7662.195469475625, 7692.0, 7718.382529397522, 7843.529388236724, 7872.72445464406, 7133.037039999534, 7147.3210045045635, 7189.065421495172, 7205.099362579677, 7219.711211551479, 5225.869353266199, 5384.6499977501335, 5429.864253393696, 5514.035043867227, 5582.27430434041, 5378.623496355218, 5465.699386533779, 5485.643433176991, 5491.615586908878, 5680.943190568207], "value": 4764.678307055427, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.78550620356066, 341.67028817191414, 348.1939310496201, 350.5355404089582, 350.8403676327271, 5328.786848526054, 5387.838364849061, 5397.649152805065, 5403.162509810976, 5409.864753381167, 5246.265522826808, 5296.364436267643, 5317.760700768465, 5340.332458442695, 5373.543248823855, 4016.6786657067364, 4027.0335119571237, 4047.6964227682893, 4061.6953728470335, 4123.484564429446, 4061.8375264989363, 4119.773412462313, 4125.484314460692, 4144.0, 4159.355299928516, 4074.207348766548, 4116.9794151029355, 4120.752754834704, 4120.752754834704, 4122.340425531916, 3954.387070004154, 3959.7228194026284, 4118.5057793065025, 4130.504339479252, 4194.874153775391, 3719.163188282642, 3721.9813900930594, 3728.366177749789, 3738.12154143776, 3745.9625403745886, 5128.076946149691, 5143.588512918957, 5180.922286165711, 5208.479152084799, 5236.633435659505, 4584.816607335702, 4804.903901921977, 4816.133096042711, 4833.29917162013, 4852.17513022787, 5539.750711218005, 5555.527780138693, 5579.38626751057, 5598.44015598441, 5600.467955544217, 4038.3336749436603, 4053.148838743867, 4068.816903239361, 4071.572484889103, 4088.325426304656, 5549.667019978814, 5766.394528574523, 5819.13787587972, 5829.621074630136, 5887.646741195542, 4109.3425051991535, 4114.177164567099, 4132.834686612502, 4136.751794892316, 4163.5836416358125, 4192.3082691355585, 4193.4693836749975, 4195.510593739179, 4198.454200953917, 4206.390073439334, 4691.413573303337, 4706.458757242961, 4759.571638552547, 4760.404949381327, 4801.879953001203, 5576.665400076008, 5584.4136365681015, 5606.21512988182, 5624.859378515488, 5631.7184140793615, 1424.8218972628422, 1438.8201474815648, 1447.5223176351778, 1451.3686546352371, 1455.1341951538818, 898.7589037311855, 929.3448119076036, 940.6548635451234, 954.8376775948105, 1015.9484933094212, 5239.240310155006, 5310.309659744208, 5319.7340132993195, 5346.518813306821, 5377.838664840061, 5687.3459552152035, 5688.800891968844, 5695.288088988877, 5724.856878577985, 5728.255326807488, 5145.382554093533, 5288.0745869472685, 5324.722066703963, 5358.46415358461, 5366.812161574326, 3018.833964131994, 3018.969810301869, 3047.5123980163066, 3051.4965030769677, 3069.98465007678, 5647.37878833328, 5858.091995740667, 5877.265341832271, 5881.6473410635235, 5887.823365298962, 5804.187413762077, 5808.332041815161, 5815.912761308584, 5816.422899916521, 5840.386759390203, 5725.0, 5800.187973683687, 5810.331811841692, 5898.8230353089475, 5902.144189092557, 5355.22349259363, 5639.154126881001, 5655.321361436654, 5671.347795003628, 5745.971270143623, 5587.385387607441, 5611.382747897646, 5636.210930469655, 5640.520555752642, 5672.716364181857, 5705.429457054262, 5797.391273916347, 5873.853153671193, 5907.822765317047, 5974.910376344272, 4125.711200216077, 4177.185448837447, 4180.289350810309, 4205.894852628709, 4220.409142720083, 5584.972075139598, 5643.322801263875, 5658.236138121466, 5663.7451314690115, 5723.828285151452, 5272.209168624737, 5462.9726851365485, 5540.335159780852, 5551.333839939233, 5601.187827764869, 5574.9721251393485, 5577.860553486195, 5588.916166257428, 5612.579056570692, 5622.7750889963945, 5339.572834173335, 5398.46015398457, 5517.944820551743, 5527.640703354269, 5530.55755539564, 5659.85850353728, 5682.744276507649, 5690.317161940594, 5690.402507736793, 5691.117876729114, 5476.479734425223, 5550.361708403585, 5554.638948468337, 5598.076317407745, 5618.943810562006], "value": 4264.50027693104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.5235252494047, 770.4375805661866, 813.9023317201929, 827.5820710541177, 860.2300940658109, 15096.0, 16532.09073500957, 16551.0, 16583.917080414612, 16646.0, 14766.704665906675, 14848.851511484881, 14876.479323223663, 14880.255987200651, 14895.180765057918, 653.4935425045604, 786.2766255045372, 796.0725754496005, 799.1129845871108, 800.779785558973, 800.3957012455588, 805.8912046873655, 807.3783186946048, 807.7859367267679, 808.1433680298902, 862.1593945902757, 868.3921255121409, 868.4094815525472, 869.0397111192136, 869.5521806269776, 687.3092541995288, 838.9748307550783, 841.5329492131864, 844.7001314533375, 861.1904809479101, 620.1008537620423, 620.3548309757847, 620.3858180401415, 620.5470006894992, 620.5811077522699, 15095.094294342265, 15103.622409439742, 15136.0, 15141.470048548357, 15144.318505667272, 14493.42026318946, 14596.708065838624, 14627.414903403851, 14635.853641463556, 14649.780253296209, 12812.10315277931, 13431.194128352232, 13608.251546164956, 13654.180749155083, 14209.928950355285, 4414.0, 4432.689711720181, 4467.798949047268, 4538.432695913011, 4641.118187544355, 64009.67995160041, 66843.99999999952, 77525.61237193835, 77609.22390776133, 78678.21321786765, 10833.133349332193, 11244.231363441664, 11647.301161930141, 11688.824667629993, 11866.644000679993, 21637.13451461924, 21665.24171654016, 21670.0, 21719.67420488694, 21766.782332176477, 8710.912890871137, 8862.734117976472, 8888.688895888612, 8941.284697224206, 9001.369904106781, 4565.315202719618, 4656.301554766812, 4729.125111854318, 4763.809447622057, 4893.681910675795, 3447.87932422369, 3539.6991255743037, 3541.8052007139854, 3547.911302217465, 3548.3790336690977, 625.9593126446766, 636.5957616913294, 637.6238019568384, 647.2427260105687, 656.5108993799649, 707.1514182980444, 761.2691815856729, 779.1351599724414, 785.721069020501, 803.269025187077, 10100.747481313027, 10169.644062457779, 10307.0, 10321.071103600712, 10409.063184313296, 630.2437075509407, 679.6771533521538, 711.4059760100271, 759.787259567322, 793.6270252463271, 4757.5718185363485, 4950.579200767903, 5053.494650534917, 5184.662996905189, 5197.8180763673845, 88639.0, 90820.54589727009, 91209.0, 107398.0, 109643.45178274058, 95506.0, 98025.50987245161, 98272.0, 99165.0, 100330.49834750926, 85466.43600691989, 85636.0, 86447.0, 89197.0, 90176.0, 9923.454210018519, 9971.900280997097, 10023.649172278936, 10101.949490252502, 10280.331778434378, 50627.0, 50880.745596273264, 51767.0, 52016.0, 52290.21564676609, 47439.52560474489, 58423.4157658435, 74687.62656186684, 76605.0, 77690.6115469419, 13554.525591604246, 13594.93202533981, 13711.382987765774, 13715.148454958453, 13958.511452099128, 14284.082159799154, 14650.413983440969, 15043.022203556733, 15195.772063418837, 15204.771928420862, 14227.430902764188, 14609.780853286997, 15106.244687765788, 15168.31742571609, 15711.292991815624, 13310.733785324046, 13835.515756948862, 14171.929140354232, 14443.35004924802, 14731.189784561524, 14189.361478733275, 14189.930271222529, 14537.41850325975, 14561.126332420088, 14806.925965370105, 10883.891161088288, 11304.43477826089, 11383.430828458379, 11405.0, 11858.584949526725, 10868.782624347627, 11283.379414131974, 11818.0, 11988.220765650205, 12101.213421127599], "value": 7701.855676673435, "unit": "score"}], "name": "dromaeo_css", "value": 7355.490649787483, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 111.0, 112.0, 113.0, 109.0, 111.0, 111.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 128.0, 172.0, 116.0, 119.0, 151.0, 123.0, 156.0, 115.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 159.0, 160.0, 160.0, 160.0, 161.0, 159.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 75.0, 121.0, 74.0, 75.0, 74.0, 74.0, 111.0, 74.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 84.0, 84.0, 84.0, 121.0, 84.0, 84.0, 129.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 145.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 100.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 83.0, 76.0, 74.0, 73.0, 82.0, 75.0, 82.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 116.0, 117.0, 118.0, 117.0, 118.0, 120.0, 124.0, 159.0, 121.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 167.0, 163.0, 163.0, 163.0, 159.0, 160.0, 163.0, 163.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 63.0, 64.0, 65.0, 66.0, 63.0, 63.0, 64.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1481.6, "alertThreshold": 2.0}]} 06:20:35 INFO - Return code: 0 06:20:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:20:36 INFO - # TBPL SUCCESS # 06:20:36 INFO - Running post-action listener: _resource_record_post_action 06:20:36 INFO - ##### 06:20:36 INFO - ##### Finished run-tests step (success) 06:20:36 INFO - ##### 06:20:36 INFO - Running post-run listener: _resource_record_post_run 06:20:36 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557690880; Read time: 16; Write time: 505484 06:20:36 INFO - TinderboxPrint: CPU usage
13.0% 06:20:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:20:36 INFO - TinderboxPrint: I/O write bytes / time
557,690,880 / 505,484 06:20:36 INFO - TinderboxPrint: CPU idle
8,269.5 (87.0%) 06:20:36 INFO - TinderboxPrint: CPU user
1,194.5 (12.6%) 06:20:36 INFO - TinderboxPrint: Swap in / out
0 / 0 06:20:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261685248; Read time: 0; Write time: 273528 06:20:36 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296005632; Read time: 0; Write time: 231956 06:20:36 INFO - Running post-run listener: _upload_blobber_files 06:20:36 INFO - Blob upload gear active. 06:20:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:20:36 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 06:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:20:37 INFO - (blobuploader) - INFO - Open directory for files ... 06:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:38 INFO - (blobuploader) - INFO - Done attempting. 06:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:20:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:42 INFO - (blobuploader) - INFO - Done attempting. 06:20:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:20:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:20:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:43 INFO - (blobuploader) - INFO - Done attempting. 06:20:43 INFO - (blobuploader) - INFO - Iteration through files over. 06:20:43 INFO - Return code: 0 06:20:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:20:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:20:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/275623697850b4565745b9be3bd0a9f39b30ca1a8a5a6836543b03487f1e9eb4bd2fc8e6b5ce63fba2c95c4060b5df63939b72ab54cd12c796f1b390ac1e29b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f5bfd02142dbf17e6dfcd2a5753aaef6fb5d807d0b92be38752e7d271c094d6ac2ce3f7b073a404583f34a641e04cb0c470505d539ad6820b60b7f09f6557a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abfc27336aa02942ce209eece9e19c09075d18dc55032f602c72048132f80f3d42ef87424d040880e5ca9b6e66c50d39b29d2ae2f59628869e6a20da0b5fbc1b"} 06:20:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:20:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:20:43 INFO - Contents: 06:20:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/275623697850b4565745b9be3bd0a9f39b30ca1a8a5a6836543b03487f1e9eb4bd2fc8e6b5ce63fba2c95c4060b5df63939b72ab54cd12c796f1b390ac1e29b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f5bfd02142dbf17e6dfcd2a5753aaef6fb5d807d0b92be38752e7d271c094d6ac2ce3f7b073a404583f34a641e04cb0c470505d539ad6820b60b7f09f6557a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abfc27336aa02942ce209eece9e19c09075d18dc55032f602c72048132f80f3d42ef87424d040880e5ca9b6e66c50d39b29d2ae2f59628869e6a20da0b5fbc1b"} 06:20:43 INFO - Running post-run listener: copy_logs_to_upload_dir 06:20:43 INFO - Copying logs to upload dir... 06:20:43 INFO - mkdir: /builds/slave/test/build/upload/logs 06:20:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.780112 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-01 06:20:43.026455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 06:20:43.031974) ========= 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=923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/275623697850b4565745b9be3bd0a9f39b30ca1a8a5a6836543b03487f1e9eb4bd2fc8e6b5ce63fba2c95c4060b5df63939b72ab54cd12c796f1b390ac1e29b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f5bfd02142dbf17e6dfcd2a5753aaef6fb5d807d0b92be38752e7d271c094d6ac2ce3f7b073a404583f34a641e04cb0c470505d539ad6820b60b7f09f6557a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abfc27336aa02942ce209eece9e19c09075d18dc55032f602c72048132f80f3d42ef87424d040880e5ca9b6e66c50d39b29d2ae2f59628869e6a20da0b5fbc1b"} build_url:https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/UGh7v4PyTHe_u70s6Uuhcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/275623697850b4565745b9be3bd0a9f39b30ca1a8a5a6836543b03487f1e9eb4bd2fc8e6b5ce63fba2c95c4060b5df63939b72ab54cd12c796f1b390ac1e29b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f5bfd02142dbf17e6dfcd2a5753aaef6fb5d807d0b92be38752e7d271c094d6ac2ce3f7b073a404583f34a641e04cb0c470505d539ad6820b60b7f09f6557a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abfc27336aa02942ce209eece9e19c09075d18dc55032f602c72048132f80f3d42ef87424d040880e5ca9b6e66c50d39b29d2ae2f59628869e6a20da0b5fbc1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 06:20:43.057565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 06:20:43.057933) ========= 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=923d835db2ba3686ebe126b700000192-1467378010.808857-1227052160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 06:20:43.139227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 06:20:43.139543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 06:20:43.139829) ========= ========= Total master_lag: 0.16 =========