builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1468866096.13 results: success (0) buildid: 20160718081125 builduid: 287f226fbb2b4168b64a0bc1976de0e5 revision: cde56ead650f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:36.127526) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:36.128089) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:36.128478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:36.162455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:36.162853) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 11:21:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.0M=0s 2016-07-18 11:21:37 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125882 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:36.303822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:36.304210) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017099 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:36.363082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 11:21:36.363576) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cde56ead650f --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 cde56ead650f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 11:21:37,252 Setting DEBUG logging. 2016-07-18 11:21:37,252 attempt 1/10 2016-07-18 11:21:37,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cde56ead650f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 11:21:38,284 unpacking tar archive at: mozilla-central-cde56ead650f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.463633 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 11:21:37.841431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:37.841851) ========= script_repo_revision: cde56ead650f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:37.842331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:37.842648) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:21:37.852504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-18 11:21:37.852814) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:21:38 INFO - MultiFileLogger online at 20160718 11:21:38 in /builds/slave/test 11:21:38 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 11:21:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:21:38 INFO - {'append_to_log': False, 11:21:38 INFO - 'base_work_dir': '/builds/slave/test', 11:21:38 INFO - 'blob_upload_branch': 'Firefox', 11:21:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:21:38 INFO - 'branch': 'Firefox', 11:21:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:21:38 INFO - 'config_files': ('talos/linux_config.py',), 11:21:38 INFO - 'default_actions': ('clobber', 11:21:38 INFO - 'read-buildbot-config', 11:21:38 INFO - 'download-and-extract', 11:21:38 INFO - 'populate-webroot', 11:21:38 INFO - 'create-virtualenv', 11:21:38 INFO - 'install', 11:21:38 INFO - 'run-tests'), 11:21:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:21:38 INFO - 'download_minidump_stackwalk': True, 11:21:38 INFO - 'download_symbols': 'ondemand', 11:21:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:21:38 INFO - 'tooltool.py': '/tools/tooltool.py', 11:21:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:21:38 INFO - '/tools/misc-python/virtualenv.py')}, 11:21:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:21:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:21:38 INFO - 'installer_path': 'installer.exe', 11:21:38 INFO - 'log_level': 'info', 11:21:38 INFO - 'log_name': 'talos', 11:21:38 INFO - 'log_to_console': True, 11:21:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:21:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:21:38 INFO - 'opt_config_files': (), 11:21:38 INFO - 'pip_index': False, 11:21:38 INFO - 'sps_profile': False, 11:21:38 INFO - 'sps_profile_interval': 0, 11:21:38 INFO - 'suite': 'dromaeojs', 11:21:38 INFO - 'system_bits': '32', 11:21:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:21:38 INFO - 'title': 'talos-linux64-ix-005', 11:21:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:21:38 INFO - 'use_talos_json': True, 11:21:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:21:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:21:38 INFO - 'work_dir': 'build'} 11:21:38 INFO - ##### 11:21:38 INFO - ##### Running clobber step. 11:21:38 INFO - ##### 11:21:38 INFO - Running pre-action listener: _resource_record_pre_action 11:21:38 INFO - Running main action method: clobber 11:21:38 INFO - rmtree: /builds/slave/test/build 11:21:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:21:39 INFO - Running post-action listener: _resource_record_post_action 11:21:39 INFO - ##### 11:21:39 INFO - ##### Finished clobber step (success) 11:21:39 INFO - ##### 11:21:39 INFO - ##### 11:21:39 INFO - ##### Running read-buildbot-config step. 11:21:39 INFO - ##### 11:21:39 INFO - Running pre-action listener: _resource_record_pre_action 11:21:39 INFO - Running main action method: read_buildbot_config 11:21:39 INFO - Using buildbot properties: 11:21:39 INFO - { 11:21:39 INFO - "project": "", 11:21:39 INFO - "product": "firefox", 11:21:39 INFO - "script_repo_revision": "production", 11:21:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:21:39 INFO - "repository": "", 11:21:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 11:21:39 INFO - "buildid": "20160718081125", 11:21:39 INFO - "stage_platform": "linux64-pgo", 11:21:39 INFO - "basedir": "/builds/slave/test", 11:21:39 INFO - "nightly_build": "True", 11:21:39 INFO - "buildnumber": 504, 11:21:39 INFO - "slavename": "talos-linux64-ix-005", 11:21:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:21:39 INFO - "platform": "ubuntu64_hw", 11:21:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 11:21:39 INFO - "branch": "mozilla-central", 11:21:39 INFO - "repo_path": "mozilla-central", 11:21:39 INFO - "revision": "cde56ead650f", 11:21:39 INFO - "pgo_build": "True", 11:21:39 INFO - "builduid": "287f226fbb2b4168b64a0bc1976de0e5", 11:21:39 INFO - "slavebuilddir": "test" 11:21:39 INFO - } 11:21:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:21:39 INFO - Running post-action listener: _resource_record_post_action 11:21:39 INFO - ##### 11:21:39 INFO - ##### Finished read-buildbot-config step (success) 11:21:39 INFO - ##### 11:21:39 INFO - ##### 11:21:39 INFO - ##### Running download-and-extract step. 11:21:39 INFO - ##### 11:21:39 INFO - Running pre-action listener: _resource_record_pre_action 11:21:39 INFO - Running main action method: download_and_extract 11:21:39 INFO - mkdir: /builds/slave/test/build/tests 11:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:39 INFO - https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:21:39 INFO - Downloaded 1361 bytes. 11:21:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:21:39 INFO - Using the following test package requirements: 11:21:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:21:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:21:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:21:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:39 INFO - u'jsshell-linux-x86_64.zip'], 11:21:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:21:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:21:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:21:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:21:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:21:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:21:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:39 INFO - https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:21:41 INFO - Downloaded 24332691 bytes. 11:21:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:21:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:21:42 INFO - Return code: 0 11:21:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:42 INFO - https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:21:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:21:43 INFO - Downloaded 24332691 bytes. 11:21:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:21:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:21:44 INFO - Return code: 0 11:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:44 INFO - https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:21:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:21:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:21:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:21:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:21:45 INFO - Downloaded 14403317 bytes. 11:21:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:21:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:21:46 INFO - Return code: 0 11:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:46 INFO - https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:21:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:21:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:21:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:21:47 INFO - Downloaded 60853817 bytes. 11:21:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:21:47 INFO - mkdir: /builds/slave/test/properties 11:21:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:21:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:21:47 INFO - Contents: 11:21:47 INFO - build_url:https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:21:48 INFO - Running post-action listener: _resource_record_post_action 11:21:48 INFO - Running post-action listener: set_extra_try_arguments 11:21:48 INFO - ##### 11:21:48 INFO - ##### Finished download-and-extract step (success) 11:21:48 INFO - ##### 11:21:48 INFO - ##### 11:21:48 INFO - ##### Running populate-webroot step. 11:21:48 INFO - ##### 11:21:48 INFO - Running pre-action listener: _resource_record_pre_action 11:21:48 INFO - Running main action method: populate_webroot 11:21:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:21:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:21:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:21:48 INFO - '--tppagecycles', 11:21:48 INFO - '7'], 11:21:48 INFO - 'tests': ['tsvgm']}}, 11:21:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:21:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:21:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:21:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:21:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:48 INFO - 'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:48 INFO - 'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['damp', 'tps']}, 11:21:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:48 INFO - 'tests': ['damp', 'tps']}, 11:21:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['dromaeo_dom']}, 11:21:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:21:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['basic_compositor_video']}, 11:21:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:21:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['a11yr', 11:21:48 INFO - 'ts_paint', 11:21:48 INFO - 'tpaint', 11:21:48 INFO - 'sessionrestore', 11:21:48 INFO - 'sessionrestore_no_auto_restore', 11:21:48 INFO - 'tabpaint']}, 11:21:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:21:48 INFO - 'ts_paint', 11:21:48 INFO - 'tpaint', 11:21:48 INFO - 'sessionrestore', 11:21:48 INFO - 'sessionrestore_no_auto_restore', 11:21:48 INFO - 'tabpaint']}, 11:21:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:21:48 INFO - 'ts_paint', 11:21:48 INFO - 'tpaint', 11:21:48 INFO - 'sessionrestore', 11:21:48 INFO - 'sessionrestore_no_auto_restore', 11:21:48 INFO - 'tabpaint']}, 11:21:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:21:48 INFO - 'ts_paint', 11:21:48 INFO - 'tpaint', 11:21:48 INFO - 'sessionrestore', 11:21:48 INFO - 'sessionrestore_no_auto_restore', 11:21:48 INFO - 'tabpaint']}, 11:21:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['a11yr', 11:21:48 INFO - 'ts_paint', 11:21:48 INFO - 'tpaint', 11:21:48 INFO - 'sessionrestore', 11:21:48 INFO - 'sessionrestore_no_auto_restore', 11:21:48 INFO - 'tabpaint']}, 11:21:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['a11yr', 11:21:48 INFO - 'ts_paint', 11:21:48 INFO - 'tpaint', 11:21:48 INFO - 'sessionrestore', 11:21:48 INFO - 'sessionrestore_no_auto_restore', 11:21:48 INFO - 'tabpaint']}, 11:21:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['tsvgx', 11:21:48 INFO - 'tsvgr_opacity', 11:21:48 INFO - 'tart', 11:21:48 INFO - 'tscrollx', 11:21:48 INFO - 'cart']}, 11:21:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:21:48 INFO - 'tsvgr_opacity', 11:21:48 INFO - 'tart', 11:21:48 INFO - 'tscrollx', 11:21:48 INFO - 'cart']}, 11:21:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:48 INFO - 'talos_options': ['--disable-e10s'], 11:21:48 INFO - 'tests': ['tp5o']}, 11:21:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:48 INFO - 'tests': ['tp5o']}, 11:21:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:48 INFO - 'talos_options': ['--disable-e10s', 11:21:48 INFO - '--xperf_path', 11:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:48 INFO - 'tests': ['tp5n']}, 11:21:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:48 INFO - 'talos_options': ['--xperf_path', 11:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:48 INFO - 'tests': ['tp5n']}}, 11:21:48 INFO - 'talos.zip': {'path': '', 11:21:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:21:48 INFO - Running post-action listener: _resource_record_post_action 11:21:48 INFO - ##### 11:21:48 INFO - ##### Finished populate-webroot step (success) 11:21:48 INFO - ##### 11:21:48 INFO - ##### 11:21:48 INFO - ##### Running create-virtualenv step. 11:21:48 INFO - ##### 11:21:48 INFO - Running pre-action listener: _resource_record_pre_action 11:21:48 INFO - Running main action method: create_virtualenv 11:21:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:21:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:21:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:21:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:21:48 INFO - Using real prefix '/usr' 11:21:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:21:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:21:50 INFO - Installing pip.................done. 11:21:50 INFO - Return code: 0 11:21:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:21:50 INFO - Using env: {'DISPLAY': ':0', 11:21:50 INFO - 'HOME': '/home/cltbld', 11:21:50 INFO - 'LANG': 'en_US.UTF-8', 11:21:50 INFO - 'LANGUAGE': 'en_US:en', 11:21:50 INFO - 'LOGNAME': 'cltbld', 11:21:50 INFO - 'MAIL': '/var/mail/cltbld', 11:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:50 INFO - 'MOZ_NO_REMOTE': '1', 11:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:50 INFO - 'NO_EM_RESTART': '1', 11:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:50 INFO - 'PWD': '/builds/slave/test', 11:21:50 INFO - 'SHELL': '/bin/bash', 11:21:50 INFO - 'SHLVL': '1', 11:21:50 INFO - 'TERM': 'linux', 11:21:50 INFO - 'TMOUT': '86400', 11:21:50 INFO - 'USER': 'cltbld', 11:21:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:50 INFO - '_': '/tools/buildbot/bin/python'} 11:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:21:50 INFO - Cleaning up... 11:21:51 INFO - Return code: 0 11:21:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:21:51 INFO - Using env: {'DISPLAY': ':0', 11:21:51 INFO - 'HOME': '/home/cltbld', 11:21:51 INFO - 'LANG': 'en_US.UTF-8', 11:21:51 INFO - 'LANGUAGE': 'en_US:en', 11:21:51 INFO - 'LOGNAME': 'cltbld', 11:21:51 INFO - 'MAIL': '/var/mail/cltbld', 11:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:51 INFO - 'MOZ_NO_REMOTE': '1', 11:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:51 INFO - 'NO_EM_RESTART': '1', 11:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:51 INFO - 'PWD': '/builds/slave/test', 11:21:51 INFO - 'SHELL': '/bin/bash', 11:21:51 INFO - 'SHLVL': '1', 11:21:51 INFO - 'TERM': 'linux', 11:21:51 INFO - 'TMOUT': '86400', 11:21:51 INFO - 'USER': 'cltbld', 11:21:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:51 INFO - '_': '/tools/buildbot/bin/python'} 11:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:51 INFO - Downloading/unpacking psutil>=3.1.1 11:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:21:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:53 INFO - Installing collected packages: psutil 11:21:53 INFO - Running setup.py install for psutil 11:21:53 INFO - building 'psutil._psutil_linux' extension 11:21:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:21:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:21:53 INFO - building 'psutil._psutil_posix' extension 11:21:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:21:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:54 INFO - Successfully installed psutil 11:21:54 INFO - Cleaning up... 11:21:54 INFO - Return code: 0 11:21:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:21:54 INFO - Using env: {'DISPLAY': ':0', 11:21:54 INFO - 'HOME': '/home/cltbld', 11:21:54 INFO - 'LANG': 'en_US.UTF-8', 11:21:54 INFO - 'LANGUAGE': 'en_US:en', 11:21:54 INFO - 'LOGNAME': 'cltbld', 11:21:54 INFO - 'MAIL': '/var/mail/cltbld', 11:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:54 INFO - 'MOZ_NO_REMOTE': '1', 11:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:54 INFO - 'NO_EM_RESTART': '1', 11:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:54 INFO - 'PWD': '/builds/slave/test', 11:21:54 INFO - 'SHELL': '/bin/bash', 11:21:54 INFO - 'SHLVL': '1', 11:21:54 INFO - 'TERM': 'linux', 11:21:54 INFO - 'TMOUT': '86400', 11:21:54 INFO - 'USER': 'cltbld', 11:21:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:54 INFO - '_': '/tools/buildbot/bin/python'} 11:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:21:56 INFO - Installing collected packages: mozsystemmonitor 11:21:56 INFO - Running setup.py install for mozsystemmonitor 11:21:56 INFO - Successfully installed mozsystemmonitor 11:21:56 INFO - Cleaning up... 11:21:56 INFO - Return code: 0 11:21:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x279b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:21:56 INFO - Using env: {'DISPLAY': ':0', 11:21:56 INFO - 'HOME': '/home/cltbld', 11:21:56 INFO - 'LANG': 'en_US.UTF-8', 11:21:56 INFO - 'LANGUAGE': 'en_US:en', 11:21:56 INFO - 'LOGNAME': 'cltbld', 11:21:56 INFO - 'MAIL': '/var/mail/cltbld', 11:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:56 INFO - 'MOZ_NO_REMOTE': '1', 11:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:56 INFO - 'NO_EM_RESTART': '1', 11:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:56 INFO - 'PWD': '/builds/slave/test', 11:21:56 INFO - 'SHELL': '/bin/bash', 11:21:56 INFO - 'SHLVL': '1', 11:21:56 INFO - 'TERM': 'linux', 11:21:56 INFO - 'TMOUT': '86400', 11:21:56 INFO - 'USER': 'cltbld', 11:21:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:56 INFO - '_': '/tools/buildbot/bin/python'} 11:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:56 INFO - Downloading/unpacking jsonschema==2.5.1 11:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:58 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:58 INFO - warning: no files found matching '*.txt' 11:21:58 INFO - no previously-included directories found matching 'build' 11:21:58 INFO - no previously-included directories found matching 'dist' 11:21:58 INFO - no previously-included directories found matching '.git*' 11:21:58 INFO - Installing collected packages: jsonschema, functools32 11:21:58 INFO - Running setup.py install for functools32 11:21:58 INFO - warning: no files found matching '*.txt' 11:21:58 INFO - no previously-included directories found matching 'build' 11:21:58 INFO - no previously-included directories found matching 'dist' 11:21:58 INFO - no previously-included directories found matching '.git*' 11:21:58 INFO - Successfully installed jsonschema functools32 11:21:58 INFO - Cleaning up... 11:21:58 INFO - Return code: 0 11:21:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:59 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 0x279b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:21:59 INFO - Using env: {'DISPLAY': ':0', 11:21:59 INFO - 'HOME': '/home/cltbld', 11:21:59 INFO - 'LANG': 'en_US.UTF-8', 11:21:59 INFO - 'LANGUAGE': 'en_US:en', 11:21:59 INFO - 'LOGNAME': 'cltbld', 11:21:59 INFO - 'MAIL': '/var/mail/cltbld', 11:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:59 INFO - 'MOZ_NO_REMOTE': '1', 11:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:59 INFO - 'NO_EM_RESTART': '1', 11:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:59 INFO - 'PWD': '/builds/slave/test', 11:21:59 INFO - 'SHELL': '/bin/bash', 11:21:59 INFO - 'SHLVL': '1', 11:21:59 INFO - 'TERM': 'linux', 11:21:59 INFO - 'TMOUT': '86400', 11:21:59 INFO - 'USER': 'cltbld', 11:21:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:59 INFO - '_': '/tools/buildbot/bin/python'} 11:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:01 INFO - Downloading docopt-0.6.1.tar.gz 11:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:01 INFO - Running setup.py install for blobuploader 11:22:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:01 INFO - Running setup.py install for requests 11:22:02 INFO - Running setup.py install for docopt 11:22:02 INFO - Successfully installed blobuploader requests docopt 11:22:02 INFO - Cleaning up... 11:22:02 INFO - Return code: 0 11:22:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:02 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 0x279b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:02 INFO - Using env: {'DISPLAY': ':0', 11:22:02 INFO - 'HOME': '/home/cltbld', 11:22:02 INFO - 'LANG': 'en_US.UTF-8', 11:22:02 INFO - 'LANGUAGE': 'en_US:en', 11:22:02 INFO - 'LOGNAME': 'cltbld', 11:22:02 INFO - 'MAIL': '/var/mail/cltbld', 11:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:02 INFO - 'MOZ_NO_REMOTE': '1', 11:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:02 INFO - 'NO_EM_RESTART': '1', 11:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:02 INFO - 'PWD': '/builds/slave/test', 11:22:02 INFO - 'SHELL': '/bin/bash', 11:22:02 INFO - 'SHLVL': '1', 11:22:02 INFO - 'TERM': 'linux', 11:22:02 INFO - 'TMOUT': '86400', 11:22:02 INFO - 'USER': 'cltbld', 11:22:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:02 INFO - '_': '/tools/buildbot/bin/python'} 11:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:02 INFO - Running setup.py (path:/tmp/pip-IW7Y4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:02 INFO - Running setup.py (path:/tmp/pip-RPjR_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:02 INFO - Running setup.py (path:/tmp/pip-i0vGrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:02 INFO - Running setup.py (path:/tmp/pip-W_JuWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:02 INFO - Running setup.py (path:/tmp/pip-VxKJWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:03 INFO - Running setup.py (path:/tmp/pip-1y3__1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:03 INFO - Running setup.py (path:/tmp/pip-eCexQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:03 INFO - Running setup.py (path:/tmp/pip-kIyfqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:03 INFO - Running setup.py (path:/tmp/pip-TPamIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:03 INFO - Running setup.py (path:/tmp/pip-qxTSpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:03 INFO - Running setup.py (path:/tmp/pip-2QRzOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:03 INFO - Running setup.py (path:/tmp/pip-4GOkC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:03 INFO - Running setup.py (path:/tmp/pip-NHdP1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:03 INFO - Running setup.py (path:/tmp/pip-KAQY28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:03 INFO - Running setup.py (path:/tmp/pip-Klk0Yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:03 INFO - Running setup.py (path:/tmp/pip-RHJ_wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:03 INFO - Running setup.py (path:/tmp/pip-ToqYjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:03 INFO - Running setup.py install for manifestparser 11:22:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:22:03 INFO - Running setup.py install for mozcrash 11:22:04 INFO - Running setup.py install for mozdebug 11:22:04 INFO - Running setup.py install for mozdevice 11:22:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:22:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:22:04 INFO - Running setup.py install for mozfile 11:22:04 INFO - Running setup.py install for mozhttpd 11:22:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:22:04 INFO - Running setup.py install for mozinfo 11:22:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:22:04 INFO - Running setup.py install for mozInstall 11:22:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:22:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:22:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:22:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:22:04 INFO - Running setup.py install for mozleak 11:22:04 INFO - Running setup.py install for mozlog 11:22:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:22:04 INFO - Running setup.py install for moznetwork 11:22:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Running setup.py install for mozprocess 11:22:05 INFO - Running setup.py install for mozprofile 11:22:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Running setup.py install for mozrunner 11:22:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Running setup.py install for mozscreenshot 11:22:05 INFO - Running setup.py install for moztest 11:22:05 INFO - Running setup.py install for mozversion 11:22:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:22:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:05 INFO - Cleaning up... 11:22:05 INFO - Return code: 0 11:22:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:05 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 0x279b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:05 INFO - Using env: {'DISPLAY': ':0', 11:22:05 INFO - 'HOME': '/home/cltbld', 11:22:05 INFO - 'LANG': 'en_US.UTF-8', 11:22:05 INFO - 'LANGUAGE': 'en_US:en', 11:22:05 INFO - 'LOGNAME': 'cltbld', 11:22:05 INFO - 'MAIL': '/var/mail/cltbld', 11:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:05 INFO - 'MOZ_NO_REMOTE': '1', 11:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:05 INFO - 'NO_EM_RESTART': '1', 11:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:05 INFO - 'PWD': '/builds/slave/test', 11:22:05 INFO - 'SHELL': '/bin/bash', 11:22:05 INFO - 'SHLVL': '1', 11:22:05 INFO - 'TERM': 'linux', 11:22:05 INFO - 'TMOUT': '86400', 11:22:05 INFO - 'USER': 'cltbld', 11:22:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:05 INFO - '_': '/tools/buildbot/bin/python'} 11:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:05 INFO - Running setup.py (path:/tmp/pip-0nX6oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:05 INFO - Running setup.py (path:/tmp/pip-T95m4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:06 INFO - Running setup.py (path:/tmp/pip-amOncU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:06 INFO - Running setup.py (path:/tmp/pip-QYQdFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:06 INFO - Running setup.py (path:/tmp/pip-mBybqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:06 INFO - Running setup.py (path:/tmp/pip-JqUvAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:06 INFO - Running setup.py (path:/tmp/pip-_wRlIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:06 INFO - Running setup.py (path:/tmp/pip-_2YfIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:06 INFO - Running setup.py (path:/tmp/pip-rx0WRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:06 INFO - Running setup.py (path:/tmp/pip-bsFhJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:06 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)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:06 INFO - Running setup.py (path:/tmp/pip-E22qo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:06 INFO - Running setup.py (path:/tmp/pip-qb7GuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:06 INFO - Running setup.py (path:/tmp/pip-jV_l6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:06 INFO - Running setup.py (path:/tmp/pip-kuysiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:06 INFO - Running setup.py (path:/tmp/pip-G6X_ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:06 INFO - Running setup.py (path:/tmp/pip-X1HmVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:07 INFO - Running setup.py (path:/tmp/pip-KcnMze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:09 INFO - Downloading blessings-1.6.tar.gz 11:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:09 INFO - Installing collected packages: blessings 11:22:09 INFO - Running setup.py install for blessings 11:22:09 INFO - Successfully installed blessings 11:22:09 INFO - Cleaning up... 11:22:09 INFO - Return code: 0 11:22:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:09 INFO - Reading from file tmpfile_stdout 11:22:09 INFO - Current package versions: 11:22:09 INFO - argparse == 1.2.1 11:22:09 INFO - blessings == 1.6 11:22:09 INFO - blobuploader == 1.2.4 11:22:09 INFO - docopt == 0.6.1 11:22:09 INFO - functools32 == 3.2.3-2 11:22:09 INFO - jsonschema == 2.5.1 11:22:09 INFO - manifestparser == 1.1 11:22:09 INFO - mozInstall == 1.12 11:22:09 INFO - mozcrash == 0.17 11:22:09 INFO - mozdebug == 0.1 11:22:09 INFO - mozdevice == 0.48 11:22:09 INFO - mozfile == 1.2 11:22:09 INFO - mozhttpd == 0.7 11:22:09 INFO - mozinfo == 0.9 11:22:09 INFO - mozleak == 0.1 11:22:09 INFO - mozlog == 3.2 11:22:09 INFO - moznetwork == 0.27 11:22:09 INFO - mozprocess == 0.23 11:22:09 INFO - mozprofile == 0.28 11:22:09 INFO - mozrunner == 6.12 11:22:09 INFO - mozscreenshot == 0.1 11:22:09 INFO - mozsystemmonitor == 0.3 11:22:09 INFO - moztest == 0.7 11:22:09 INFO - mozversion == 1.4 11:22:09 INFO - psutil == 3.1.1 11:22:09 INFO - requests == 1.2.3 11:22:09 INFO - wsgiref == 0.1.2 11:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:09 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 0x279b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:09 INFO - Using env: {'DISPLAY': ':0', 11:22:09 INFO - 'HOME': '/home/cltbld', 11:22:09 INFO - 'LANG': 'en_US.UTF-8', 11:22:09 INFO - 'LANGUAGE': 'en_US:en', 11:22:09 INFO - 'LOGNAME': 'cltbld', 11:22:09 INFO - 'MAIL': '/var/mail/cltbld', 11:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:09 INFO - 'MOZ_NO_REMOTE': '1', 11:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:09 INFO - 'NO_EM_RESTART': '1', 11:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:09 INFO - 'PWD': '/builds/slave/test', 11:22:09 INFO - 'SHELL': '/bin/bash', 11:22:09 INFO - 'SHLVL': '1', 11:22:09 INFO - 'TERM': 'linux', 11:22:09 INFO - 'TMOUT': '86400', 11:22:09 INFO - 'USER': 'cltbld', 11:22:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:09 INFO - '_': '/tools/buildbot/bin/python'} 11:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:22:09 INFO - Cleaning up... 11:22:09 INFO - Return code: 0 11:22:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:22:09 INFO - Using env: {'DISPLAY': ':0', 11:22:09 INFO - 'HOME': '/home/cltbld', 11:22:09 INFO - 'LANG': 'en_US.UTF-8', 11:22:09 INFO - 'LANGUAGE': 'en_US:en', 11:22:09 INFO - 'LOGNAME': 'cltbld', 11:22:09 INFO - 'MAIL': '/var/mail/cltbld', 11:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:09 INFO - 'MOZ_NO_REMOTE': '1', 11:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:09 INFO - 'NO_EM_RESTART': '1', 11:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:09 INFO - 'PWD': '/builds/slave/test', 11:22:09 INFO - 'SHELL': '/bin/bash', 11:22:09 INFO - 'SHLVL': '1', 11:22:09 INFO - 'TERM': 'linux', 11:22:09 INFO - 'TMOUT': '86400', 11:22:09 INFO - 'USER': 'cltbld', 11:22:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:09 INFO - '_': '/tools/buildbot/bin/python'} 11:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:22:09 INFO - Cleaning up... 11:22:09 INFO - Return code: 0 11:22:09 INFO - Running post-action listener: _resource_record_post_action 11:22:09 INFO - Running post-action listener: _start_resource_monitoring 11:22:10 INFO - Starting resource monitoring. 11:22:10 INFO - ##### 11:22:10 INFO - ##### Finished create-virtualenv step (success) 11:22:10 INFO - ##### 11:22:10 INFO - ##### 11:22:10 INFO - ##### Running install step. 11:22:10 INFO - ##### 11:22:10 INFO - Running pre-action listener: _resource_record_pre_action 11:22:10 INFO - Running main action method: install 11:22:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:10 INFO - Reading from file tmpfile_stdout 11:22:10 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:22:10 INFO - Reading from file tmpfile_stdout 11:22:10 INFO - Output received: 11:22:10 INFO - Usage: mozinstall [options] installer 11:22:10 INFO - Options: 11:22:10 INFO - -h, --help show this help message and exit 11:22:10 INFO - -d DEST, --destination=DEST 11:22:10 INFO - Directory to install application into. [default: 11:22:10 INFO - "/builds/slave/test"] 11:22:10 INFO - --app=APP Application being installed. [default: firefox] 11:22:10 INFO - mkdir: /builds/slave/test/build/application 11:22:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:22:27 INFO - Reading from file tmpfile_stdout 11:22:27 INFO - Output received: 11:22:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:22:27 INFO - Running post-action listener: _resource_record_post_action 11:22:27 INFO - ##### 11:22:27 INFO - ##### Finished install step (success) 11:22:27 INFO - ##### 11:22:27 INFO - ##### 11:22:27 INFO - ##### Running run-tests step. 11:22:27 INFO - ##### 11:22:27 INFO - Running pre-action listener: _resource_record_pre_action 11:22:27 INFO - Running main action method: run_tests 11:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:22:27 INFO - Python 2.7.3 11:22:27 INFO - Return code: 0 11:22:27 INFO - grabbing minidump binary from tooltool 11:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:27 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 0x2a5a3b0>, '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 0x2a5b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:22:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:22:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:22:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:22:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:27 INFO - Return code: 0 11:22:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:22:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:22:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:22:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:22:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:22:27 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/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:22:27 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/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:22:27 INFO - Using env: {'DISPLAY': ':0', 11:22:27 INFO - 'HOME': '/home/cltbld', 11:22:27 INFO - 'LANG': 'en_US.UTF-8', 11:22:27 INFO - 'LANGUAGE': 'en_US:en', 11:22:27 INFO - 'LOGNAME': 'cltbld', 11:22:27 INFO - 'MAIL': '/var/mail/cltbld', 11:22:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:27 INFO - 'MOZ_NO_REMOTE': '1', 11:22:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:27 INFO - 'NO_EM_RESTART': '1', 11:22:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:27 INFO - 'PWD': '/builds/slave/test', 11:22:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:27 INFO - 'SHELL': '/bin/bash', 11:22:27 INFO - 'SHLVL': '1', 11:22:27 INFO - 'TERM': 'linux', 11:22:27 INFO - 'TMOUT': '86400', 11:22:27 INFO - 'USER': 'cltbld', 11:22:27 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057', 11:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:27 INFO - '_': '/tools/buildbot/bin/python'} 11:22:27 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/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:22:27 INFO - mozversion application_buildid: 20160718081125 11:22:27 INFO - mozversion application_changeset: cde56ead650fd302be1d440507485b9abf7c163a 11:22:27 INFO - mozversion application_display_name: Nightly 11:22:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:27 INFO - mozversion application_name: Firefox 11:22:27 INFO - mozversion application_remotingname: firefox 11:22:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:22:27 INFO - mozversion application_vendor: Mozilla 11:22:27 INFO - mozversion application_version: 50.0a1 11:22:27 INFO - mozversion platform_buildid: 20160718081125 11:22:27 INFO - mozversion platform_changeset: cde56ead650fd302be1d440507485b9abf7c163a 11:22:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:22:27 INFO - mozversion platform_version: 50.0a1 11:22:27 INFO - using testdate: 1468866147 11:22:27 INFO - actual date: 1468866147 11:22:27 INFO - starting webserver on 'localhost:50502' 11:22:27 INFO - SUITE-START | Running 2 tests 11:22:27 INFO - TEST-START | dromaeo_css 11:22:27 INFO - operating with platform_type : linux_ 11:22:27 INFO - Initialising browser for dromaeo_css test... 11:22:27 INFO - TEST-INFO | started process 31995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTjB6LP/profile http://localhost:50502/getInfo.html) 11:22:31 INFO - PROCESS | 31995 | __metrics Screen width/height:1600/1200 11:22:31 INFO - PROCESS | 31995 | colorDepth:24 11:22:31 INFO - PROCESS | 31995 | Browser inner width/height: 1024/697 11:22:31 INFO - PROCESS | 31995 | __metrics 11:22:32 INFO - PROCESS | 31995 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:22:32 INFO - PROCESS | 31995 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:22:33 INFO - TEST-INFO | 31995: exit 0 11:22:33 INFO - Browser initialized. 11:22:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:22:33 INFO - TEST-INFO | started process 32076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTjB6LP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:45 INFO - PROCESS | 32076 | RSS: Main: 157745152 11:22:45 INFO - PROCESS | 32076 | 11:23:36 INFO - PROCESS | 32076 | 1468866216672 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:25:44 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50502/tests/dromaeo/cssquery-ext.html) 11:25:45 INFO - PROCESS | 32076 | RSS: Main: 261926912 11:25:45 INFO - PROCESS | 32076 | 11:28:47 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50502/tests/dromaeo/cssquery-ext.html (next: http://localhost:50502/tests/dromaeo/cssquery-jquery.html) 11:28:48 INFO - PROCESS | 32076 | RSS: Main: 243699712 11:28:48 INFO - PROCESS | 32076 | 11:31:50 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50502/tests/dromaeo/cssquery-mootools.html) 11:31:51 INFO - PROCESS | 32076 | RSS: Main: 235331584 11:31:51 INFO - PROCESS | 32076 | 11:34:53 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50502/tests/dromaeo/cssquery-prototype.html) 11:34:53 INFO - PROCESS | 32076 | RSS: Main: 235958272 11:34:53 INFO - PROCESS | 32076 | 11:37:56 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50502/tests/dromaeo/cssquery-yui.html) 11:37:57 INFO - PROCESS | 32076 | RSS: Main: 222310400 11:37:57 INFO - PROCESS | 32076 | 11:41:00 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50502/tests/dromaeo/cssquery-yui.html (next: http://localhost:50502/tests/dromaeo/cssquery-dojo.html) 11:41:00 INFO - PROCESS | 32076 | RSS: Main: 285319168 11:41:00 INFO - PROCESS | 32076 | 11:41:00 INFO - PROCESS | 32076 | __start_tp_report 11:41:00 INFO - PROCESS | 32076 | _x_x_mozilla_page_load 11:41:00 INFO - PROCESS | 32076 | _x_x_mozilla_page_load_details 11:41:00 INFO - PROCESS | 32076 | |i|pagename|runs| 11:41:00 INFO - PROCESS | 32076 | |0;dojo.html;3023.032629558541;3035.5598438226457;3051.877924883004;3075.3388021575383;3089.2894634234126;5133.948660513393;5139.331886854713;5258.106121959267;5377.247185394043;5397.5951803614735;5211.3746350437905;5279.260903473517;5310.76101575429;5355.277037599923;5372.677639341632;4804.663673542854;4853.39332583427;4892.584130348924;4897.926531102036;4925.039617274633;4845.079434907374;4848.587870031034;4879.6828206166665;4895;4920.3111564381015;4700.435947686283;4730.030343779534;4750.809967601292;4834.033193361307;4850.660453768238;4823.155947709137;4827.637927155477;4891.730954797485;4892.217245240744;4934.851954441372;4641.535846415331;4842.273658951185;4862.051899879525;4873.512648735134;4903.8528844134735;5237.188235823415;5326.547243484309;5327.067763141435;5385.084535628953;5400.729963501848;5730.7707691692285;5759.452851979056;5779.913301300484;5787.1608616750755;5792.304923409218;5580.776768929238;5599.944000559983;5602.327720673505;5810.448007439287;5848.385919478436;5292.8147514837565;5321.813736519203;5345.705986170759;5351.7324133793545;5352.678839269656;5799.768009279666;5809.215755872988;5809.680467574324;5812.099124635688;5821.592488525847;5392.245085688007;5562;5587.217789509472;5592.468715472024;5602.85992850182;5699.4585514376895;5746.482816546447;5756.539476841926;5760.3951585083805;5760.74076666551;5693.914591281134;5696.601237913389;5697.544196464273;5703.486686198262;5734.197212390269;5508.3114610673665;5557.221988921554;5588.30146231721;5596.272484576979;5615.606907516435;4299.892502687458;4302.7848607569495;4307.310830267204;4308.956910430856;4337.414449049338;3799.354109801285;3848.826802793881;3860.8841734748003;3881.3207688654375;3904.843806247775;5302.469753024744;5355.062863998863;5370.543503802142;5383.973080134652;5395.271638328853;5749.741261643236;5755.050416681201;5758.683272419973;5762.510186634099;5770.451807078321;5292.603054770908;5374.8656283592445;5394.649347792381;5440.91838622421;5450.373207081237;4949.282354058641;4957.652964292465;4969.975150124298;4975.950240497621;5018.272350509229;5933.762649493972;5944.227250457413;5946.583739138218;5946.970265148647;5957.07665311886;5467.9453205467435;5676.035074037506;5736.71316434185;5756.136579512939;5820.883582328414;5942.1383899335215;5945.405459454193;5951.970240148771;5954.642721436728;5959.433853783884;5658.151277308437;5662;5664.433556644302;5665;5665.801696940587;5457.045017121908;5711.143328500758;5762.308522977102;5773;5780.5953583248765;5670.829875103754;5676.971615141898;5677.74450149736;5678.858028549319;5679.176519404746;5641.830745077655;5658.377578466283;5660.377358490645;5671.0075736745075;5671.517920976763;5401.054815407367;5438.483344082306;5457.781688732406;5479.863003424946;5516;5563.5271001963665;5595.580331475075;5606.074997625509;5658.745356459051;5661.037623603915;5308.044551980526;5443.510084092451;5486.670799752028;5493.176023596492;5496.7526461310135 11:41:00 INFO - PROCESS | 32076 | |1;ext.html;597.4981015946606;618.2735286038903;618.882412341655;644.1111266452301;646.1374065622393;44006;45367;45496.31755523666;45506.089878202496;48779.51220487794;46537.534624653825;46690.76654616722;46881.29678054823;46997.76501117498;47091.764541177334;9049.502277374742;9066.410683305598;9190.586423610921;9195.126462986005;9198.862017069749;9055.456672599632;9098.818023639524;9138.451692898414;9145;9146.954265228664;9214.354995150343;9241.214496767783;9252.213561847251;9259.86110208344;9265.907340926571;9159.954200228989;9176.357654964155;9190.954045229799;9199.586018629177;9201.309901757395;9017.909820901772;9076.591553380114;9088.272938164931;9090.409123406956;9093.09069093092;43533.782331088456;43681.34477982833;43685;43789.34315985263;43969.78015109936;3476.4263896457055;3491.458823882277;3775.6601905828607;3838.193979264358;3854.2484215577974;34626.13434664128;34646.653533464596;34687.959361219204;34783.30433391318;36624;4419.381286619876;4446.377507149002;4464.285714285698;4479.619232365253;4503.954960450386;351874;356824.9999999974;357378;358354;358434;52165.217521737206;60750.39249607536;61560.38439615636;61636.69181654063;61641;61440.38559614347;62650.686746565974;62892;68934.65532672405;69089.65455172693;16157.757633635505;16347.836521634632;16400.589985250226;16409.6718065638;16420.425285114965;11378.089752819755;11694.94152529249;13319.533816316383;13501.66245843842;13553.525626603021;17603;17919.552011199823;18122.919103752392;18812.529686757665;18853.62292754137;6421;6423.197100362455;6505.284418713938;6538.444232240217;6659.833504162338;917.6742256498846;1005.1205195453978;1035.7928414317166;1107.9728457459955;1125.634168895096;32582.674173258438;32593.185170370456;32927.20374827894;33165.66834331674;33859.83070084683;1067.2902519824386;1090.8800031996475;1109.2235435195234;1116.7989761842784;1146.60442147459;17242.137893105293;17347.739783903253;17546.64906701859;17816.821831781777;17844.55388615269;569440;572520;574975;576094.3585846216;576105;60692.39307606956;60788.69605651943;60790.696046519486;60878.69560652169;60935.39064609297;1246.8940140088014;1345.5290648273221;1349.1837438349658;1382.592135320083;1391.422559637739;33547.664523354455;34407.483887741204;34718;34934.126646833014;35039.82480087583;51797.482025180776;51881;52171;52349.21476177784;52478.737606311726;425565;427201;427488;427521;427690;36516;40810;42244;42424.5757542433;46516.06967860556;47746;49066.26400603922;49069.509304906496;49330.506694934025;49692.75153624209;39073.2185356297;41975.370369443874;42519.362209566265;42936.35595466008;43055.277788888096;41304.79347603243;41822.790886045375;41967.505448781696;42382.57617423786;42709.97188556416;42034.579654203066;42756.1448771029;42855.3571696431;43409.565904340554;43453.78273108614;35117.473237900944;37359.626403735616;37888.81055594704;38474.6152538471;38568.42147367848;25532.74467255378;25738.356541085872;25830.87084564565;26103;26211.606825897245 11:41:00 INFO - PROCESS | 32076 | |2;jquery.html;383.3770123549232;383.8483798899435;391.962763537464;408.2549347440917;413.0891384497184;19140.330088446906;20637.4840628984;21175.258865939697;21362.786372136292;21433.57132857344;19745.21019159232;20025.399238022845;20438.795612043876;20699.482512937146;20703.896480517575;5012.398512178525;5609.49514543691;5811.418858114176;5820.476157145856;5823.330317013555;4073.551909289976;6090.66501342426;6339.841503962415;6343.587666801666;6468.547201695883;6213.596116252452;6412.422881940624;6444.806655800334;6453.354664533556;6457.6771161441975;6353.872922541569;6402.551821372505;6410.1987251593555;6441.677916104176;6448.838779030515;3754.699624030071;5343.652662576959;5618.101103823409;5631.887362252732;5696.829095127153;23843.284701458982;24340.269791906096;24388;24537.877310613512;24817;2385.0698227691214;2419.2863105383954;2454.521368333176;2461.3108329667543;2522.709888362825;9343.486108264044;14417.78373324401;14769.630759230999;15345.923270383688;15347.769783453146;1901.9144138513661;1932.4492519631979;1942.524081600003;1981.2669312354376;2005.3683089826804;83989.58005209996;91710.0828991715;91784;92090.53954730183;92800;10943.671689849318;10994.560217591366;11127.332360058423;11145.275557088764;11263.549458021751;15071;15111.31999060045;15207.695846083237;15268.31292591836;15303.234838258042;8170.550619715973;8282.668693252323;8487.915120848837;8607.354448416394;8616.310695144373;8284.917150828414;8340.582970851434;8358.247757701836;8517.48895066298;8534.189252021048;4314.094040251583;4462.107578484316;4511.526289739596;4661.27750198713;4759.809607615726;1769.282489674373;1770.6458708258142;1797.7842658880757;1900.6673832079607;1962.6859702447825;925.121134921827;931.7391130483476;947.6541062512272;1001.7395477175987;1013.807376598444;19240.807591924182;20068.598628027357;20277.49306267355;20358.28745993883;20723.58552828935;989.1987490132872;1000.429755039635;1059.2373491086405;1068.3536460441476;1090.0897750378365;10631.946840265904;11188.888111118948;11191.832122518168;11218.046466050477;11244.49399777012;402682;403131;403696;494445;538050;105859.470702646;107204;108874.45562772136;109767;111878.44060779807;994.6178901530938;1016.8220561401725;1022.7289768211579;1026.2046913641839;1027.6197806811529;18299.81700182981;18342;18596.907015464836;18865.245390184788;19002.619947600695;45242.09515809731;45552;45635.54364456446;46468.30297545472;49079.50920490892;64765.67617161884;65602;66110.33889661042;66130.66934665295;66735.66632166808;8288.21261980111;8325.791855203668;8401.789955250923;8443.113473085237;8515;13079.803802942773;13139.211647301192;13885.583432497042;13940.163590184622;13948.372323245276;11833.467493962964;12120.64081128411;12328;12420.937895310466;12535.623931282076;12238.143329967173;12333.814992774936;12433.06751993586;12583.307918064595;12819.871801281868;12061;12398.16471576068;12592.11855170166;12626.43181056873;12788.168769029984;8361.749147525585;8368.87446688288;8489.533075680896;8515.787105322417;8568.286342731353;6944.861102778017;8356.6239519223;11043.723272450858;12061;12301 11:41:00 INFO - PROCESS | 32076 | |3;mootools.html;1368.179092544474;1459.7153555056761;1498.6777842763804;1623.7564365345204;1788.7674602301706;8619.870701939475;8940.418872773265;8945.642174313029;9189.77025574361;9198.678046268382;8926.2412694921;9090.272778177747;9093.227075698573;9097.909020909805;9100.36297459178;1982.8017198280202;2291.415688999311;2337.2871274261342;2361.9763802362013;2386.427257458215;2319.22306027481;2322.268485427085;2333.7316208636053;2334.159702507096;2334.754850740673;2344.765523447659;2367.396313939943;2367.988160059197;2368.917087901924;2370.3363058343607;1919.3282351177047;2244.057495851738;2278.157081879715;2338.1699496678602;2339.9649005264932;2290.061074959275;2299.0918587158144;2314.4329639238495;2320.7215134184007;2321.1063740459876;9252.444853308823;9296.581653825595;9302.674406395812;9312.34813563051;9320.533973301375;5312.229726689647;5400.405955344909;5451.945480545183;5458.61789674719;5460.399356070829;3452.395830729612;3547.18414764603;3591.515145455356;3602.3335682898746;3641.799701016443;1156.6240971684151;1164.2956011612937;1185.205912038936;1193.8089905615147;1209.105262106044;12890.226586404846;12917.67705807353;12930.676733081655;12950.093493455463;12964.740705185937;4470.955290447054;4678.345031695565;4742.217534106834;4810.542998415145;4810.783514741775;10537.89462105369;10542.631007914686;10545.31455455393;10546.314489558154;10581.89418105809;5407.648502847303;5408.269883565668;5412.539934105645;5414.91877621836;5422.132458806572;4279.379489973999;4787.305840653155;4925.605951523869;4951.3810773653295;4998.350214472168;3995.580464051233;4023.322760218356;4026.355783074694;4048.595140485928;4164.8125834337525;1087.445402844555;1137.3914955498933;1266.5250531050856;1269.156011252525;1291.8837304642627;842.9072801991776;923.1184219070772;929.0245242495353;943.1558754914313;975.0298453039129;6237.96881015592;6328.11406403104;6330.145430366933;6429.774957876545;6507.837304067436;939.1969865764672;967.9903200968041;975.4149507051042;1022.4274406332478;1033.6020632056561;4229.386738922839;4320.071184695305;4385.079133381962;4430.136123455895;4442.378067070613;11404;11591.420428978518;11691.356975366267;11701.824472632918;11724.296542207494;11502.884971150348;11532.481038353295;11552.422378881023;11622.302661840147;11625.128115391379;8086.555239461768;8378.24595786382;8386.622601982925;8492.532910689972;8672.956635216784;5988.131720900358;6125.448709616156;6137.1101190328045;6239.313675495782;6258.342873998165;10476.319039262728;10576.629817956335;10846.457677115955;10860.511276992396;10862;10868.967448092419;10882.945585272022;10914.617988370368;10938.289011214245;11124.165687573626;7804.570748608881;7826.7651970440975;7892.684292628231;7960.880586791319;7963.482373645695;8814.206721395105;8816.911830881865;8887.15572020657;8888.377813552988;8892.15524525169;7381.926180738339;7624.618769061413;7624.656890439833;7699.345555627834;7764.572948487661;7188.065551478275;7226.313500217471;7429.962850185931;7498.550086994798;7590.924090759022;7280.490365674352;7313.707451701873;7356.705731770883;7359.448041397024;7374.446916481178;5308.920366194433;5440.619156658996;5512.614117011771;5631.549476041989;5719.942800571941;5388.54197393226;5445.074337362737;5515.09001014828;5583.972080139736;5615.522680572197 11:41:00 INFO - PROCESS | 32076 | |4;prototype.html;325.79637726420987;327.3812494385611;334.32966901362795;337.4802803682331;338.2136532561794;5275.232797013001;5283.07546179419;5308.416074231832;5315.441878602749;5348.866278343034;5188.014277287322;5194.792208311673;5230.529252367286;5245.370555533342;5252.030488566787;3968.384900340445;4002.5196976362877;4111.807575803014;4133.834646614132;4184.7907604619795;4084.4690190275223;4106.32245679464;4117.876463706094;4117.999999999985;4142.2958097123565;3967.3453880109746;4086.550479447273;4100.671946244293;4102.302608556538;4108.815103320343;4079.287273962811;4140.399642051901;4183.97908010458;4184.644305234059;4193.203291374629;3696.057505336149;3723.9945214791856;3724.5902950675404;3728.9627103728885;3740.345439548068;5191.610629202825;5213.165893457029;5237.397699264595;5262.7631756571045;5283.837555737731;4473.306637471197;4666.113438446684;4678.134545109132;4701.200795864711;4705.600023997964;5470.863228419322;5487.286652735119;5511.311086114236;5558.666480011172;5560.555155587544;3869.090763670535;3957.821898014596;3969.642732154091;3976.423418604315;3980.542237642679;5670.858228544278;5704.600677952545;5712.542996560265;5721.742521586497;5737.250138707693;4051.1897620476025;4054.3310353791885;4074.4703188585295;4078.898027549276;4093.488313960755;3919.235749028969;4113.547509773923;4152.148809494047;4154.646855017358;4157.48031496063;4667.813287468532;4696.483386827446;4720.386349774507;4727.149113159664;4735.6503396531825;5557.305021968257;5623.5097699109765;5628.465295796893;5630.577706672016;5646.378898321182;1361.1220762608061;1423.7650787619928;1427.2578259305103;1445.8481859404822;1446.1106419552111;867.7700409391516;910.8178364327028;921.8292768184502;955.0592666223764;988.6440881282732;5285.973570132125;5296.894062118736;5308.628396012319;5313.290221986737;5320.813771517978;5563.527100196528;5594.636348637326;5608.85977850557;5625.240592519957;5629.521490673339;5151.175811870083;5312.468753124656;5321.893562128813;5407.270018547524;5421.972890135524;3021.8942337018098;3031.6058912341255;3043.949837306126;3046.4211799757977;3049.2224482756756;5696.746715722617;5900.911486327708;5902.763889444374;5907.379725128885;5907.9704601476715;5797.9420205797405;5807.734983356494;5832.270966129234;5837.941620583825;5839.328477225088;5837.532997360201;5858.418227078665;5876.7649294028615;5896;5929.644221346733;5436.755346009518;5664;5683.8010669626365;5735.4551317624755;5741.770329186786;5636.773474477476;5652.434756524314;5660.320761508646;5662.292213473316;5697.7436015380235;5706.343770466284;5895;5920.437558431942;5925.05199168131;5956.076808094752;4134.131832315247;4138.606832350922;4153.563875792998;4156.231097247019;4159.604837540429;5637.605367624391;5680.091185410314;5685.061964775766;5706;5709.144528028324;5363.176519983224;5515.751791169488;5525.723713814374;5537.5569954404355;5559.388467268516;5468.726563671721;5473.425290344457;5485.259489968803;5548.944510554843;5564.415736347625;5288.153895376721;5317.468253174651;5442.782288708408;5455.863603409946;5484.765927666243;5579.6652200868075;5591.692456914746;5594.86012849682;5594.888102237851;5598.32820061579;5463.508284254436;5464.885015541262;5470.835874923759;5484.709174495271;5511.779528818803 11:41:00 INFO - PROCESS | 32076 | |5;yui.html;773.8258891749354;782.1474592693962;799.7001124578284;814.4380377539499;836.071960124262;15108.320125594348;15372.69254614907;15945.68108637828;15946.122963237018;16023.99999999997;15126.773098403506;15404.845951540481;15507.457238996609;15521.301541430634;15635.609109772233;665.5241502325836;790.8774140008308;792.1484404265409;817.8527864984301;821.1255013410728;815.7838172884191;825.8224481736426;829.1915382502042;830.0993422136988;831.7421599304205;868.0364795077459;872.5026734761188;873.0745409865531;873.3144481581959;874.0298268921492;700.7687463137153;824.077033722229;824.3240542754943;866.3632230310717;867.0289276010876;615.1418770814734;616.901295792671;616.9413905678954;616.9969150154266;618.1222663817346;15188.848111518964;15218.163001034938;15265.38938442461;15271.083734975826;15272.38910443581;13556.254406007665;13792.586222413343;13837.377318020612;13916.930415347959;14295.28523573817;13192.934035329761;13214.86785132146;13261;13381.397837097256;13834.031617786759;4369.453818272716;4384.4519435070615;4535.478419981711;4545;4562.5665561771575;76317.61841190814;76776.61611691961;77328.61335693342;78204;78214;10333.741656458498;10351.275410721177;10553.736156596147;10638.787224255471;10755.300905441121;19799.10904009323;19807.60384792325;19816.108275127655;19827.206911723657;19862.404127876187;8058.637361318754;8144.470609410369;8157.306628936488;8271.296939760188;8301.875471867927;4535.433070866142;4674.5325467452985;4687.929681054787;4806.303086052503;5032.194848824171;3266.6733326667145;3589.892303230907;3608.4767708682093;3614.1326081740717;3615.168511242429;616.8334549671654;623.3268070483866;629.3454807000668;637.6142433827467;637.8532937424418;579.8946640738783;601.6059481039925;603.2429301226932;627.4165026525375;651.4495251512465;8669.349798764992;9548;9638.084381983701;9656.130948214695;10044.347117437343;646.7800947677812;660.4617236951868;672.8385187554951;690.7237105157876;701.4633805139073;4623.514530974199;4733.502982186889;4748.264019077049;4768.713877167381;4768.904621907612;114749.4262528682;117944.41027794806;119409;121783;122031;74511;104947;105307.47346263373;105555;105758;85434.57282713671;88758;93240.53379733194;95537.52231238938;97574.51212743891;9368.341398331275;9783.517884170922;9838.908183145435;10028.64899728506;10180.949095254477;51920.15793807376;52925.735371322895;53534.464655352946;53621.463785361644;55084.17373739317;72125;72274;78655;80240.59879700564;82108.58945705234;14115.576532704035;14146.292685365896;14278.928605356907;14368.13791172533;14453.349599267847;14449.85550144485;14614.647583687612;14796.48212312607;14860.331285091981;15695.058296502246;12895.226286422845;12951.611451656465;13039.348032598142;13188.340582971005;13623.795643065163;13663.316834158053;13982.790258146339;14042.438302467786;14362.13827170373;14597.27013649292;14378.496752613608;14818.703625927637;15080.773788393402;15118.402538694181;15240.161791101596;11150.776984460428;11285.322880627189;11326.773464530828;11393.202475826612;11572.94213528927;11182.776344473228;11456.255343402652;11657.855228147593;12000.219985700902;12135.847094526005 11:41:00 INFO - PROCESS | 32076 | __end_tp_report 11:41:00 INFO - PROCESS | 32076 | __start_cc_report 11:41:00 INFO - PROCESS | 32076 | _x_x_mozilla_cycle_collect,934 11:41:00 INFO - PROCESS | 32076 | __end_cc_report 11:41:00 INFO - PROCESS | 32076 | __startTimestamp1468867260425__endTimestamp 11:41:00 INFO - PROCESS | 32076 | 11:41:00 INFO - PROCESS | 32076 | ------- Summary: start ------- 11:41:00 INFO - PROCESS | 32076 | Number of tests: 6 11:41:00 INFO - PROCESS | 32076 | 11:41:00 INFO - PROCESS | 32076 | [#0] dojo.html Cycles:165 Average:5297.46 Median:5467.95 stddev:615.01 (11.2%) stddev-sans-first:590.44 11:41:00 INFO - PROCESS | 32076 | Values: 3023.0 3035.6 3051.9 3075.3 3089.3 5133.9 5139.3 5258.1 5377.2 5397.6 5211.4 5279.3 5310.8 5355.3 5372.7 4804.7 4853.4 4892.6 4897.9 4925.0 4845.1 4848.6 4879.7 4895.0 4920.3 4700.4 4730.0 4750.8 4834.0 4850.7 4823.2 4827.6 4891.7 4892.2 4934.9 4641.5 4842.3 4862.1 4873.5 4903.9 5237.2 5326.5 5327.1 5385.1 5400.7 5730.8 5759.5 5779.9 5787.2 5792.3 5580.8 5599.9 5602.3 5810.4 5848.4 5292.8 5321.8 5345.7 5351.7 5352.7 5799.8 5809.2 5809.7 5812.1 5821.6 5392.2 5562.0 5587.2 5592.5 5602.9 5699.5 5746.5 5756.5 5760.4 5760.7 5693.9 5696.6 5697.5 5703.5 5734.2 5508.3 5557.2 5588.3 5596.3 5615.6 4299.9 4302.8 4307.3 4309.0 4337.4 3799.4 3848.8 3860.9 3881.3 3904.8 5302.5 5355.1 5370.5 5384.0 5395.3 5749.7 5755.1 5758.7 5762.5 5770.5 5292.6 5374.9 5394.6 5440.9 5450.4 4949.3 4957.7 4970.0 4976.0 5018.3 5933.8 5944.2 5946.6 5947.0 5957.1 5467.9 5676.0 5736.7 5756.1 5820.9 5942.1 5945.4 5952.0 5954.6 5959.4 5658.2 5662.0 5664.4 5665.0 5665.8 5457.0 5711.1 5762.3 5773.0 5780.6 5670.8 5677.0 5677.7 5678.9 5679.2 5641.8 5658.4 5660.4 5671.0 5671.5 5401.1 5438.5 5457.8 5479.9 5516.0 5563.5 5595.6 5606.1 5658.7 5661.0 5308.0 5443.5 5486.7 5493.2 5496.8 11:41:00 INFO - PROCESS | 32076 | 11:41:00 INFO - PROCESS | 32076 | [#1] ext.html Cycles:180 Average:62342.28 Median:43232.42 stddev:122363.45 (283.0%) stddev-sans-first:122618.90 11:41:00 INFO - PROCESS | 32076 | Values: 597.5 618.3 618.9 644.1 646.1 44006.0 45367.0 45496.3 45506.1 48779.5 46537.5 46690.8 46881.3 46997.8 47091.8 9049.5 9066.4 9190.6 9195.1 9198.9 9055.5 9098.8 9138.5 9145.0 9147.0 9214.4 9241.2 9252.2 9259.9 9265.9 9160.0 9176.4 9191.0 9199.6 9201.3 9017.9 9076.6 9088.3 9090.4 9093.1 43533.8 43681.3 43685.0 43789.3 43969.8 3476.4 3491.5 3775.7 3838.2 3854.2 34626.1 34646.7 34688.0 34783.3 36624.0 4419.4 4446.4 4464.3 4479.6 4504.0 351874.0 356825.0 357378.0 358354.0 358434.0 52165.2 60750.4 61560.4 61636.7 61641.0 61440.4 62650.7 62892.0 68934.7 69089.7 16157.8 16347.8 16400.6 16409.7 16420.4 11378.1 11694.9 13319.5 13501.7 13553.5 17603.0 17919.6 18122.9 18812.5 18853.6 6421.0 6423.2 6505.3 6538.4 6659.8 917.7 1005.1 1035.8 1108.0 1125.6 32582.7 32593.2 32927.2 33165.7 33859.8 1067.3 1090.9 1109.2 1116.8 1146.6 17242.1 17347.7 17546.6 17816.8 17844.6 569440.0 572520.0 574975.0 576094.4 576105.0 60692.4 60788.7 60790.7 60878.7 60935.4 1246.9 1345.5 1349.2 1382.6 1391.4 33547.7 34407.5 34718.0 34934.1 35039.8 51797.5 51881.0 52171.0 52349.2 52478.7 425565.0 427201.0 427488.0 427521.0 427690.0 36516.0 40810.0 42244.0 42424.6 46516.1 47746.0 49066.3 49069.5 49330.5 49692.8 39073.2 41975.4 42519.4 42936.4 43055.3 41304.8 41822.8 41967.5 42382.6 42710.0 42034.6 42756.1 42855.4 43409.6 43453.8 35117.5 37359.6 37888.8 38474.6 38568.4 25532.7 25738.4 25830.9 26103.0 26211.6 11:41:00 INFO - PROCESS | 32076 | 11:41:00 INFO - PROCESS | 32076 | [#2] jquery.html Cycles:180 Average:29268.13 Median:24364.13 stddev:75508.53 (309.9%) stddev-sans-first:75689.20 11:41:00 INFO - PROCESS | 32076 | Values: 383.4 383.8 392.0 408.3 413.1 19140.3 20637.5 21175.3 21362.8 21433.6 19745.2 20025.4 20438.8 20699.5 20703.9 5012.4 5609.5 5811.4 5820.5 5823.3 4073.6 6090.7 6339.8 6343.6 6468.5 6213.6 6412.4 6444.8 6453.4 6457.7 6353.9 6402.6 6410.2 6441.7 6448.8 3754.7 5343.7 5618.1 5631.9 5696.8 23843.3 24340.3 24388.0 24537.9 24817.0 2385.1 2419.3 2454.5 2461.3 2522.7 9343.5 14417.8 14769.6 15345.9 15347.8 1901.9 1932.4 1942.5 1981.3 2005.4 83989.6 91710.1 91784.0 92090.5 92800.0 10943.7 10994.6 11127.3 11145.3 11263.5 15071.0 15111.3 15207.7 15268.3 15303.2 8170.6 8282.7 8487.9 8607.4 8616.3 8284.9 8340.6 8358.2 8517.5 8534.2 4314.1 4462.1 4511.5 4661.3 4759.8 1769.3 1770.6 1797.8 1900.7 1962.7 925.1 931.7 947.7 1001.7 1013.8 19240.8 20068.6 20277.5 20358.3 20723.6 989.2 1000.4 1059.2 1068.4 1090.1 10631.9 11188.9 11191.8 11218.0 11244.5 402682.0 403131.0 403696.0 494445.0 538050.0 105859.5 107204.0 108874.5 109767.0 111878.4 994.6 1016.8 1022.7 1026.2 1027.6 18299.8 18342.0 18596.9 18865.2 19002.6 45242.1 45552.0 45635.5 46468.3 49079.5 64765.7 65602.0 66110.3 66130.7 66735.7 8288.2 8325.8 8401.8 8443.1 8515.0 13079.8 13139.2 13885.6 13940.2 13948.4 11833.5 12120.6 12328.0 12420.9 12535.6 12238.1 12333.8 12433.1 12583.3 12819.9 12061.0 12398.2 12592.1 12626.4 12788.2 8361.7 8368.9 8489.5 8515.8 8568.3 6944.9 8356.6 11043.7 12061.0 12301.0 11:41:00 INFO - PROCESS | 32076 | 11:41:00 INFO - PROCESS | 32076 | [#3] mootools.html Cycles:180 Average:6010.34 Median:4764.76 stddev:3480.72 (73.1%) stddev-sans-first:3473.00 11:41:00 INFO - PROCESS | 32076 | Values: 1368.2 1459.7 1498.7 1623.8 1788.8 8619.9 8940.4 8945.6 9189.8 9198.7 8926.2 9090.3 9093.2 9097.9 9100.4 1982.8 2291.4 2337.3 2362.0 2386.4 2319.2 2322.3 2333.7 2334.2 2334.8 2344.8 2367.4 2368.0 2368.9 2370.3 1919.3 2244.1 2278.2 2338.2 2340.0 2290.1 2299.1 2314.4 2320.7 2321.1 9252.4 9296.6 9302.7 9312.3 9320.5 5312.2 5400.4 5451.9 5458.6 5460.4 3452.4 3547.2 3591.5 3602.3 3641.8 1156.6 1164.3 1185.2 1193.8 1209.1 12890.2 12917.7 12930.7 12950.1 12964.7 4471.0 4678.3 4742.2 4810.5 4810.8 10537.9 10542.6 10545.3 10546.3 10581.9 5407.6 5408.3 5412.5 5414.9 5422.1 4279.4 4787.3 4925.6 4951.4 4998.4 3995.6 4023.3 4026.4 4048.6 4164.8 1087.4 1137.4 1266.5 1269.2 1291.9 842.9 923.1 929.0 943.2 975.0 6238.0 6328.1 6330.1 6429.8 6507.8 939.2 968.0 975.4 1022.4 1033.6 4229.4 4320.1 4385.1 4430.1 4442.4 11404.0 11591.4 11691.4 11701.8 11724.3 11502.9 11532.5 11552.4 11622.3 11625.1 8086.6 8378.2 8386.6 8492.5 8673.0 5988.1 6125.4 6137.1 6239.3 6258.3 10476.3 10576.6 10846.5 10860.5 10862.0 10869.0 10882.9 10914.6 10938.3 11124.2 7804.6 7826.8 7892.7 7960.9 7963.5 8814.2 8816.9 8887.2 8888.4 8892.2 7381.9 7624.6 7624.7 7699.3 7764.6 7188.1 7226.3 7430.0 7498.6 7590.9 7280.5 7313.7 7356.7 7359.4 7374.4 5308.9 5440.6 5512.6 5631.5 5719.9 5388.5 5445.1 5515.1 5584.0 5615.5 11:41:00 INFO - PROCESS | 32076 | 11:41:00 INFO - PROCESS | 32076 | [#4] prototype.html Cycles:180 Average:4673.75 Median:5316.46 stddev:1370.94 (25.8%) stddev-sans-first:1335.38 11:41:00 INFO - PROCESS | 32076 | Values: 325.8 327.4 334.3 337.5 338.2 5275.2 5283.1 5308.4 5315.4 5348.9 5188.0 5194.8 5230.5 5245.4 5252.0 3968.4 4002.5 4111.8 4133.8 4184.8 4084.5 4106.3 4117.9 4118.0 4142.3 3967.3 4086.6 4100.7 4102.3 4108.8 4079.3 4140.4 4184.0 4184.6 4193.2 3696.1 3724.0 3724.6 3729.0 3740.3 5191.6 5213.2 5237.4 5262.8 5283.8 4473.3 4666.1 4678.1 4701.2 4705.6 5470.9 5487.3 5511.3 5558.7 5560.6 3869.1 3957.8 3969.6 3976.4 3980.5 5670.9 5704.6 5712.5 5721.7 5737.3 4051.2 4054.3 4074.5 4078.9 4093.5 3919.2 4113.5 4152.1 4154.6 4157.5 4667.8 4696.5 4720.4 4727.1 4735.7 5557.3 5623.5 5628.5 5630.6 5646.4 1361.1 1423.8 1427.3 1445.8 1446.1 867.8 910.8 921.8 955.1 988.6 5286.0 5296.9 5308.6 5313.3 5320.8 5563.5 5594.6 5608.9 5625.2 5629.5 5151.2 5312.5 5321.9 5407.3 5422.0 3021.9 3031.6 3043.9 3046.4 3049.2 5696.7 5900.9 5902.8 5907.4 5908.0 5797.9 5807.7 5832.3 5837.9 5839.3 5837.5 5858.4 5876.8 5896.0 5929.6 5436.8 5664.0 5683.8 5735.5 5741.8 5636.8 5652.4 5660.3 5662.3 5697.7 5706.3 5895.0 5920.4 5925.1 5956.1 4134.1 4138.6 4153.6 4156.2 4159.6 5637.6 5680.1 5685.1 5706.0 5709.1 5363.2 5515.8 5525.7 5537.6 5559.4 5468.7 5473.4 5485.3 5548.9 5564.4 5288.2 5317.5 5442.8 5455.9 5484.8 5579.7 5591.7 5594.9 5594.9 5598.3 5463.5 5464.9 5470.8 5484.7 5511.8 11:41:00 INFO - PROCESS | 32076 | 11:41:00 INFO - PROCESS | 32076 | [#5] yui.html Cycles:180 Average:21344.03 Median:4540.24 stddev:30965.21 (682.0%) stddev-sans-first:31013.55 11:41:00 INFO - PROCESS | 32076 | Values: 773.8 782.1 799.7 814.4 836.1 15108.3 15372.7 15945.7 15946.1 16024.0 15126.8 15404.8 15507.5 15521.3 15635.6 665.5 790.9 792.1 817.9 821.1 815.8 825.8 829.2 830.1 831.7 868.0 872.5 873.1 873.3 874.0 700.8 824.1 824.3 866.4 867.0 615.1 616.9 616.9 617.0 618.1 15188.8 15218.2 15265.4 15271.1 15272.4 13556.3 13792.6 13837.4 13916.9 14295.3 13192.9 13214.9 13261.0 13381.4 13834.0 4369.5 4384.5 4535.5 4545.0 4562.6 76317.6 76776.6 77328.6 78204.0 78214.0 10333.7 10351.3 10553.7 10638.8 10755.3 19799.1 19807.6 19816.1 19827.2 19862.4 8058.6 8144.5 8157.3 8271.3 8301.9 4535.4 4674.5 4687.9 4806.3 5032.2 3266.7 3589.9 3608.5 3614.1 3615.2 616.8 623.3 629.3 637.6 637.9 579.9 601.6 603.2 627.4 651.4 8669.3 9548.0 9638.1 9656.1 10044.3 646.8 660.5 672.8 690.7 701.5 4623.5 4733.5 4748.3 4768.7 4768.9 114749.4 117944.4 119409.0 121783.0 122031.0 74511.0 104947.0 105307.5 105555.0 105758.0 85434.6 88758.0 93240.5 95537.5 97574.5 9368.3 9783.5 9838.9 10028.6 10180.9 51920.2 52925.7 53534.5 53621.5 55084.2 72125.0 72274.0 78655.0 80240.6 82108.6 14115.6 14146.3 14278.9 14368.1 14453.3 14449.9 14614.6 14796.5 14860.3 15695.1 12895.2 12951.6 13039.3 13188.3 13623.8 13663.3 13982.8 14042.4 14362.1 14597.3 14378.5 14818.7 15080.8 15118.4 15240.2 11150.8 11285.3 11326.8 11393.2 11572.9 11182.8 11456.3 11657.9 12000.2 12135.8 11:41:00 INFO - PROCESS | 32076 | -------- Summary: end -------- 11:41:00 INFO - PROCESS | 32076 | 11:41:01 INFO - TEST-INFO | 32076: exit 0 11:41:01 INFO - TEST-OK | dromaeo_css | took 1113176ms 11:41:01 INFO - TEST-START | kraken 11:41:01 INFO - operating with platform_type : linux_ 11:41:01 INFO - Initialising browser for kraken test... 11:41:01 INFO - TEST-INFO | started process 32266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSpQNRz/profile http://localhost:50502/getInfo.html) 11:41:05 INFO - PROCESS | 32266 | __metrics Screen width/height:1600/1200 11:41:05 INFO - PROCESS | 32266 | colorDepth:24 11:41:05 INFO - PROCESS | 32266 | Browser inner width/height: 1024/697 11:41:05 INFO - PROCESS | 32266 | __metrics 11:41:05 INFO - PROCESS | 32266 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:41:05 INFO - PROCESS | 32266 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:41:06 INFO - TEST-INFO | 32266: exit 0 11:41:06 INFO - Browser initialized. 11:41:06 INFO - Running cycle 1/1 for kraken test... 11:41:06 INFO - TEST-INFO | started process 32349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSpQNRz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:18 INFO - PROCESS | 32349 | RSS: Main: 157855744 11:41:18 INFO - PROCESS | 32349 | 11:41:21 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50502/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:21 INFO - PROCESS | 32349 | RSS: Main: 217329664 11:41:21 INFO - PROCESS | 32349 | 11:41:24 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50502/tests/kraken/driver.html?testName=audio-dft) 11:41:25 INFO - PROCESS | 32349 | RSS: Main: 205758464 11:41:25 INFO - PROCESS | 32349 | 11:41:28 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50502/tests/kraken/driver.html?testName=audio-fft) 11:41:28 INFO - PROCESS | 32349 | RSS: Main: 269991936 11:41:28 INFO - PROCESS | 32349 | 11:41:30 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50502/tests/kraken/driver.html?testName=audio-oscillator) 11:41:31 INFO - PROCESS | 32349 | RSS: Main: 180355072 11:41:31 INFO - PROCESS | 32349 | 11:41:33 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:34 INFO - PROCESS | 32349 | RSS: Main: 184807424 11:41:34 INFO - PROCESS | 32349 | 11:41:37 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50502/tests/kraken/driver.html?testName=imaging-darkroom) 11:41:37 INFO - PROCESS | 32349 | RSS: Main: 220426240 11:41:37 INFO - PROCESS | 32349 | 11:41:41 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50502/tests/kraken/driver.html?testName=imaging-desaturate) 11:41:41 INFO - PROCESS | 32349 | RSS: Main: 221474816 11:41:41 INFO - PROCESS | 32349 | 11:41:44 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50502/tests/kraken/driver.html?testName=json-parse-financial) 11:41:45 INFO - PROCESS | 32349 | RSS: Main: 221454336 11:41:45 INFO - PROCESS | 32349 | 11:41:46 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:41:47 INFO - PROCESS | 32349 | RSS: Main: 209563648 11:41:47 INFO - PROCESS | 32349 | 11:41:48 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50502/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:41:49 INFO - PROCESS | 32349 | RSS: Main: 213426176 11:41:49 INFO - PROCESS | 32349 | 11:41:51 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:41:52 INFO - PROCESS | 32349 | RSS: Main: 212258816 11:41:52 INFO - PROCESS | 32349 | 11:41:54 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:41:55 INFO - PROCESS | 32349 | RSS: Main: 223576064 11:41:55 INFO - PROCESS | 32349 | 11:41:57 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:58 INFO - PROCESS | 32349 | RSS: Main: 223100928 11:41:58 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | Cycle 1(1): loaded http://localhost:50502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50502/tests/kraken/driver.html?testName=ai-astar) 11:42:00 INFO - PROCESS | 32349 | RSS: Main: 265535488 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | __start_tp_report 11:42:00 INFO - PROCESS | 32349 | _x_x_mozilla_page_load 11:42:00 INFO - PROCESS | 32349 | _x_x_mozilla_page_load_details 11:42:00 INFO - PROCESS | 32349 | |i|pagename|runs| 11:42:00 INFO - PROCESS | 32349 | |0;ai-astar;101;112;110;111;111;111;110;109;110;110 11:42:00 INFO - PROCESS | 32349 | |1;audio-beat-detection;147;115;125;174;120;119;141;117;148;115 11:42:00 INFO - PROCESS | 32349 | |2;audio-dft;161;160;160;161;161;162;161;162;161;161 11:42:00 INFO - PROCESS | 32349 | |3;audio-fft;74;74;75;110;75;75;74;75;102;75 11:42:00 INFO - PROCESS | 32349 | |4;audio-oscillator;84;84;115;83;83;83;124;84;84;132 11:42:00 INFO - PROCESS | 32349 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;116;118;116 11:42:00 INFO - PROCESS | 32349 | |6;imaging-darkroom;146;147;146;145;147;146;146;145;145;145 11:42:00 INFO - PROCESS | 32349 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 11:42:00 INFO - PROCESS | 32349 | |8;json-parse-financial;51;50;50;52;52;52;52;52;50;51 11:42:00 INFO - PROCESS | 32349 | |9;json-stringify-tinderbox;59;60;60;60;60;59;60;60;61;61 11:42:00 INFO - PROCESS | 32349 | |10;stanford-crypto-aes;76;75;74;74;74;75;78;77;84;75 11:42:00 INFO - PROCESS | 32349 | |11;stanford-crypto-ccm;128;124;124;116;130;128;129;133;167;120 11:42:00 INFO - PROCESS | 32349 | |12;stanford-crypto-pbkdf2;156;159;158;153;155;155;152;154;155;159 11:42:00 INFO - PROCESS | 32349 | |13;stanford-crypto-sha256-iterative;67;62;65;63;63;64;63;62;65;62 11:42:00 INFO - PROCESS | 32349 | __end_tp_report 11:42:00 INFO - PROCESS | 32349 | __start_cc_report 11:42:00 INFO - PROCESS | 32349 | _x_x_mozilla_cycle_collect,1638 11:42:00 INFO - PROCESS | 32349 | __end_cc_report 11:42:00 INFO - PROCESS | 32349 | __startTimestamp1468867320405__endTimestamp 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | ------- Summary: start ------- 11:42:00 INFO - PROCESS | 32349 | Number of tests: 14 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:3.10 (2.8%) stddev-sans-first:0.88 11:42:00 INFO - PROCESS | 32349 | Values: 101.0 112.0 110.0 111.0 111.0 111.0 110.0 109.0 110.0 110.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:133.00 stddev:19.69 (14.8%) stddev-sans-first:20.14 11:42:00 INFO - PROCESS | 32349 | Values: 147.0 115.0 125.0 174.0 120.0 119.0 141.0 117.0 148.0 115.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:42:00 INFO - PROCESS | 32349 | Values: 161.0 160.0 160.0 161.0 161.0 162.0 161.0 162.0 161.0 161.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:13.37 (17.8%) stddev-sans-first:13.95 11:42:00 INFO - PROCESS | 32349 | Values: 74.0 74.0 75.0 110.0 75.0 75.0 74.0 75.0 102.0 75.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:83.50 stddev:19.78 (23.7%) stddev-sans-first:20.53 11:42:00 INFO - PROCESS | 32349 | Values: 84.0 84.0 115.0 83.0 83.0 83.0 124.0 84.0 84.0 132.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 11:42:00 INFO - PROCESS | 32349 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 118.0 116.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 11:42:00 INFO - PROCESS | 32349 | Values: 146.0 147.0 146.0 145.0 147.0 146.0 146.0 145.0 145.0 145.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:42:00 INFO - PROCESS | 32349 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.97 11:42:00 INFO - PROCESS | 32349 | Values: 51.0 50.0 50.0 52.0 52.0 52.0 52.0 52.0 50.0 51.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 11:42:00 INFO - PROCESS | 32349 | Values: 59.0 60.0 60.0 60.0 60.0 59.0 60.0 60.0 61.0 61.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.50 stddev:3.05 (4.0%) stddev-sans-first:3.23 11:42:00 INFO - PROCESS | 32349 | Values: 76.0 75.0 74.0 74.0 74.0 75.0 78.0 77.0 84.0 75.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:128.50 stddev:13.96 (10.9%) stddev-sans-first:14.79 11:42:00 INFO - PROCESS | 32349 | Values: 128.0 124.0 124.0 116.0 130.0 128.0 129.0 133.0 167.0 120.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:155.50 stddev:2.41 (1.6%) stddev-sans-first:2.55 11:42:00 INFO - PROCESS | 32349 | Values: 156.0 159.0 158.0 153.0 155.0 155.0 152.0 154.0 155.0 159.0 11:42:00 INFO - PROCESS | 32349 | 11:42:00 INFO - PROCESS | 32349 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:1.65 (2.6%) stddev-sans-first:1.20 11:42:00 INFO - PROCESS | 32349 | Values: 67.0 62.0 65.0 63.0 63.0 64.0 63.0 62.0 65.0 62.0 11:42:00 INFO - PROCESS | 32349 | -------- Summary: end -------- 11:42:00 INFO - PROCESS | 32349 | 11:42:01 INFO - TEST-INFO | 32349: exit 0 11:42:01 INFO - TEST-OK | kraken | took 60286ms 11:42:01 INFO - SUITE-END | took 1173s 11:42:01 INFO - Completed test suite (00:19:33) 11:42:01 INFO - javascript benchmark 11:42:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3023.032629558541, 3035.5598438226457, 3051.877924883004, 3075.3388021575383, 3089.2894634234126, 5133.948660513393, 5139.331886854713, 5258.106121959267, 5377.247185394043, 5397.5951803614735, 5211.3746350437905, 5279.260903473517, 5310.76101575429, 5355.277037599923, 5372.677639341632, 4804.663673542854, 4853.39332583427, 4892.584130348924, 4897.926531102036, 4925.039617274633, 4845.079434907374, 4848.587870031034, 4879.6828206166665, 4895.0, 4920.3111564381015, 4700.435947686283, 4730.030343779534, 4750.809967601292, 4834.033193361307, 4850.660453768238, 4823.155947709137, 4827.637927155477, 4891.730954797485, 4892.217245240744, 4934.851954441372, 4641.535846415331, 4842.273658951185, 4862.051899879525, 4873.512648735134, 4903.8528844134735, 5237.188235823415, 5326.547243484309, 5327.067763141435, 5385.084535628953, 5400.729963501848, 5730.7707691692285, 5759.452851979056, 5779.913301300484, 5787.1608616750755, 5792.304923409218, 5580.776768929238, 5599.944000559983, 5602.327720673505, 5810.448007439287, 5848.385919478436, 5292.8147514837565, 5321.813736519203, 5345.705986170759, 5351.7324133793545, 5352.678839269656, 5799.768009279666, 5809.215755872988, 5809.680467574324, 5812.099124635688, 5821.592488525847, 5392.245085688007, 5562.0, 5587.217789509472, 5592.468715472024, 5602.85992850182, 5699.4585514376895, 5746.482816546447, 5756.539476841926, 5760.3951585083805, 5760.74076666551, 5693.914591281134, 5696.601237913389, 5697.544196464273, 5703.486686198262, 5734.197212390269, 5508.3114610673665, 5557.221988921554, 5588.30146231721, 5596.272484576979, 5615.606907516435, 4299.892502687458, 4302.7848607569495, 4307.310830267204, 4308.956910430856, 4337.414449049338, 3799.354109801285, 3848.826802793881, 3860.8841734748003, 3881.3207688654375, 3904.843806247775, 5302.469753024744, 5355.062863998863, 5370.543503802142, 5383.973080134652, 5395.271638328853, 5749.741261643236, 5755.050416681201, 5758.683272419973, 5762.510186634099, 5770.451807078321, 5292.603054770908, 5374.8656283592445, 5394.649347792381, 5440.91838622421, 5450.373207081237, 4949.282354058641, 4957.652964292465, 4969.975150124298, 4975.950240497621, 5018.272350509229, 5933.762649493972, 5944.227250457413, 5946.583739138218, 5946.970265148647, 5957.07665311886, 5467.9453205467435, 5676.035074037506, 5736.71316434185, 5756.136579512939, 5820.883582328414, 5942.1383899335215, 5945.405459454193, 5951.970240148771, 5954.642721436728, 5959.433853783884, 5658.151277308437, 5662.0, 5664.433556644302, 5665.0, 5665.801696940587, 5457.045017121908, 5711.143328500758, 5762.308522977102, 5773.0, 5780.5953583248765, 5670.829875103754, 5676.971615141898, 5677.74450149736, 5678.858028549319, 5679.176519404746, 5641.830745077655, 5658.377578466283, 5660.377358490645, 5671.0075736745075, 5671.517920976763, 5401.054815407367, 5438.483344082306, 5457.781688732406, 5479.863003424946, 5516.0, 5563.5271001963665, 5595.580331475075, 5606.074997625509, 5658.745356459051, 5661.037623603915, 5308.044551980526, 5443.510084092451, 5486.670799752028, 5493.176023596492, 5496.7526461310135], "value": 5254.97100757413, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4981015946606, 618.2735286038903, 618.882412341655, 644.1111266452301, 646.1374065622393, 44006.0, 45367.0, 45496.31755523666, 45506.089878202496, 48779.51220487794, 46537.534624653825, 46690.76654616722, 46881.29678054823, 46997.76501117498, 47091.764541177334, 9049.502277374742, 9066.410683305598, 9190.586423610921, 9195.126462986005, 9198.862017069749, 9055.456672599632, 9098.818023639524, 9138.451692898414, 9145.0, 9146.954265228664, 9214.354995150343, 9241.214496767783, 9252.213561847251, 9259.86110208344, 9265.907340926571, 9159.954200228989, 9176.357654964155, 9190.954045229799, 9199.586018629177, 9201.309901757395, 9017.909820901772, 9076.591553380114, 9088.272938164931, 9090.409123406956, 9093.09069093092, 43533.782331088456, 43681.34477982833, 43685.0, 43789.34315985263, 43969.78015109936, 3476.4263896457055, 3491.458823882277, 3775.6601905828607, 3838.193979264358, 3854.2484215577974, 34626.13434664128, 34646.653533464596, 34687.959361219204, 34783.30433391318, 36624.0, 4419.381286619876, 4446.377507149002, 4464.285714285698, 4479.619232365253, 4503.954960450386, 351874.0, 356824.9999999974, 357378.0, 358354.0, 358434.0, 52165.217521737206, 60750.39249607536, 61560.38439615636, 61636.69181654063, 61641.0, 61440.38559614347, 62650.686746565974, 62892.0, 68934.65532672405, 69089.65455172693, 16157.757633635505, 16347.836521634632, 16400.589985250226, 16409.6718065638, 16420.425285114965, 11378.089752819755, 11694.94152529249, 13319.533816316383, 13501.66245843842, 13553.525626603021, 17603.0, 17919.552011199823, 18122.919103752392, 18812.529686757665, 18853.62292754137, 6421.0, 6423.197100362455, 6505.284418713938, 6538.444232240217, 6659.833504162338, 917.6742256498846, 1005.1205195453978, 1035.7928414317166, 1107.9728457459955, 1125.634168895096, 32582.674173258438, 32593.185170370456, 32927.20374827894, 33165.66834331674, 33859.83070084683, 1067.2902519824386, 1090.8800031996475, 1109.2235435195234, 1116.7989761842784, 1146.60442147459, 17242.137893105293, 17347.739783903253, 17546.64906701859, 17816.821831781777, 17844.55388615269, 569440.0, 572520.0, 574975.0, 576094.3585846216, 576105.0, 60692.39307606956, 60788.69605651943, 60790.696046519486, 60878.69560652169, 60935.39064609297, 1246.8940140088014, 1345.5290648273221, 1349.1837438349658, 1382.592135320083, 1391.422559637739, 33547.664523354455, 34407.483887741204, 34718.0, 34934.126646833014, 35039.82480087583, 51797.482025180776, 51881.0, 52171.0, 52349.21476177784, 52478.737606311726, 425565.0, 427201.0, 427488.0, 427521.0, 427690.0, 36516.0, 40810.0, 42244.0, 42424.5757542433, 46516.06967860556, 47746.0, 49066.26400603922, 49069.509304906496, 49330.506694934025, 49692.75153624209, 39073.2185356297, 41975.370369443874, 42519.362209566265, 42936.35595466008, 43055.277788888096, 41304.79347603243, 41822.790886045375, 41967.505448781696, 42382.57617423786, 42709.97188556416, 42034.579654203066, 42756.1448771029, 42855.3571696431, 43409.565904340554, 43453.78273108614, 35117.473237900944, 37359.626403735616, 37888.81055594704, 38474.6152538471, 38568.42147367848, 25532.74467255378, 25738.356541085872, 25830.87084564565, 26103.0, 26211.606825897245], "value": 20769.083460937687, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.3770123549232, 383.8483798899435, 391.962763537464, 408.2549347440917, 413.0891384497184, 19140.330088446906, 20637.4840628984, 21175.258865939697, 21362.786372136292, 21433.57132857344, 19745.21019159232, 20025.399238022845, 20438.795612043876, 20699.482512937146, 20703.896480517575, 5012.398512178525, 5609.49514543691, 5811.418858114176, 5820.476157145856, 5823.330317013555, 4073.551909289976, 6090.66501342426, 6339.841503962415, 6343.587666801666, 6468.547201695883, 6213.596116252452, 6412.422881940624, 6444.806655800334, 6453.354664533556, 6457.6771161441975, 6353.872922541569, 6402.551821372505, 6410.1987251593555, 6441.677916104176, 6448.838779030515, 3754.699624030071, 5343.652662576959, 5618.101103823409, 5631.887362252732, 5696.829095127153, 23843.284701458982, 24340.269791906096, 24388.0, 24537.877310613512, 24817.0, 2385.0698227691214, 2419.2863105383954, 2454.521368333176, 2461.3108329667543, 2522.709888362825, 9343.486108264044, 14417.78373324401, 14769.630759230999, 15345.923270383688, 15347.769783453146, 1901.9144138513661, 1932.4492519631979, 1942.524081600003, 1981.2669312354376, 2005.3683089826804, 83989.58005209996, 91710.0828991715, 91784.0, 92090.53954730183, 92800.0, 10943.671689849318, 10994.560217591366, 11127.332360058423, 11145.275557088764, 11263.549458021751, 15071.0, 15111.31999060045, 15207.695846083237, 15268.31292591836, 15303.234838258042, 8170.550619715973, 8282.668693252323, 8487.915120848837, 8607.354448416394, 8616.310695144373, 8284.917150828414, 8340.582970851434, 8358.247757701836, 8517.48895066298, 8534.189252021048, 4314.094040251583, 4462.107578484316, 4511.526289739596, 4661.27750198713, 4759.809607615726, 1769.282489674373, 1770.6458708258142, 1797.7842658880757, 1900.6673832079607, 1962.6859702447825, 925.121134921827, 931.7391130483476, 947.6541062512272, 1001.7395477175987, 1013.807376598444, 19240.807591924182, 20068.598628027357, 20277.49306267355, 20358.28745993883, 20723.58552828935, 989.1987490132872, 1000.429755039635, 1059.2373491086405, 1068.3536460441476, 1090.0897750378365, 10631.946840265904, 11188.888111118948, 11191.832122518168, 11218.046466050477, 11244.49399777012, 402682.0, 403131.0, 403696.0, 494445.0, 538050.0, 105859.470702646, 107204.0, 108874.45562772136, 109767.0, 111878.44060779807, 994.6178901530938, 1016.8220561401725, 1022.7289768211579, 1026.2046913641839, 1027.6197806811529, 18299.81700182981, 18342.0, 18596.907015464836, 18865.245390184788, 19002.619947600695, 45242.09515809731, 45552.0, 45635.54364456446, 46468.30297545472, 49079.50920490892, 64765.67617161884, 65602.0, 66110.33889661042, 66130.66934665295, 66735.66632166808, 8288.21261980111, 8325.791855203668, 8401.789955250923, 8443.113473085237, 8515.0, 13079.803802942773, 13139.211647301192, 13885.583432497042, 13940.163590184622, 13948.372323245276, 11833.467493962964, 12120.64081128411, 12328.0, 12420.937895310466, 12535.623931282076, 12238.143329967173, 12333.814992774936, 12433.06751993586, 12583.307918064595, 12819.871801281868, 12061.0, 12398.16471576068, 12592.11855170166, 12626.43181056873, 12788.168769029984, 8361.749147525585, 8368.87446688288, 8489.533075680896, 8515.787105322417, 8568.286342731353, 6944.861102778017, 8356.6239519223, 11043.723272450858, 12061.0, 12301.0], "value": 9568.236089227266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.179092544474, 1459.7153555056761, 1498.6777842763804, 1623.7564365345204, 1788.7674602301706, 8619.870701939475, 8940.418872773265, 8945.642174313029, 9189.77025574361, 9198.678046268382, 8926.2412694921, 9090.272778177747, 9093.227075698573, 9097.909020909805, 9100.36297459178, 1982.8017198280202, 2291.415688999311, 2337.2871274261342, 2361.9763802362013, 2386.427257458215, 2319.22306027481, 2322.268485427085, 2333.7316208636053, 2334.159702507096, 2334.754850740673, 2344.765523447659, 2367.396313939943, 2367.988160059197, 2368.917087901924, 2370.3363058343607, 1919.3282351177047, 2244.057495851738, 2278.157081879715, 2338.1699496678602, 2339.9649005264932, 2290.061074959275, 2299.0918587158144, 2314.4329639238495, 2320.7215134184007, 2321.1063740459876, 9252.444853308823, 9296.581653825595, 9302.674406395812, 9312.34813563051, 9320.533973301375, 5312.229726689647, 5400.405955344909, 5451.945480545183, 5458.61789674719, 5460.399356070829, 3452.395830729612, 3547.18414764603, 3591.515145455356, 3602.3335682898746, 3641.799701016443, 1156.6240971684151, 1164.2956011612937, 1185.205912038936, 1193.8089905615147, 1209.105262106044, 12890.226586404846, 12917.67705807353, 12930.676733081655, 12950.093493455463, 12964.740705185937, 4470.955290447054, 4678.345031695565, 4742.217534106834, 4810.542998415145, 4810.783514741775, 10537.89462105369, 10542.631007914686, 10545.31455455393, 10546.314489558154, 10581.89418105809, 5407.648502847303, 5408.269883565668, 5412.539934105645, 5414.91877621836, 5422.132458806572, 4279.379489973999, 4787.305840653155, 4925.605951523869, 4951.3810773653295, 4998.350214472168, 3995.580464051233, 4023.322760218356, 4026.355783074694, 4048.595140485928, 4164.8125834337525, 1087.445402844555, 1137.3914955498933, 1266.5250531050856, 1269.156011252525, 1291.8837304642627, 842.9072801991776, 923.1184219070772, 929.0245242495353, 943.1558754914313, 975.0298453039129, 6237.96881015592, 6328.11406403104, 6330.145430366933, 6429.774957876545, 6507.837304067436, 939.1969865764672, 967.9903200968041, 975.4149507051042, 1022.4274406332478, 1033.6020632056561, 4229.386738922839, 4320.071184695305, 4385.079133381962, 4430.136123455895, 4442.378067070613, 11404.0, 11591.420428978518, 11691.356975366267, 11701.824472632918, 11724.296542207494, 11502.884971150348, 11532.481038353295, 11552.422378881023, 11622.302661840147, 11625.128115391379, 8086.555239461768, 8378.24595786382, 8386.622601982925, 8492.532910689972, 8672.956635216784, 5988.131720900358, 6125.448709616156, 6137.1101190328045, 6239.313675495782, 6258.342873998165, 10476.319039262728, 10576.629817956335, 10846.457677115955, 10860.511276992396, 10862.0, 10868.967448092419, 10882.945585272022, 10914.617988370368, 10938.289011214245, 11124.165687573626, 7804.570748608881, 7826.7651970440975, 7892.684292628231, 7960.880586791319, 7963.482373645695, 8814.206721395105, 8816.911830881865, 8887.15572020657, 8888.377813552988, 8892.15524525169, 7381.926180738339, 7624.618769061413, 7624.656890439833, 7699.345555627834, 7764.572948487661, 7188.065551478275, 7226.313500217471, 7429.962850185931, 7498.550086994798, 7590.924090759022, 7280.490365674352, 7313.707451701873, 7356.705731770883, 7359.448041397024, 7374.446916481178, 5308.920366194433, 5440.619156658996, 5512.614117011771, 5631.549476041989, 5719.942800571941, 5388.54197393226, 5445.074337362737, 5515.09001014828, 5583.972080139736, 5615.522680572197], "value": 4763.649607007406, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.79637726420987, 327.3812494385611, 334.32966901362795, 337.4802803682331, 338.2136532561794, 5275.232797013001, 5283.07546179419, 5308.416074231832, 5315.441878602749, 5348.866278343034, 5188.014277287322, 5194.792208311673, 5230.529252367286, 5245.370555533342, 5252.030488566787, 3968.384900340445, 4002.5196976362877, 4111.807575803014, 4133.834646614132, 4184.7907604619795, 4084.4690190275223, 4106.32245679464, 4117.876463706094, 4117.999999999985, 4142.2958097123565, 3967.3453880109746, 4086.550479447273, 4100.671946244293, 4102.302608556538, 4108.815103320343, 4079.287273962811, 4140.399642051901, 4183.97908010458, 4184.644305234059, 4193.203291374629, 3696.057505336149, 3723.9945214791856, 3724.5902950675404, 3728.9627103728885, 3740.345439548068, 5191.610629202825, 5213.165893457029, 5237.397699264595, 5262.7631756571045, 5283.837555737731, 4473.306637471197, 4666.113438446684, 4678.134545109132, 4701.200795864711, 4705.600023997964, 5470.863228419322, 5487.286652735119, 5511.311086114236, 5558.666480011172, 5560.555155587544, 3869.090763670535, 3957.821898014596, 3969.642732154091, 3976.423418604315, 3980.542237642679, 5670.858228544278, 5704.600677952545, 5712.542996560265, 5721.742521586497, 5737.250138707693, 4051.1897620476025, 4054.3310353791885, 4074.4703188585295, 4078.898027549276, 4093.488313960755, 3919.235749028969, 4113.547509773923, 4152.148809494047, 4154.646855017358, 4157.48031496063, 4667.813287468532, 4696.483386827446, 4720.386349774507, 4727.149113159664, 4735.6503396531825, 5557.305021968257, 5623.5097699109765, 5628.465295796893, 5630.577706672016, 5646.378898321182, 1361.1220762608061, 1423.7650787619928, 1427.2578259305103, 1445.8481859404822, 1446.1106419552111, 867.7700409391516, 910.8178364327028, 921.8292768184502, 955.0592666223764, 988.6440881282732, 5285.973570132125, 5296.894062118736, 5308.628396012319, 5313.290221986737, 5320.813771517978, 5563.527100196528, 5594.636348637326, 5608.85977850557, 5625.240592519957, 5629.521490673339, 5151.175811870083, 5312.468753124656, 5321.893562128813, 5407.270018547524, 5421.972890135524, 3021.8942337018098, 3031.6058912341255, 3043.949837306126, 3046.4211799757977, 3049.2224482756756, 5696.746715722617, 5900.911486327708, 5902.763889444374, 5907.379725128885, 5907.9704601476715, 5797.9420205797405, 5807.734983356494, 5832.270966129234, 5837.941620583825, 5839.328477225088, 5837.532997360201, 5858.418227078665, 5876.7649294028615, 5896.0, 5929.644221346733, 5436.755346009518, 5664.0, 5683.8010669626365, 5735.4551317624755, 5741.770329186786, 5636.773474477476, 5652.434756524314, 5660.320761508646, 5662.292213473316, 5697.7436015380235, 5706.343770466284, 5895.0, 5920.437558431942, 5925.05199168131, 5956.076808094752, 4134.131832315247, 4138.606832350922, 4153.563875792998, 4156.231097247019, 4159.604837540429, 5637.605367624391, 5680.091185410314, 5685.061964775766, 5706.0, 5709.144528028324, 5363.176519983224, 5515.751791169488, 5525.723713814374, 5537.5569954404355, 5559.388467268516, 5468.726563671721, 5473.425290344457, 5485.259489968803, 5548.944510554843, 5564.415736347625, 5288.153895376721, 5317.468253174651, 5442.782288708408, 5455.863603409946, 5484.765927666243, 5579.6652200868075, 5591.692456914746, 5594.86012849682, 5594.888102237851, 5598.32820061579, 5463.508284254436, 5464.885015541262, 5470.835874923759, 5484.709174495271, 5511.779528818803], "value": 4235.490898193395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.8258891749354, 782.1474592693962, 799.7001124578284, 814.4380377539499, 836.071960124262, 15108.320125594348, 15372.69254614907, 15945.68108637828, 15946.122963237018, 16023.99999999997, 15126.773098403506, 15404.845951540481, 15507.457238996609, 15521.301541430634, 15635.609109772233, 665.5241502325836, 790.8774140008308, 792.1484404265409, 817.8527864984301, 821.1255013410728, 815.7838172884191, 825.8224481736426, 829.1915382502042, 830.0993422136988, 831.7421599304205, 868.0364795077459, 872.5026734761188, 873.0745409865531, 873.3144481581959, 874.0298268921492, 700.7687463137153, 824.077033722229, 824.3240542754943, 866.3632230310717, 867.0289276010876, 615.1418770814734, 616.901295792671, 616.9413905678954, 616.9969150154266, 618.1222663817346, 15188.848111518964, 15218.163001034938, 15265.38938442461, 15271.083734975826, 15272.38910443581, 13556.254406007665, 13792.586222413343, 13837.377318020612, 13916.930415347959, 14295.28523573817, 13192.934035329761, 13214.86785132146, 13261.0, 13381.397837097256, 13834.031617786759, 4369.453818272716, 4384.4519435070615, 4535.478419981711, 4545.0, 4562.5665561771575, 76317.61841190814, 76776.61611691961, 77328.61335693342, 78204.0, 78214.0, 10333.741656458498, 10351.275410721177, 10553.736156596147, 10638.787224255471, 10755.300905441121, 19799.10904009323, 19807.60384792325, 19816.108275127655, 19827.206911723657, 19862.404127876187, 8058.637361318754, 8144.470609410369, 8157.306628936488, 8271.296939760188, 8301.875471867927, 4535.433070866142, 4674.5325467452985, 4687.929681054787, 4806.303086052503, 5032.194848824171, 3266.6733326667145, 3589.892303230907, 3608.4767708682093, 3614.1326081740717, 3615.168511242429, 616.8334549671654, 623.3268070483866, 629.3454807000668, 637.6142433827467, 637.8532937424418, 579.8946640738783, 601.6059481039925, 603.2429301226932, 627.4165026525375, 651.4495251512465, 8669.349798764992, 9548.0, 9638.084381983701, 9656.130948214695, 10044.347117437343, 646.7800947677812, 660.4617236951868, 672.8385187554951, 690.7237105157876, 701.4633805139073, 4623.514530974199, 4733.502982186889, 4748.264019077049, 4768.713877167381, 4768.904621907612, 114749.4262528682, 117944.41027794806, 119409.0, 121783.0, 122031.0, 74511.0, 104947.0, 105307.47346263373, 105555.0, 105758.0, 85434.57282713671, 88758.0, 93240.53379733194, 95537.52231238938, 97574.51212743891, 9368.341398331275, 9783.517884170922, 9838.908183145435, 10028.64899728506, 10180.949095254477, 51920.15793807376, 52925.735371322895, 53534.464655352946, 53621.463785361644, 55084.17373739317, 72125.0, 72274.0, 78655.0, 80240.59879700564, 82108.58945705234, 14115.576532704035, 14146.292685365896, 14278.928605356907, 14368.13791172533, 14453.349599267847, 14449.85550144485, 14614.647583687612, 14796.48212312607, 14860.331285091981, 15695.058296502246, 12895.226286422845, 12951.611451656465, 13039.348032598142, 13188.340582971005, 13623.795643065163, 13663.316834158053, 13982.790258146339, 14042.438302467786, 14362.13827170373, 14597.27013649292, 14378.496752613608, 14818.703625927637, 15080.773788393402, 15118.402538694181, 15240.161791101596, 11150.776984460428, 11285.322880627189, 11326.773464530828, 11393.202475826612, 11572.94213528927, 11182.776344473228, 11456.255343402652, 11657.855228147593, 12000.219985700902, 12135.847094526005], "value": 7642.853763767301, "unit": "score"}], "name": "dromaeo_css", "value": 7376.111506590635, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 110.0, 111.0, 111.0, 111.0, 110.0, 109.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 125.0, 174.0, 120.0, 119.0, 141.0, 117.0, 148.0, 115.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 110.0, 75.0, 75.0, 74.0, 75.0, 102.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 115.0, 83.0, 83.0, 83.0, 124.0, 84.0, 84.0, 132.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 52.0, 52.0, 52.0, 52.0, 52.0, 50.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 61.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 74.0, 74.0, 75.0, 78.0, 77.0, 84.0, 75.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 124.0, 116.0, 130.0, 128.0, 129.0, 133.0, 167.0, 120.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 158.0, 153.0, 155.0, 155.0, 152.0, 154.0, 155.0, 159.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 65.0, 63.0, 63.0, 64.0, 63.0, 62.0, 65.0, 62.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1473.0, "alertThreshold": 2.0}]} 11:42:01 INFO - Return code: 0 11:42:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:42:01 INFO - # TBPL SUCCESS # 11:42:01 INFO - Running post-action listener: _resource_record_post_action 11:42:01 INFO - ##### 11:42:01 INFO - ##### Finished run-tests step (success) 11:42:01 INFO - ##### 11:42:01 INFO - Running post-run listener: _resource_record_post_run 11:42:01 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559472640; Read time: 148; Write time: 413736 11:42:01 INFO - TinderboxPrint: CPU usage
13.0% 11:42:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 148 11:42:01 INFO - TinderboxPrint: I/O write bytes / time
559,472,640 / 413,736 11:42:01 INFO - TinderboxPrint: CPU idle
8,271.1 (87.0%) 11:42:01 INFO - TinderboxPrint: CPU user
1,194.8 (12.6%) 11:42:01 INFO - TinderboxPrint: Swap in / out
0 / 0 11:42:01 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 260640768; Read time: 0; Write time: 243328 11:42:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298831872; Read time: 148; Write time: 170408 11:42:02 INFO - Running post-run listener: _upload_blobber_files 11:42:02 INFO - Blob upload gear active. 11:42:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:42:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:42:02 INFO - (blobuploader) - INFO - Open directory for files ... 11:42:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:42:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:42:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:03 INFO - (blobuploader) - INFO - Done attempting. 11:42:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:42:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:42:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:04 INFO - (blobuploader) - INFO - Done attempting. 11:42:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:42:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:42:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:08 INFO - (blobuploader) - INFO - Done attempting. 11:42:08 INFO - (blobuploader) - INFO - Iteration through files over. 11:42:08 INFO - Return code: 0 11:42:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:42:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:42:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27e3e4aa781858bb7b7aeb080d5947264cf6c65ba91bf5c72fd1282bdd57de407e6e27f46fcf3b2f591499f8ff189c31df53ccf39b644182c710d8f89028b65f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f60addf20ea0d603d5667903926f98992aed7757cd4ba53103678f636deae05991892f7bf1793451a3a8a4fcf200de72f3f30fcdc9230e129ea5bd9e3e18ba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f26ebccb9603e6812308adf8c46ec6e482fe304378574195f185b9979f508f76f634a6a06e203e75aea63caa6aede97851e73dfd7c40918af162b6ec17c8072"} 11:42:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:42:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:42:08 INFO - Contents: 11:42:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27e3e4aa781858bb7b7aeb080d5947264cf6c65ba91bf5c72fd1282bdd57de407e6e27f46fcf3b2f591499f8ff189c31df53ccf39b644182c710d8f89028b65f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f60addf20ea0d603d5667903926f98992aed7757cd4ba53103678f636deae05991892f7bf1793451a3a8a4fcf200de72f3f30fcdc9230e129ea5bd9e3e18ba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f26ebccb9603e6812308adf8c46ec6e482fe304378574195f185b9979f508f76f634a6a06e203e75aea63caa6aede97851e73dfd7c40918af162b6ec17c8072"} 11:42:08 INFO - Running post-run listener: copy_logs_to_upload_dir 11:42:08 INFO - Copying logs to upload dir... 11:42:08 INFO - mkdir: /builds/slave/test/build/upload/logs 11:42:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.868554 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-18 11:42:07.736306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:07.739321) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057 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/27e3e4aa781858bb7b7aeb080d5947264cf6c65ba91bf5c72fd1282bdd57de407e6e27f46fcf3b2f591499f8ff189c31df53ccf39b644182c710d8f89028b65f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f60addf20ea0d603d5667903926f98992aed7757cd4ba53103678f636deae05991892f7bf1793451a3a8a4fcf200de72f3f30fcdc9230e129ea5bd9e3e18ba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f26ebccb9603e6812308adf8c46ec6e482fe304378574195f185b9979f508f76f634a6a06e203e75aea63caa6aede97851e73dfd7c40918af162b6ec17c8072"} build_url:https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/DMjAgHj2TSifduwmZB7odA/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/27e3e4aa781858bb7b7aeb080d5947264cf6c65ba91bf5c72fd1282bdd57de407e6e27f46fcf3b2f591499f8ff189c31df53ccf39b644182c710d8f89028b65f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f60addf20ea0d603d5667903926f98992aed7757cd4ba53103678f636deae05991892f7bf1793451a3a8a4fcf200de72f3f30fcdc9230e129ea5bd9e3e18ba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f26ebccb9603e6812308adf8c46ec6e482fe304378574195f185b9979f508f76f634a6a06e203e75aea63caa6aede97851e73dfd7c40918af162b6ec17c8072"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:07.767253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:07.767897) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1468866095.498557-1210181057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004353 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:07.853362) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:42:07.854107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:42:07.854706) ========= ========= Total master_lag: 0.18 =========