builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1468271478.33 results: success (0) buildid: 20160711113035 builduid: c74c4b23587f450d8ccb0354b2caadca revision: 2e5b22652d834a59b920901b806c35c7943e678c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:18.326710) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:18.327118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:18.327412) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:18.781962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:18.782433) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 14:11:18-- 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% 42.3M=0s 2016-07-11 14:11:18 (42.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148764 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:19.005699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:19.006020) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021509 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:19.249027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:19.249345) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e5b22652d834a59b920901b806c35c7943e678c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2e5b22652d834a59b920901b806c35c7943e678c --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=8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 14:11:19,252 truncating revision to first 12 chars 2016-07-11 14:11:19,252 Setting DEBUG logging. 2016-07-11 14:11:19,252 attempt 1/10 2016-07-11 14:11:19,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e5b22652d83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 14:11:19,555 unpacking tar archive at: fx-team-2e5b22652d83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:19.984618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:19.984927) ========= script_repo_revision: 2e5b22652d834a59b920901b806c35c7943e678c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:19.985332) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:19.985602) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 14:11:19.994896) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-11 14:11:19.995205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:11:20 INFO - MultiFileLogger online at 20160711 14:11:20 in /builds/slave/test 14:11:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:11:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:11:20 INFO - {'append_to_log': False, 14:11:20 INFO - 'base_work_dir': '/builds/slave/test', 14:11:20 INFO - 'blob_upload_branch': 'Fx-Team', 14:11:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:11:20 INFO - 'branch': 'Fx-Team', 14:11:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:20 INFO - 'config_files': ('talos/linux_config.py',), 14:11:20 INFO - 'default_actions': ('clobber', 14:11:20 INFO - 'read-buildbot-config', 14:11:20 INFO - 'download-and-extract', 14:11:20 INFO - 'populate-webroot', 14:11:20 INFO - 'create-virtualenv', 14:11:20 INFO - 'install', 14:11:20 INFO - 'run-tests'), 14:11:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:20 INFO - 'download_minidump_stackwalk': True, 14:11:20 INFO - 'download_symbols': 'ondemand', 14:11:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:20 INFO - 'installer_path': 'installer.exe', 14:11:20 INFO - 'log_level': 'info', 14:11:20 INFO - 'log_name': 'talos', 14:11:20 INFO - 'log_to_console': True, 14:11:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:11:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:11:20 INFO - 'opt_config_files': (), 14:11:20 INFO - 'pip_index': False, 14:11:20 INFO - 'sps_profile': False, 14:11:20 INFO - 'sps_profile_interval': 0, 14:11:20 INFO - 'suite': 'dromaeojs', 14:11:20 INFO - 'system_bits': '32', 14:11:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:20 INFO - 'title': 'talos-linux64-ix-001', 14:11:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:20 INFO - 'use_talos_json': True, 14:11:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:11:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:20 INFO - 'work_dir': 'build'} 14:11:20 INFO - ##### 14:11:20 INFO - ##### Running clobber step. 14:11:20 INFO - ##### 14:11:20 INFO - Running pre-action listener: _resource_record_pre_action 14:11:20 INFO - Running main action method: clobber 14:11:20 INFO - rmtree: /builds/slave/test/build 14:11:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:11:20 INFO - Running post-action listener: _resource_record_post_action 14:11:20 INFO - ##### 14:11:20 INFO - ##### Finished clobber step (success) 14:11:20 INFO - ##### 14:11:20 INFO - ##### 14:11:20 INFO - ##### Running read-buildbot-config step. 14:11:20 INFO - ##### 14:11:20 INFO - Running pre-action listener: _resource_record_pre_action 14:11:20 INFO - Running main action method: read_buildbot_config 14:11:20 INFO - Using buildbot properties: 14:11:20 INFO - { 14:11:20 INFO - "project": "", 14:11:20 INFO - "product": "firefox", 14:11:20 INFO - "script_repo_revision": "production", 14:11:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:11:20 INFO - "repository": "", 14:11:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:11:20 INFO - "buildid": "20160711113035", 14:11:20 INFO - "pgo_build": "True", 14:11:20 INFO - "basedir": "/builds/slave/test", 14:11:20 INFO - "buildnumber": 888, 14:11:20 INFO - "slavename": "talos-linux64-ix-001", 14:11:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:11:20 INFO - "platform": "ubuntu64_hw", 14:11:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:11:20 INFO - "branch": "fx-team", 14:11:20 INFO - "repo_path": "integration/fx-team", 14:11:20 INFO - "revision": "2e5b22652d834a59b920901b806c35c7943e678c", 14:11:20 INFO - "stage_platform": "linux64-pgo", 14:11:20 INFO - "builduid": "c74c4b23587f450d8ccb0354b2caadca", 14:11:20 INFO - "slavebuilddir": "test" 14:11:20 INFO - } 14:11:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:11:20 INFO - Running post-action listener: _resource_record_post_action 14:11:20 INFO - ##### 14:11:20 INFO - ##### Finished read-buildbot-config step (success) 14:11:20 INFO - ##### 14:11:20 INFO - ##### 14:11:20 INFO - ##### Running download-and-extract step. 14:11:20 INFO - ##### 14:11:20 INFO - Running pre-action listener: _resource_record_pre_action 14:11:20 INFO - Running main action method: download_and_extract 14:11:20 INFO - mkdir: /builds/slave/test/build/tests 14:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:20 INFO - https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:22 INFO - Downloaded 1361 bytes. 14:11:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:22 INFO - Using the following test package requirements: 14:11:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:11:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:11:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:22 INFO - u'jsshell-linux-x86_64.zip'], 14:11:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:11:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:11:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:11:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:11:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:11:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:11:22 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')]} 14:11:22 INFO - https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:34 INFO - Downloaded 24269708 bytes. 14:11:34 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'] 14:11:34 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 14:11:35 INFO - Return code: 0 14:11:35 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 14:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:35 INFO - https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:36 INFO - Downloaded 24269708 bytes. 14:11:36 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'] 14:11:36 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 14:11:38 INFO - Return code: 0 14:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:38 INFO - https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:11:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:11:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:11:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:39 INFO - Downloaded 14403333 bytes. 14:11:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:11:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:11:40 INFO - Return code: 0 14:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:40 INFO - https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSw-R0rJRPG8GMygcX8iEg/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 14:11:41 INFO - Downloaded 60492413 bytes. 14:11:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:41 INFO - mkdir: /builds/slave/test/properties 14:11:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:41 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:41 INFO - Contents: 14:11:41 INFO - build_url:https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:42 INFO - Running post-action listener: _resource_record_post_action 14:11:42 INFO - Running post-action listener: set_extra_try_arguments 14:11:42 INFO - ##### 14:11:42 INFO - ##### Finished download-and-extract step (success) 14:11:42 INFO - ##### 14:11:42 INFO - ##### 14:11:42 INFO - ##### Running populate-webroot step. 14:11:42 INFO - ##### 14:11:42 INFO - Running pre-action listener: _resource_record_pre_action 14:11:42 INFO - Running main action method: populate_webroot 14:11:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:42 INFO - '--tppagecycles', 14:11:42 INFO - '7'], 14:11:42 INFO - 'tests': ['tsvgm']}}, 14:11:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:42 INFO - 'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:42 INFO - 'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['damp', 'tps']}, 14:11:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:42 INFO - 'tests': ['damp', 'tps']}, 14:11:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['dromaeo_dom']}, 14:11:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['basic_compositor_video']}, 14:11:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:11:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['a11yr', 14:11:42 INFO - 'ts_paint', 14:11:42 INFO - 'tpaint', 14:11:42 INFO - 'sessionrestore', 14:11:42 INFO - 'sessionrestore_no_auto_restore', 14:11:42 INFO - 'tabpaint']}, 14:11:42 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:42 INFO - 'ts_paint', 14:11:42 INFO - 'tpaint', 14:11:42 INFO - 'sessionrestore', 14:11:42 INFO - 'sessionrestore_no_auto_restore', 14:11:42 INFO - 'tabpaint']}, 14:11:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:42 INFO - 'ts_paint', 14:11:42 INFO - 'tpaint', 14:11:42 INFO - 'sessionrestore', 14:11:42 INFO - 'sessionrestore_no_auto_restore', 14:11:42 INFO - 'tabpaint']}, 14:11:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:42 INFO - 'ts_paint', 14:11:42 INFO - 'tpaint', 14:11:42 INFO - 'sessionrestore', 14:11:42 INFO - 'sessionrestore_no_auto_restore', 14:11:42 INFO - 'tabpaint']}, 14:11:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['a11yr', 14:11:42 INFO - 'ts_paint', 14:11:42 INFO - 'tpaint', 14:11:42 INFO - 'sessionrestore', 14:11:42 INFO - 'sessionrestore_no_auto_restore', 14:11:42 INFO - 'tabpaint']}, 14:11:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['a11yr', 14:11:42 INFO - 'ts_paint', 14:11:42 INFO - 'tpaint', 14:11:42 INFO - 'sessionrestore', 14:11:42 INFO - 'sessionrestore_no_auto_restore', 14:11:42 INFO - 'tabpaint']}, 14:11:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['tsvgx', 14:11:42 INFO - 'tsvgr_opacity', 14:11:42 INFO - 'tart', 14:11:42 INFO - 'tscrollx', 14:11:42 INFO - 'cart']}, 14:11:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:42 INFO - 'tsvgr_opacity', 14:11:42 INFO - 'tart', 14:11:42 INFO - 'tscrollx', 14:11:42 INFO - 'cart']}, 14:11:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:42 INFO - 'talos_options': ['--disable-e10s'], 14:11:42 INFO - 'tests': ['tp5o']}, 14:11:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:42 INFO - 'tests': ['tp5o']}, 14:11:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:42 INFO - 'talos_options': ['--disable-e10s', 14:11:42 INFO - '--xperf_path', 14:11:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:42 INFO - 'tests': ['tp5n']}, 14:11:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:42 INFO - 'talos_options': ['--xperf_path', 14:11:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:42 INFO - 'tests': ['tp5n']}}, 14:11:42 INFO - 'talos.zip': {'path': '', 14:11:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:42 INFO - Running post-action listener: _resource_record_post_action 14:11:42 INFO - ##### 14:11:42 INFO - ##### Finished populate-webroot step (success) 14:11:42 INFO - ##### 14:11:42 INFO - ##### 14:11:42 INFO - ##### Running create-virtualenv step. 14:11:42 INFO - ##### 14:11:42 INFO - Running pre-action listener: _resource_record_pre_action 14:11:42 INFO - Running main action method: create_virtualenv 14:11:42 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:42 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 14:11:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:42 INFO - Using real prefix '/usr' 14:11:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:42 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:44 INFO - Installing pip.................done. 14:11:44 INFO - Return code: 0 14:11:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11:45 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')]} 14:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:45 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')]} 14:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:45 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 0xdc5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', '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 14:11:45 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 14:11:45 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 14:11:45 INFO - Using env: {'DISPLAY': ':0', 14:11:45 INFO - 'HOME': '/home/cltbld', 14:11:45 INFO - 'LANG': 'en_US.UTF-8', 14:11:45 INFO - 'LANGUAGE': 'en_US:en', 14:11:45 INFO - 'LOGNAME': 'cltbld', 14:11:45 INFO - 'MAIL': '/var/mail/cltbld', 14:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:45 INFO - 'MOZ_NO_REMOTE': '1', 14:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:45 INFO - 'NO_EM_RESTART': '1', 14:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:45 INFO - 'PWD': '/builds/slave/test', 14:11:45 INFO - 'SHELL': '/bin/bash', 14:11:45 INFO - 'SHLVL': '1', 14:11:45 INFO - 'TERM': 'linux', 14:11:45 INFO - 'TMOUT': '86400', 14:11:45 INFO - 'USER': 'cltbld', 14:11:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:45 INFO - '_': '/tools/buildbot/bin/python'} 14:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:45 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 14:11:45 INFO - Cleaning up... 14:11:45 INFO - Return code: 0 14:11:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:45 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')]} 14:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:45 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')]} 14:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:45 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 0xdc5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', '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 14:11:45 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 14:11:45 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 14:11:45 INFO - Using env: {'DISPLAY': ':0', 14:11:45 INFO - 'HOME': '/home/cltbld', 14:11:45 INFO - 'LANG': 'en_US.UTF-8', 14:11:45 INFO - 'LANGUAGE': 'en_US:en', 14:11:45 INFO - 'LOGNAME': 'cltbld', 14:11:45 INFO - 'MAIL': '/var/mail/cltbld', 14:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:45 INFO - 'MOZ_NO_REMOTE': '1', 14:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:45 INFO - 'NO_EM_RESTART': '1', 14:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:45 INFO - 'PWD': '/builds/slave/test', 14:11:45 INFO - 'SHELL': '/bin/bash', 14:11:45 INFO - 'SHLVL': '1', 14:11:45 INFO - 'TERM': 'linux', 14:11:45 INFO - 'TMOUT': '86400', 14:11:45 INFO - 'USER': 'cltbld', 14:11:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:45 INFO - '_': '/tools/buildbot/bin/python'} 14:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:46 INFO - Downloading/unpacking psutil>=3.1.1 14:11:46 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 14:11:46 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 14:11:46 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 14:11:46 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 14:11:46 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 14:11:46 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 14:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:48 INFO - Installing collected packages: psutil 14:11:48 INFO - Running setup.py install for psutil 14:11:48 INFO - building 'psutil._psutil_linux' extension 14:11:48 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 14:11:49 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 14:11:49 INFO - building 'psutil._psutil_posix' extension 14:11:49 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 14:11:49 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 14:11:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:49 INFO - Successfully installed psutil 14:11:49 INFO - Cleaning up... 14:11:49 INFO - Return code: 0 14:11:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', '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 14:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:11:49 INFO - Using env: {'DISPLAY': ':0', 14:11:49 INFO - 'HOME': '/home/cltbld', 14:11:49 INFO - 'LANG': 'en_US.UTF-8', 14:11:49 INFO - 'LANGUAGE': 'en_US:en', 14:11:49 INFO - 'LOGNAME': 'cltbld', 14:11:49 INFO - 'MAIL': '/var/mail/cltbld', 14:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:49 INFO - 'MOZ_NO_REMOTE': '1', 14:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:49 INFO - 'NO_EM_RESTART': '1', 14:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:49 INFO - 'PWD': '/builds/slave/test', 14:11:49 INFO - 'SHELL': '/bin/bash', 14:11:49 INFO - 'SHLVL': '1', 14:11:49 INFO - 'TERM': 'linux', 14:11:49 INFO - 'TMOUT': '86400', 14:11:49 INFO - 'USER': 'cltbld', 14:11:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:49 INFO - '_': '/tools/buildbot/bin/python'} 14:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:51 INFO - Installing collected packages: mozsystemmonitor 14:11:51 INFO - Running setup.py install for mozsystemmonitor 14:11:51 INFO - Successfully installed mozsystemmonitor 14:11:51 INFO - Cleaning up... 14:11:51 INFO - Return code: 0 14:11:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', '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 0xdc5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', '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 14:11: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11: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 jsonschema==2.5.1 14:11:51 INFO - Using env: {'DISPLAY': ':0', 14:11:51 INFO - 'HOME': '/home/cltbld', 14:11:51 INFO - 'LANG': 'en_US.UTF-8', 14:11:51 INFO - 'LANGUAGE': 'en_US:en', 14:11:51 INFO - 'LOGNAME': 'cltbld', 14:11:51 INFO - 'MAIL': '/var/mail/cltbld', 14:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:51 INFO - 'MOZ_NO_REMOTE': '1', 14:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:51 INFO - 'NO_EM_RESTART': '1', 14:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:51 INFO - 'PWD': '/builds/slave/test', 14:11:51 INFO - 'SHELL': '/bin/bash', 14:11:51 INFO - 'SHLVL': '1', 14:11:51 INFO - 'TERM': 'linux', 14:11:51 INFO - 'TMOUT': '86400', 14:11:51 INFO - 'USER': 'cltbld', 14:11:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:51 INFO - '_': '/tools/buildbot/bin/python'} 14:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:51 INFO - Downloading/unpacking jsonschema==2.5.1 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:54 INFO - warning: no files found matching '*.txt' 14:11:54 INFO - no previously-included directories found matching 'build' 14:11:54 INFO - no previously-included directories found matching 'dist' 14:11:54 INFO - no previously-included directories found matching '.git*' 14:11:54 INFO - Installing collected packages: jsonschema, functools32 14:11:54 INFO - Running setup.py install for functools32 14:11:54 INFO - warning: no files found matching '*.txt' 14:11:54 INFO - no previously-included directories found matching 'build' 14:11:54 INFO - no previously-included directories found matching 'dist' 14:11:54 INFO - no previously-included directories found matching '.git*' 14:11:54 INFO - Successfully installed jsonschema functools32 14:11:54 INFO - Cleaning up... 14:11:54 INFO - Return code: 0 14:11:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', '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 0xdc5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', '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 14:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11: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 blobuploader==1.2.4 14:11:54 INFO - Using env: {'DISPLAY': ':0', 14:11:54 INFO - 'HOME': '/home/cltbld', 14:11:54 INFO - 'LANG': 'en_US.UTF-8', 14:11:54 INFO - 'LANGUAGE': 'en_US:en', 14:11:54 INFO - 'LOGNAME': 'cltbld', 14:11:54 INFO - 'MAIL': '/var/mail/cltbld', 14:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:54 INFO - 'MOZ_NO_REMOTE': '1', 14:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:54 INFO - 'NO_EM_RESTART': '1', 14:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:54 INFO - 'PWD': '/builds/slave/test', 14:11:54 INFO - 'SHELL': '/bin/bash', 14:11:54 INFO - 'SHLVL': '1', 14:11:54 INFO - 'TERM': 'linux', 14:11:54 INFO - 'TMOUT': '86400', 14:11:54 INFO - 'USER': 'cltbld', 14:11:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:54 INFO - '_': '/tools/buildbot/bin/python'} 14:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:57 INFO - Downloading docopt-0.6.1.tar.gz 14:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:57 INFO - Running setup.py install for blobuploader 14:11:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:57 INFO - Running setup.py install for requests 14:11:57 INFO - Running setup.py install for docopt 14:11:57 INFO - Successfully installed blobuploader requests docopt 14:11:57 INFO - Cleaning up... 14:11:57 INFO - Return code: 0 14:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:57 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')]} 14:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:57 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')]} 14:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:57 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 0xdc5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', '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 14:11:57 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 14:11:57 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 14:11:57 INFO - Using env: {'DISPLAY': ':0', 14:11:57 INFO - 'HOME': '/home/cltbld', 14:11:57 INFO - 'LANG': 'en_US.UTF-8', 14:11:57 INFO - 'LANGUAGE': 'en_US:en', 14:11:57 INFO - 'LOGNAME': 'cltbld', 14:11:57 INFO - 'MAIL': '/var/mail/cltbld', 14:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:57 INFO - 'MOZ_NO_REMOTE': '1', 14:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:57 INFO - 'NO_EM_RESTART': '1', 14:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:57 INFO - 'PWD': '/builds/slave/test', 14:11:57 INFO - 'SHELL': '/bin/bash', 14:11:57 INFO - 'SHLVL': '1', 14:11:57 INFO - 'TERM': 'linux', 14:11:57 INFO - 'TMOUT': '86400', 14:11:57 INFO - 'USER': 'cltbld', 14:11:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:57 INFO - '_': '/tools/buildbot/bin/python'} 14:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:58 INFO - Running setup.py (path:/tmp/pip-PJATt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:58 INFO - Running setup.py (path:/tmp/pip-x0aNgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:58 INFO - Running setup.py (path:/tmp/pip-TeMCfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:58 INFO - Running setup.py (path:/tmp/pip-sZOsQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:58 INFO - Running setup.py (path:/tmp/pip-1Oonud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:58 INFO - Running setup.py (path:/tmp/pip-43g9ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:58 INFO - Running setup.py (path:/tmp/pip-UXXOc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:58 INFO - Running setup.py (path:/tmp/pip-StPcne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:58 INFO - Running setup.py (path:/tmp/pip-pi0azg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:58 INFO - Running setup.py (path:/tmp/pip-jSJTEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:58 INFO - Running setup.py (path:/tmp/pip-eaTSCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:58 INFO - Running setup.py (path:/tmp/pip-x_E3Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:58 INFO - Running setup.py (path:/tmp/pip-XWGVWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:59 INFO - Running setup.py (path:/tmp/pip-29WCzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:59 INFO - Running setup.py (path:/tmp/pip-7da0QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:59 INFO - Running setup.py (path:/tmp/pip-VhlPbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:59 INFO - Running setup.py (path:/tmp/pip-lEWD0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:59 INFO - Running setup.py install for manifestparser 14:11:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:59 INFO - Running setup.py install for mozcrash 14:11:59 INFO - Running setup.py install for mozdebug 14:11:59 INFO - Running setup.py install for mozdevice 14:11:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:59 INFO - Running setup.py install for mozfile 14:11:59 INFO - Running setup.py install for mozhttpd 14:11:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:59 INFO - Running setup.py install for mozinfo 14:12:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Running setup.py install for mozInstall 14:12:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Running setup.py install for mozleak 14:12:00 INFO - Running setup.py install for mozlog 14:12:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Running setup.py install for moznetwork 14:12:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Running setup.py install for mozprocess 14:12:00 INFO - Running setup.py install for mozprofile 14:12:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Running setup.py install for mozrunner 14:12:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:12:00 INFO - Running setup.py install for mozscreenshot 14:12:00 INFO - Running setup.py install for moztest 14:12:01 INFO - Running setup.py install for mozversion 14:12:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:12:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:12:01 INFO - Cleaning up... 14:12:01 INFO - Return code: 0 14:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:01 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 0xdc5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', '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 14:12:01 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 14:12:01 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 14:12:01 INFO - Using env: {'DISPLAY': ':0', 14:12:01 INFO - 'HOME': '/home/cltbld', 14:12:01 INFO - 'LANG': 'en_US.UTF-8', 14:12:01 INFO - 'LANGUAGE': 'en_US:en', 14:12:01 INFO - 'LOGNAME': 'cltbld', 14:12:01 INFO - 'MAIL': '/var/mail/cltbld', 14:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:01 INFO - 'MOZ_NO_REMOTE': '1', 14:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:01 INFO - 'NO_EM_RESTART': '1', 14:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:01 INFO - 'PWD': '/builds/slave/test', 14:12:01 INFO - 'SHELL': '/bin/bash', 14:12:01 INFO - 'SHLVL': '1', 14:12:01 INFO - 'TERM': 'linux', 14:12:01 INFO - 'TMOUT': '86400', 14:12:01 INFO - 'USER': 'cltbld', 14:12:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:01 INFO - '_': '/tools/buildbot/bin/python'} 14:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:12:01 INFO - Running setup.py (path:/tmp/pip-_qo_mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:12:01 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)) 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:12:01 INFO - Running setup.py (path:/tmp/pip-arhuNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:12:01 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)) 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:12:01 INFO - Running setup.py (path:/tmp/pip-QZi6sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:12:01 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)) 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:12:01 INFO - Running setup.py (path:/tmp/pip-ePPSXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:12:01 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)) 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:12:01 INFO - Running setup.py (path:/tmp/pip-qcfIHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:12:01 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)) 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:12:01 INFO - Running setup.py (path:/tmp/pip-UvI3zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:12:01 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)) 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:12:01 INFO - Running setup.py (path:/tmp/pip-zuJw7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:12:01 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)) 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:12:01 INFO - Running setup.py (path:/tmp/pip-LCBt6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:12:01 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)) 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:12:01 INFO - Running setup.py (path:/tmp/pip-0PTwPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:12:01 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)) 14:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:12:01 INFO - Running setup.py (path:/tmp/pip-N2dGEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:12:02 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)) 14:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:12:02 INFO - Running setup.py (path:/tmp/pip-se2iVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:12:02 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)) 14:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:12:02 INFO - Running setup.py (path:/tmp/pip-ehEHCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:12:02 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)) 14:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:12:02 INFO - Running setup.py (path:/tmp/pip-zlIxUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:12:02 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)) 14:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:12:02 INFO - Running setup.py (path:/tmp/pip-61_aB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:12:02 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)) 14:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:02 INFO - Running setup.py (path:/tmp/pip-UVkQ2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:02 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)) 14:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:12:02 INFO - Running setup.py (path:/tmp/pip-CU0bKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:12:02 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)) 14:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:12:02 INFO - Running setup.py (path:/tmp/pip-teQeHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:12:02 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)) 14:12:02 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)) 14:12:02 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)) 14:12:02 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)) 14:12:02 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)) 14:12:02 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)) 14:12:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:12:02 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 14:12:02 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 14:12:02 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 14:12:02 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 14:12:02 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 14:12:02 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 14:12:04 INFO - Downloading blessings-1.6.tar.gz 14:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:12:04 INFO - Installing collected packages: blessings 14:12:04 INFO - Running setup.py install for blessings 14:12:04 INFO - Successfully installed blessings 14:12:04 INFO - Cleaning up... 14:12:04 INFO - Return code: 0 14:12:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:04 INFO - Reading from file tmpfile_stdout 14:12:04 INFO - Current package versions: 14:12:04 INFO - argparse == 1.2.1 14:12:04 INFO - blessings == 1.6 14:12:04 INFO - blobuploader == 1.2.4 14:12:04 INFO - docopt == 0.6.1 14:12:04 INFO - functools32 == 3.2.3-2 14:12:04 INFO - jsonschema == 2.5.1 14:12:04 INFO - manifestparser == 1.1 14:12:04 INFO - mozInstall == 1.12 14:12:04 INFO - mozcrash == 0.17 14:12:04 INFO - mozdebug == 0.1 14:12:04 INFO - mozdevice == 0.48 14:12:04 INFO - mozfile == 1.2 14:12:04 INFO - mozhttpd == 0.7 14:12:04 INFO - mozinfo == 0.9 14:12:04 INFO - mozleak == 0.1 14:12:04 INFO - mozlog == 3.2 14:12:04 INFO - moznetwork == 0.27 14:12:04 INFO - mozprocess == 0.23 14:12:04 INFO - mozprofile == 0.28 14:12:04 INFO - mozrunner == 6.12 14:12:04 INFO - mozscreenshot == 0.1 14:12:04 INFO - mozsystemmonitor == 0.3 14:12:04 INFO - moztest == 0.7 14:12:04 INFO - mozversion == 1.4 14:12:04 INFO - psutil == 3.1.1 14:12:04 INFO - requests == 1.2.3 14:12:04 INFO - wsgiref == 0.1.2 14:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:04 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')]} 14:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:04 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')]} 14:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:04 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 0xdc5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', '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 14:12:04 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 14:12:04 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 14:12:04 INFO - Using env: {'DISPLAY': ':0', 14:12:04 INFO - 'HOME': '/home/cltbld', 14:12:04 INFO - 'LANG': 'en_US.UTF-8', 14:12:04 INFO - 'LANGUAGE': 'en_US:en', 14:12:04 INFO - 'LOGNAME': 'cltbld', 14:12:04 INFO - 'MAIL': '/var/mail/cltbld', 14:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:04 INFO - 'MOZ_NO_REMOTE': '1', 14:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:04 INFO - 'NO_EM_RESTART': '1', 14:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:04 INFO - 'PWD': '/builds/slave/test', 14:12:04 INFO - 'SHELL': '/bin/bash', 14:12:04 INFO - 'SHLVL': '1', 14:12:04 INFO - 'TERM': 'linux', 14:12:04 INFO - 'TMOUT': '86400', 14:12:04 INFO - 'USER': 'cltbld', 14:12:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:04 INFO - '_': '/tools/buildbot/bin/python'} 14:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:05 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)) 14:12:05 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)) 14:12:05 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)) 14:12:05 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)) 14:12:05 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)) 14:12:05 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)) 14:12:05 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)) 14:12:05 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)) 14:12:05 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)) 14:12:05 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)) 14:12:05 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)) 14:12:05 INFO - Cleaning up... 14:12:05 INFO - Return code: 0 14:12:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:12: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')]} 14:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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')]} 14:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', '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 14:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:12:05 INFO - Using env: {'DISPLAY': ':0', 14:12:05 INFO - 'HOME': '/home/cltbld', 14:12:05 INFO - 'LANG': 'en_US.UTF-8', 14:12:05 INFO - 'LANGUAGE': 'en_US:en', 14:12:05 INFO - 'LOGNAME': 'cltbld', 14:12:05 INFO - 'MAIL': '/var/mail/cltbld', 14:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:05 INFO - 'MOZ_NO_REMOTE': '1', 14:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:05 INFO - 'NO_EM_RESTART': '1', 14:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:05 INFO - 'PWD': '/builds/slave/test', 14:12:05 INFO - 'SHELL': '/bin/bash', 14:12:05 INFO - 'SHLVL': '1', 14:12:05 INFO - 'TERM': 'linux', 14:12:05 INFO - 'TMOUT': '86400', 14:12:05 INFO - 'USER': 'cltbld', 14:12:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:05 INFO - '_': '/tools/buildbot/bin/python'} 14:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:12:05 INFO - Cleaning up... 14:12:05 INFO - Return code: 0 14:12:05 INFO - Running post-action listener: _resource_record_post_action 14:12:05 INFO - Running post-action listener: _start_resource_monitoring 14:12:05 INFO - Starting resource monitoring. 14:12:05 INFO - ##### 14:12:05 INFO - ##### Finished create-virtualenv step (success) 14:12:05 INFO - ##### 14:12:05 INFO - ##### 14:12:05 INFO - ##### Running install step. 14:12:05 INFO - ##### 14:12:05 INFO - Running pre-action listener: _resource_record_pre_action 14:12:05 INFO - Running main action method: install 14:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:05 INFO - Reading from file tmpfile_stdout 14:12:05 INFO - Detecting whether we're running mozinstall >=1.0... 14:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:12:05 INFO - Reading from file tmpfile_stdout 14:12:05 INFO - Output received: 14:12:05 INFO - Usage: mozinstall [options] installer 14:12:05 INFO - Options: 14:12:05 INFO - -h, --help show this help message and exit 14:12:05 INFO - -d DEST, --destination=DEST 14:12:05 INFO - Directory to install application into. [default: 14:12:05 INFO - "/builds/slave/test"] 14:12:05 INFO - --app=APP Application being installed. [default: firefox] 14:12:05 INFO - mkdir: /builds/slave/test/build/application 14:12:05 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'] 14:12:05 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 14:12:22 INFO - Reading from file tmpfile_stdout 14:12:22 INFO - Output received: 14:12:22 INFO - /builds/slave/test/build/application/firefox/firefox 14:12:22 INFO - Running post-action listener: _resource_record_post_action 14:12:22 INFO - ##### 14:12:22 INFO - ##### Finished install step (success) 14:12:22 INFO - ##### 14:12:22 INFO - ##### 14:12:22 INFO - ##### Running run-tests step. 14:12:22 INFO - ##### 14:12:22 INFO - Running pre-action listener: _resource_record_pre_action 14:12:22 INFO - Running main action method: run_tests 14:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:12:22 INFO - Python 2.7.3 14:12:22 INFO - Return code: 0 14:12:22 INFO - grabbing minidump binary from tooltool 14:12:22 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')]} 14:12:22 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 0x10843b0>, '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 0x10852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:12:22 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 14:12:22 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 14:12:22 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 14:12:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:22 INFO - Return code: 0 14:12:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:12:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:12:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:12:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:12:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 14:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 14:12:22 INFO - Using env: {'DISPLAY': ':0', 14:12:22 INFO - 'HOME': '/home/cltbld', 14:12:22 INFO - 'LANG': 'en_US.UTF-8', 14:12:22 INFO - 'LANGUAGE': 'en_US:en', 14:12:22 INFO - 'LOGNAME': 'cltbld', 14:12:22 INFO - 'MAIL': '/var/mail/cltbld', 14:12:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:22 INFO - 'MOZ_NO_REMOTE': '1', 14:12:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:22 INFO - 'NO_EM_RESTART': '1', 14:12:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:22 INFO - 'PWD': '/builds/slave/test', 14:12:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:22 INFO - 'SHELL': '/bin/bash', 14:12:22 INFO - 'SHLVL': '1', 14:12:22 INFO - 'TERM': 'linux', 14:12:22 INFO - 'TMOUT': '86400', 14:12:22 INFO - 'USER': 'cltbld', 14:12:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351', 14:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:22 INFO - '_': '/tools/buildbot/bin/python'} 14:12:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 14:12:23 INFO - mozversion application_buildid: 20160711113035 14:12:23 INFO - mozversion application_changeset: 2e5b22652d834a59b920901b806c35c7943e678c 14:12:23 INFO - mozversion application_display_name: Nightly 14:12:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:23 INFO - mozversion application_name: Firefox 14:12:23 INFO - mozversion application_remotingname: firefox 14:12:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:12:23 INFO - mozversion application_vendor: Mozilla 14:12:23 INFO - mozversion application_version: 50.0a1 14:12:23 INFO - mozversion platform_buildid: 20160711113035 14:12:23 INFO - mozversion platform_changeset: 2e5b22652d834a59b920901b806c35c7943e678c 14:12:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:12:23 INFO - mozversion platform_version: 50.0a1 14:12:23 INFO - using testdate: 1468271543 14:12:23 INFO - actual date: 1468271543 14:12:23 INFO - starting webserver on 'localhost:33993' 14:12:23 INFO - SUITE-START | Running 2 tests 14:12:23 INFO - TEST-START | dromaeo_css 14:12:23 INFO - operating with platform_type : linux_ 14:12:23 INFO - Initialising browser for dromaeo_css test... 14:12:23 INFO - TEST-INFO | started process 3273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4grrg/profile http://localhost:33993/getInfo.html) 14:12:28 INFO - PROCESS | 3273 | __metrics Screen width/height:1600/1200 14:12:28 INFO - PROCESS | 3273 | colorDepth:24 14:12:28 INFO - PROCESS | 3273 | Browser inner width/height: 1024/697 14:12:28 INFO - PROCESS | 3273 | __metrics 14:12:29 INFO - PROCESS | 3273 | 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" 14:12:29 INFO - PROCESS | 3273 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:30 INFO - TEST-INFO | 3273: exit 0 14:12:30 INFO - Browser initialized. 14:12:30 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:30 INFO - TEST-INFO | started process 3358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4grrg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:42 INFO - PROCESS | 3358 | RSS: Main: 157708288 14:12:42 INFO - PROCESS | 3358 | 14:13:33 INFO - PROCESS | 3358 | 1468271613619 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] 14:15:41 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33993/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33993/tests/dromaeo/cssquery-ext.html) 14:15:42 INFO - PROCESS | 3358 | RSS: Main: 259518464 14:15:42 INFO - PROCESS | 3358 | 14:18:45 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33993/tests/dromaeo/cssquery-ext.html (next: http://localhost:33993/tests/dromaeo/cssquery-jquery.html) 14:18:45 INFO - PROCESS | 3358 | RSS: Main: 248815616 14:18:45 INFO - PROCESS | 3358 | 14:21:47 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33993/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33993/tests/dromaeo/cssquery-mootools.html) 14:21:48 INFO - PROCESS | 3358 | RSS: Main: 251375616 14:21:48 INFO - PROCESS | 3358 | 14:24:50 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33993/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33993/tests/dromaeo/cssquery-prototype.html) 14:24:51 INFO - PROCESS | 3358 | RSS: Main: 249151488 14:24:51 INFO - PROCESS | 3358 | 14:27:53 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33993/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33993/tests/dromaeo/cssquery-yui.html) 14:27:54 INFO - PROCESS | 3358 | RSS: Main: 227631104 14:27:54 INFO - PROCESS | 3358 | 14:30:57 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33993/tests/dromaeo/cssquery-yui.html (next: http://localhost:33993/tests/dromaeo/cssquery-dojo.html) 14:30:57 INFO - PROCESS | 3358 | RSS: Main: 319946752 14:30:57 INFO - PROCESS | 3358 | 14:30:57 INFO - PROCESS | 3358 | __start_tp_report 14:30:57 INFO - PROCESS | 3358 | _x_x_mozilla_page_load 14:30:57 INFO - PROCESS | 3358 | _x_x_mozilla_page_load_details 14:30:57 INFO - PROCESS | 3358 | |i|pagename|runs| 14:30:57 INFO - PROCESS | 3358 | |0;dojo.html;3108.922276943076;3143.8428078596066;3163.066895265898;3169.9366012679748;3183.6657150999145;5331.680099194051;5408.756605952732;5413.079776438005;5481.260029895963;5544.47327503887;5419.3225846769155;5424.674519528831;5453.263809385731;5454.945450545493;5466.863328416782;4894;4920.434150072734;4975.104481193383;4986.75066246688;5095.184770436731;5032.6477146599755;5034.496550344955;5071.543561079502;5086.491350864921;5098.209777484477;4782.856514304559;4840.975795121037;4915.3855768029;4937.407511098655;5019.799208031674;4912.263160525949;4967.925481117786;4987;4995.750212489361;5012.774425150877;4910.705357678551;4933.062718083553;4950.603951683856;4955.1080805455;4989.65072444929;5259.921101183485;5393.325834270716;5468.781248750045;5474.233607294982;5515.669059856381;5927.407259274038;5947.881042379128;5956.838416508783;5973.8805223895715;5974.761009559613;5682.232898558683;5952.672603006833;5996.730147143389;6010.909836352458;6013.4888534474185;5404.486573775485;5454.890902181974;5461.290032295776;5538.47384498472;5540.2243685884005;5984.1323008164445;5989.640621562633;5998.520118390518;5999.160117583542;6003.249593800775;5649.689267090267;5651.943480565142;5656.236408084938;5702.714864256771;5714.542836573064;5784.971075144597;5846.093855452326;5878.470937615635;5879.911801322984;5892.6759028253;5763.7982670606325;5813.244278243886;5818.505427038749;5823.388544202882;5856.531477481876;5623.662580245198;5776.422357764274;5829.387914269026;5830.154627579062;5835.533157347402;4481.977590112094;4499.235130027903;4503.977480112644;4541.364209010741;4542.568455996675;3995.300822356076;4010.63904248619;4011.29802284599;4017.5580686124504;4046.008727861693;5412.323459567554;5476.698781567052;5489.313835770528;5553.389127196006;5629.4652008059165;5855.092460668603;5870.941290587125;5878.382769809108;5880.647161170344;5922.822315330547;5565.387807341189;5580.051391263495;5582.91625625616;5583.4137415571595;5587.916181257285;4951.851444456672;5055.241713742968;5100.668456550312;5104.05574968632;5132.461091585405;6134.6625935573975;6136.171616831671;6137.171481849982;6141.570090093651;6145.692715364214;5621.775128994795;5889.204957330706;5905.498032667099;5909.527237820878;5912.379200184091;6098.664573448503;6101.095933926211;6105.15650299495;6164.630122192682;6174.289956654862;5787.659633813393;5840.503557197516;5844.590878638624;5844.590878638624;5900.734466948912;5636.577256705681;5791.247137872049;5997.610155339889;6002.489788368038;6007.579469437097;5727.341355743976;5777.22007528995;5787.276590426197;5788.450097240755;5842.977478941083;5698.430156984434;5729.914051289317;5744.798932037359;5747.597668163188;5751.8562035949435;5484.040292948798;5630.0428927081675;5690.174924635988;5728.656280623176;5739.368669446274;5774.162746401664;5774.855628609318;5800.187973683604;5823.4467725566;5832.037713777349;5615.6630602164005;5652.547796176378;5655.88688226225;5661.631993920382;5669.574781891292 14:30:57 INFO - PROCESS | 3358 | |1;ext.html;591.1576004194022;607.8996965500692;617.305531277313;620.1906512001841;631.0408179567055;33320;35377.64622353779;35379;44054.779726101326;45172.3224151638;46206.53793462065;46369.536304636946;46577.53422465774;46578;46599.534004659945;8943;9079.228265597432;9086.681966131187;9103.408278461879;9106.86339704905;8959.910400896006;9020.909790902073;9048.592813323383;9049.773755656128;9054.637814487412;9055.547222638874;9091.727248182566;9101.590428430703;9104.772380690503;9106.499142547158;9039.638414463414;9068.365214434927;9073.818523629556;9078.77303067422;9086.545672716404;8975.461472311683;9020.233280171193;9057.139571740674;9058.456492610465;9063.229625481841;44018;44297;44419.77790111061;44436.11127777426;44594;3530.593981692087;3592.479090531858;3628.5827129880136;3771.7235331632774;4118.217538667644;33364.6663533364;33409.6659033409;33626.83186584051;34013.6598634013;34966;4481.610700682799;4505.684602077856;4536.795844186987;4562.954370456286;4594.770261486946;345670;347311;347671;349501;350676;57641;60073;60864.69567652133;60923.390766092656;61058;57948.420515795144;58198.709006455545;58242.417575823696;62289.68855155695;63830;16566.58583535397;17039.40362087321;17085.145742713063;17094;17113.14434278306;13013.869861301266;13053.934730326477;13127.606171814861;13135.934320328528;13185.736285274432;16753.162341882857;18880.24479020851;18915.810841891405;19004.23983040663;19134.138963746664;6426.164598602152;6664.666766661648;6721.327867213239;6741.59550426976;6791.320867913268;928.3130483442204;983.3559018842669;1053.942033188182;1076.3272954403499;1169.082270417718;33175.17062073419;34016.48975265373;34211.65788342134;34322.82838585791;34363.4845477318;1108.5731993182521;1164.1501703756305;1174.8590169179754;1239.69007748063;1272.783626783449;17355.91322043407;17753.201105950004;17941;17942.37201697934;17998.280068797103;516914;518192;520819;521559;522673;59549;59758.10362844474;59818.40181598216;59849;59894;1312.9277889716157;1330.1752913193882;1393.895457840666;1397.874191322786;1404.1154072934191;33053.504197436574;33737.493937590465;34091.65908340885;34160;34194.82902585471;53760.73119634377;54086;54164;54254.728726357695;54256;338553;342934;344476;344561;345018;36500.26999460049;42413.575864240964;43667.126657467306;44339.55660443354;44439;46730.53269467262;47874.76062619804;48496.757516212194;48861.75569122132;49023.754881225366;39185.608143918194;40583;41457.79271103625;41990;42354.576454235066;40640.39039414352;41072.79463602782;41100;41177.588224117375;41870.1625967485;40503.79748101241;41160.176796464504;41195;41759.7912010438;42057.15885682208;35740.28519429545;35909.1022724434;36033;36943.81528092342;37038.44442333313;27734.861325693244;28366.31955727282;28368.29079272952;28416.43167136687;28467.715322846507 14:30:57 INFO - PROCESS | 3358 | |2;jquery.html;358.3925246706833;376.3376457434915;382.90810205550656;391.1707180776753;417.4573055028464;17517.29930802768;19673.409797706056;19689.901550492265;19715.704264436026;20805;19648.803511964878;19678.311259105933;20279.89860050698;20317.695234571493;20479.897600511977;5694.5159661428825;5703.99999999999;5859.560532960024;5867;5876.08920617305;5529.115341545354;5691.032524470829;5705.372409035002;5759.740811663464;5763.279590051244;5638.323401191842;5697.886042279152;5746.856328591777;5777.797777077803;5778.624389414675;5691.060974939151;5761.308642962829;5766.942330576682;5789;5796;4958.355413796219;5160.48395160481;5188.143956247215;5191.714455704935;5192.870178245574;23770.524589508284;24085.39786505334;24303.63544546833;24643.876780616163;24655.876720616463;2186.9562608747897;2393.748656391071;2408.1812183857573;2458.1519375815315;2531.1520640585427;10073.597056117747;10187.592496300213;10456.268061235716;10726.624568140078;10881.020708136306;1937.3122541497846;1972.36884197057;1972.6843705007273;1996.2015193922548;2057.9588408231753;86493.13506864976;87359.56320218422;87900.12099879047;88895.88014981273;89086.10913890907;11081.833772493419;11219.439028048564;11430.1998860079;11447.370394628375;11557.422128893522;15368;15511.767323490156;15597.610059748597;15616.531504054896;15622.29699663518;8220.547869867214;8461.492310461268;8493.532855692873;8574.399792014623;8608.65565377378;8228.794280143044;8253.8349233015;8282.627281772335;8305.018522090484;8381.49711017341;4465.977670111629;4596.49438561758;4637.25803871379;4759.452662943737;4889.877753056131;1955.1690531524046;2006.3078238007863;2010.7888671689554;2020.8787472751683;2076.3355726167483;907.3603109807569;959.1894848852709;978.921686265097;1006.5017816180891;1094.141099237095;19832.10755516005;19905.805651660947;19919.203231870564;19992.90003549973;20050.699239511418;1018.7351288665001;1027.9434631095212;1047.6961681112543;1054.7943151085617;1064.6646306413454;10710.946445267724;11067.391293478937;11137.632454134076;11253;11273.436328183558;497914;503362;507231;514854.6630803171;516547;94083.52958235165;94692.52653736825;95642.52178739062;95784.52107739417;95901;945.8061097475002;952.4095061062047;974.8099120671401;974.985375219358;975.4976187263424;17557.648847022734;17734.73397899007;18045.548861278574;18069.457916262534;18278.268869245083;30647.846760766053;37099.629003710696;37502;40776.59223407728;41792.79103604584;60212.69893650504;60259.69870150621;61279.08081378694;62099.068513971426;62328.376716234074;8437.198466145706;8510.82978340442;8539.8719019216;8651.95674021626;9016.819663606822;9080.318976076689;13221;13643.86356136426;13744.381502832197;14635.341409636805;11832.70418239551;12194.57318993831;12836.486540538648;13117.73764524685;13289.069765116736;12188.268703877795;12449;12697.301648409426;12847.871521284667;12882.613521594367;12551;12595.811062833882;12913.09608327408;12919.22484650924;13022.02334824873;8947.59735811877;8995.685151019683;9007;9094.454332740057;9215.216706580015;9387.483688396931;12607.936960315139;12613.30626815534;12705.936470317589;12925.28910909909 14:30:57 INFO - PROCESS | 3358 | |3;mootools.html;1314.802779583063;1445.89155813314;1508.2835653064794;1617.2075682915374;1799.451167393945;8310;8733.694320698776;8734.170253825885;8919.687810926618;8933;8685.348598855095;8800.91199088009;8819.559022048905;8830.60262288197;8898;1956.1392987085637;2224.688543603897;2282.075759317471;2291.346966114662;2340.730815956161;2329.860208387502;2337.4039619896903;2338.8012018978407;2340;2341.4848733278736;2266.0822366941416;2272.693186419837;2284.5430913817304;2291.5531471363092;2310.9884450577806;1904.552430178907;1961.5978724361614;2167.089822274648;2204.9228277010307;2216.6342553478657;2232.6427771556473;2247.820174386045;2248.550289942018;2249.5950728868797;2250.088714070788;8543.743687689317;8589.184027517376;8594.484330940164;8594.527300998443;8598.2261596456;5113.693178409308;5233.738313084331;5244.239585260116;5254.106801843657;5259.474052594748;3426.9143271418166;3477.547918770569;3635.581908080578;3642.1258897864586;3663.8351274192723;1170.3563040327786;1221.8350522679414;1225.7916154253799;1231.901447884167;2176.858504197222;11916.702082447922;12196.207246528948;12309.507619695201;12332.321722305269;12339;4456.309272062836;4475.4181956345465;4492.887677808081;4533.639908027644;4538.931916021263;9576.994415586263;9659.372140810825;9675.951620241854;9676.12914837654;9689.321747477608;5183.585313175013;5195.2986346843445;5199.194124910645;5200.6619569727845;5205.27126202332;4387.648988080946;4751.429828420612;4811.230203167476;4848.781804818792;4909.0672772173175;3697.334479793663;3747.6439738224826;3787.8295476703065;3823.063349479395;3866.149447121629;1008.9192864570816;1078.6925726168004;1114.6154576671036;1121.4112590889847;1123.646051493777;924.4176169013479;924.542351535994;930.4882314726873;955.0878910640322;963.982997937169;5945.464908158287;6075.544334174954;6150;6174.289956654952;6208.410201030895;925.9074092590687;956.8469044952774;976.3409698453515;984.8571957066185;1012.8987101289812;4099.651529620016;4220.78896055196;4253.2769429197115;4254.574542545721;4278.4010238566625;10692.518836652369;11137;11187.32876027441;11200.551977920955;11203.271787333797;10998.010179083922;11018.228723989243;11021.44892755359;11050.557977680803;11068.667939961813;7748.57382843949;8145.144759800254;8170.060443049126;8318.459300145592;8326.12575679557;5863.706814659336;6116.969415152896;6119.173911522065;6191.907121393093;6305.464035557029;10253.948730256301;10306.948465257627;10540.736481588021;10550.314229575053;10555;10399.636012739518;10464.47677616101;10615.363078215332;10764.784704305714;10860;7926.365890728613;8032.437729359122;8149.755507334789;8155.79610509742;8193.057798353266;8665.826683466421;8705.390622656354;8737.519436430803;8737.56312184401;8739.56302184901;7761.883571746315;7945.960270198843;7952.840943180989;7991.920080799117;7998.720044798404;7472.887906681295;7477.476576639583;7491.625418729151;7571.659275332513;7640.541567505968;7129.857402852018;7172.13934327884;7186.820329491805;7195;7202.53183543068;5079.263506791568;5097.9490205098955;5123.282740416419;5247.58019358458;5250.133727934848;5165.9483405166975;5196.064708352382;5228;5344.331958505187;5450.91823622638 14:30:57 INFO - PROCESS | 3358 | |4;prototype.html;318.95375170600266;325.62065194048904;326.74350634751727;328.764933072853;334.74726581431014;5300.734963251836;5301.469853014697;5303.7348132593315;5308.787648494061;5309.73451327434;5202.817901373443;5264.710440925747;5265.210218467222;5266.552343050846;5278.181881808317;3833.750806197588;3928.155446578985;4019.437278780973;4025.29557327468;4037.919241615166;4125.66994640428;4147.668186545069;4154.81587747492;4158.08522125132;4161.2093702196635;4101.015756218516;4116.917661646765;4146.751194928299;4152.480939882515;4169.72896761711;3944.15200731844;4015.377616469452;4097.815598298054;4160.729552579072;4162.875113746577;3595.7842529448317;3610.963890361089;3612.6206748291575;3618.203995121069;3627.7460577759566;5117.53942145205;5119.360079990001;5128.153864608737;5160.045391602565;5178.508041736029;4467.307567327037;4686.835960741392;4689.812407503696;4701.130290896195;4709.246520556729;5433.293671822637;5437.211604317352;5478.260434841285;5481.917771233395;5488.313960754906;3940.527136743609;3947.230290093433;3974.8012599370204;3981.9601803981877;3993.940090898639;5523.420040895729;5730.971345143289;5731.914021289643;5752.884942301131;5752.9712351437975;3959.366501359769;3986.8405263789123;3990.8204130814183;3995.6603688686787;4005.3991901214467;4069.04377471294;4079.5920407958965;4083.224187404384;4086.141910198832;4095.91808163841;4577.954220457753;4682.765861706901;4688.132695451352;4698.919248572779;4703.882402939886;5485.052806253802;5516.80691175815;5522.067276453289;5567.944320556823;5602.187682786055;1390.5272207449516;1401.4044031286662;1404.4452441285634;1410.6050305914155;1411.703542256117;867.3278209387774;881.8809460722848;908.6456282050005;915.6337465014047;921.4703592037187;4786.617070634341;4791.377120974321;4808.855734327975;4823.324734537167;4826.95173048265;5027.134533315975;5051.797928082909;5065.744774389531;5128.743562821844;5164.586833053347;4561.885952851139;4771.379720636295;4808.206645903387;4833.299171620095;4878.146324393288;2665.7200993895362;2668.4262883480146;2672.6391937088633;2672.665916760405;2683.9597406038924;5193.675612718733;5203.866414769926;5204.42751297357;5205.2042045494245;5212.9739351303;4888.02239552091;5112.693238405707;5135.486451354835;5139.434662187156;5521.668699878021;5662.989638678292;5870.412958704095;5934.109883517507;5954.702264886825;5960.195373624505;5707;5722.909628800568;5728.336323609542;5731.19763233156;5756.3380211276235;5320.627556071193;5606.327240731139;5635.915461268166;5643.3792282848035;5661.264035675335;5793.652380857162;5827.921834460638;5848.912266315923;5857.765689372377;5876.823695289148;3873.341531939521;3897.376419772823;3898.719249239227;3901.6098390160755;3910.941335880021;5497.45025497447;5603.8792241552665;5604.8318550443555;5645.8545752613745;5665.405132461032;5515.917261241165;5523.6685798852195;5546.389897111395;5551.195076713773;5556.194351818883;5277.572316734345;5490.945090549043;5521.917171242354;5531.778728850962;5532.5020748132865;5491.945080549143;5500.559955203494;5509.393966663583;5517.69652669091;5520.558355331644;5511.338639363302;5530.529904958124;5540.445955404427;5555.749991250323;5574.052411090043;5261.842144735664;5423.430539793265;5431.37539182999;5444.747708027255;5445.210444485607 14:30:57 INFO - PROCESS | 3358 | |5;yui.html;716.3874886971638;734.2363941500839;749.194615788028;756.678411675038;757.1973707869658;16063.116528590923;16562.254698538578;16592.585185370343;16606.25271862766;16618.33526658932;15927.44253951112;16743.24655390507;16763.497095087136;17283.395081172162;17465.91267043666;667.4927055437878;815.3843847894846;816.6284340625031;833.9666413343489;834.045018453873;791.48553440264;820.4789958376444;824.826786374862;825.7027470110785;826.3554427546524;853.799357151069;855.285836326668;855.5807654249435;856.0882659967147;856.8029353248756;701.9894701579481;841.7348535211389;849.8130411309502;849.902261239956;852.4288726553193;628.7516431009772;628.7862126876838;628.9842753931189;629.1255155334089;632.1876388840318;16614;16619;16663.6667266654;16673.83326166735;16678.082705451194;14497.855021449755;15066.09603423798;15150.54548363551;15225.543233703007;15245.23773811305;11655.825162622483;12253.019758419305;14012.649683757885;14120.85879141216;14268.357923893449;3918.784466854322;3965.381120495761;4013.177298653769;4014.237294913957;4147.7926103695;69295.65352173206;70474;71111;82782.58608706978;83988.16011839865;11807.822882656767;12005.92959356324;12046.397680115959;12113.636590902288;12400.19398739097;20463.79536204619;20535.794642053686;20539.794602054088;20565.280215192397;20575.485612859797;9076.909230907606;9095.863562046574;9134.771630709285;9248.953755231181;9466.242700583936;4885.5358740919555;4963.255511673206;4989.675671081441;5031.471695471922;5255.684658920477;3569.250457403922;3707.462417949382;3708.5735140458655;3708.8331025103935;3721.7580857244734;678.1624693503519;696.0916004614028;703.8838591632426;704.7357241034612;706.1208795050093;727.6507276507306;742.2132539508139;771.4060173666246;773.7137259214127;773.7369294439804;9716.465594392235;9928.50357482123;10166.593336266467;10211.081002709792;10683.198760092868;624.5596854217765;672.428435829541;701.8876979683226;738.9371903388164;745.3440971944763;4818.640451454685;5021.271915572222;5407.675539467645;5499.33282358056;5646.2377579027125;113421.35918447025;114929.42535287437;116456;118048;130726;87064;97270.05459890762;97999.51000244953;98943;99708;72999.6350018257;85182.57408712916;85356.57321713351;87371;88562.55718721365;9924.255680824112;10194.235432342752;10244.846327305246;10573.101286390744;10627.628033019117;38848.805755971036;47078;48281.75859120682;51233;52657.736711316196;72443.63778181287;73855.26144738699;75387;76116.23883761092;80001;13709.794353084511;13741.862581374458;13742.793858091936;14073.718525629634;14076.718465630425;15508.224588770741;15550.144742039296;15957.521274361789;15997.258464243543;16026.198690065217;14399.42402303896;14819.851801481847;15216.239188040776;15369.538913832603;15891;13373.465061397435;14777.704445911237;14888.255587220812;15150.25854962413;15178.848211518185;13632.863671363159;13678.31608419555;13730.244836534086;14197.574072777834;14300.928495357457;11724.88275117238;12112.818307725214;12215.144939854124;12281.508739650313;12350.691232719253;11600.825987610362;12173.147879648339;12216.511339546674;12984.35078246065;13009.479620815062 14:30:57 INFO - PROCESS | 3358 | __end_tp_report 14:30:57 INFO - PROCESS | 3358 | __start_cc_report 14:30:57 INFO - PROCESS | 3358 | _x_x_mozilla_cycle_collect,887 14:30:57 INFO - PROCESS | 3358 | __end_cc_report 14:30:57 INFO - PROCESS | 3358 | __startTimestamp1468272657444__endTimestamp 14:30:57 INFO - PROCESS | 3358 | 14:30:57 INFO - PROCESS | 3358 | ------- Summary: start ------- 14:30:57 INFO - PROCESS | 3358 | Number of tests: 6 14:30:57 INFO - PROCESS | 3358 | 14:30:57 INFO - PROCESS | 3358 | [#0] dojo.html Cycles:165 Average:5449.98 Median:5651.94 stddev:627.41 (11.1%) stddev-sans-first:601.86 14:30:57 INFO - PROCESS | 3358 | Values: 3108.9 3143.8 3163.1 3169.9 3183.7 5331.7 5408.8 5413.1 5481.3 5544.5 5419.3 5424.7 5453.3 5454.9 5466.9 4894.0 4920.4 4975.1 4986.8 5095.2 5032.6 5034.5 5071.5 5086.5 5098.2 4782.9 4841.0 4915.4 4937.4 5019.8 4912.3 4967.9 4987.0 4995.8 5012.8 4910.7 4933.1 4950.6 4955.1 4989.7 5259.9 5393.3 5468.8 5474.2 5515.7 5927.4 5947.9 5956.8 5973.9 5974.8 5682.2 5952.7 5996.7 6010.9 6013.5 5404.5 5454.9 5461.3 5538.5 5540.2 5984.1 5989.6 5998.5 5999.2 6003.2 5649.7 5651.9 5656.2 5702.7 5714.5 5785.0 5846.1 5878.5 5879.9 5892.7 5763.8 5813.2 5818.5 5823.4 5856.5 5623.7 5776.4 5829.4 5830.2 5835.5 4482.0 4499.2 4504.0 4541.4 4542.6 3995.3 4010.6 4011.3 4017.6 4046.0 5412.3 5476.7 5489.3 5553.4 5629.5 5855.1 5870.9 5878.4 5880.6 5922.8 5565.4 5580.1 5582.9 5583.4 5587.9 4951.9 5055.2 5100.7 5104.1 5132.5 6134.7 6136.2 6137.2 6141.6 6145.7 5621.8 5889.2 5905.5 5909.5 5912.4 6098.7 6101.1 6105.2 6164.6 6174.3 5787.7 5840.5 5844.6 5844.6 5900.7 5636.6 5791.2 5997.6 6002.5 6007.6 5727.3 5777.2 5787.3 5788.5 5843.0 5698.4 5729.9 5744.8 5747.6 5751.9 5484.0 5630.0 5690.2 5728.7 5739.4 5774.2 5774.9 5800.2 5823.4 5832.0 5615.7 5652.5 5655.9 5661.6 5669.6 14:30:57 INFO - PROCESS | 3358 | 14:30:57 INFO - PROCESS | 3358 | [#1] ext.html Cycles:180 Average:57949.13 Median:42205.87 stddev:108863.81 (257.9%) stddev-sans-first:109084.02 14:30:57 INFO - PROCESS | 3358 | Values: 591.2 607.9 617.3 620.2 631.0 33320.0 35377.6 35379.0 44054.8 45172.3 46206.5 46369.5 46577.5 46578.0 46599.5 8943.0 9079.2 9086.7 9103.4 9106.9 8959.9 9020.9 9048.6 9049.8 9054.6 9055.5 9091.7 9101.6 9104.8 9106.5 9039.6 9068.4 9073.8 9078.8 9086.5 8975.5 9020.2 9057.1 9058.5 9063.2 44018.0 44297.0 44419.8 44436.1 44594.0 3530.6 3592.5 3628.6 3771.7 4118.2 33364.7 33409.7 33626.8 34013.7 34966.0 4481.6 4505.7 4536.8 4563.0 4594.8 345670.0 347311.0 347671.0 349501.0 350676.0 57641.0 60073.0 60864.7 60923.4 61058.0 57948.4 58198.7 58242.4 62289.7 63830.0 16566.6 17039.4 17085.1 17094.0 17113.1 13013.9 13053.9 13127.6 13135.9 13185.7 16753.2 18880.2 18915.8 19004.2 19134.1 6426.2 6664.7 6721.3 6741.6 6791.3 928.3 983.4 1053.9 1076.3 1169.1 33175.2 34016.5 34211.7 34322.8 34363.5 1108.6 1164.2 1174.9 1239.7 1272.8 17355.9 17753.2 17941.0 17942.4 17998.3 516914.0 518192.0 520819.0 521559.0 522673.0 59549.0 59758.1 59818.4 59849.0 59894.0 1312.9 1330.2 1393.9 1397.9 1404.1 33053.5 33737.5 34091.7 34160.0 34194.8 53760.7 54086.0 54164.0 54254.7 54256.0 338553.0 342934.0 344476.0 344561.0 345018.0 36500.3 42413.6 43667.1 44339.6 44439.0 46730.5 47874.8 48496.8 48861.8 49023.8 39185.6 40583.0 41457.8 41990.0 42354.6 40640.4 41072.8 41100.0 41177.6 41870.2 40503.8 41160.2 41195.0 41759.8 42057.2 35740.3 35909.1 36033.0 36943.8 37038.4 27734.9 28366.3 28368.3 28416.4 28467.7 14:30:57 INFO - PROCESS | 3358 | 14:30:57 INFO - PROCESS | 3358 | [#2] jquery.html Cycles:180 Average:30003.19 Median:15503.12 stddev:83842.41 (540.8%) stddev-sans-first:84048.06 14:30:57 INFO - PROCESS | 3358 | Values: 358.4 376.3 382.9 391.2 417.5 17517.3 19673.4 19689.9 19715.7 20805.0 19648.8 19678.3 20279.9 20317.7 20479.9 5694.5 5704.0 5859.6 5867.0 5876.1 5529.1 5691.0 5705.4 5759.7 5763.3 5638.3 5697.9 5746.9 5777.8 5778.6 5691.1 5761.3 5766.9 5789.0 5796.0 4958.4 5160.5 5188.1 5191.7 5192.9 23770.5 24085.4 24303.6 24643.9 24655.9 2187.0 2393.7 2408.2 2458.2 2531.2 10073.6 10187.6 10456.3 10726.6 10881.0 1937.3 1972.4 1972.7 1996.2 2058.0 86493.1 87359.6 87900.1 88895.9 89086.1 11081.8 11219.4 11430.2 11447.4 11557.4 15368.0 15511.8 15597.6 15616.5 15622.3 8220.5 8461.5 8493.5 8574.4 8608.7 8228.8 8253.8 8282.6 8305.0 8381.5 4466.0 4596.5 4637.3 4759.5 4889.9 1955.2 2006.3 2010.8 2020.9 2076.3 907.4 959.2 978.9 1006.5 1094.1 19832.1 19905.8 19919.2 19992.9 20050.7 1018.7 1027.9 1047.7 1054.8 1064.7 10710.9 11067.4 11137.6 11253.0 11273.4 497914.0 503362.0 507231.0 514854.7 516547.0 94083.5 94692.5 95642.5 95784.5 95901.0 945.8 952.4 974.8 975.0 975.5 17557.6 17734.7 18045.5 18069.5 18278.3 30647.8 37099.6 37502.0 40776.6 41792.8 60212.7 60259.7 61279.1 62099.1 62328.4 8437.2 8510.8 8539.9 8652.0 9016.8 9080.3 13221.0 13643.9 13744.4 14635.3 11832.7 12194.6 12836.5 13117.7 13289.1 12188.3 12449.0 12697.3 12847.9 12882.6 12551.0 12595.8 12913.1 12919.2 13022.0 8947.6 8995.7 9007.0 9094.5 9215.2 9387.5 12607.9 12613.3 12705.9 12925.3 14:30:57 INFO - PROCESS | 3358 | 14:30:57 INFO - PROCESS | 3358 | [#3] mootools.html Cycles:180 Average:5827.22 Median:4994.17 stddev:3329.18 (66.7%) stddev-sans-first:3321.25 14:30:57 INFO - PROCESS | 3358 | Values: 1314.8 1445.9 1508.3 1617.2 1799.5 8310.0 8733.7 8734.2 8919.7 8933.0 8685.3 8800.9 8819.6 8830.6 8898.0 1956.1 2224.7 2282.1 2291.3 2340.7 2329.9 2337.4 2338.8 2340.0 2341.5 2266.1 2272.7 2284.5 2291.6 2311.0 1904.6 1961.6 2167.1 2204.9 2216.6 2232.6 2247.8 2248.6 2249.6 2250.1 8543.7 8589.2 8594.5 8594.5 8598.2 5113.7 5233.7 5244.2 5254.1 5259.5 3426.9 3477.5 3635.6 3642.1 3663.8 1170.4 1221.8 1225.8 1231.9 2176.9 11916.7 12196.2 12309.5 12332.3 12339.0 4456.3 4475.4 4492.9 4533.6 4538.9 9577.0 9659.4 9676.0 9676.1 9689.3 5183.6 5195.3 5199.2 5200.7 5205.3 4387.6 4751.4 4811.2 4848.8 4909.1 3697.3 3747.6 3787.8 3823.1 3866.1 1008.9 1078.7 1114.6 1121.4 1123.6 924.4 924.5 930.5 955.1 964.0 5945.5 6075.5 6150.0 6174.3 6208.4 925.9 956.8 976.3 984.9 1012.9 4099.7 4220.8 4253.3 4254.6 4278.4 10692.5 11137.0 11187.3 11200.6 11203.3 10998.0 11018.2 11021.4 11050.6 11068.7 7748.6 8145.1 8170.1 8318.5 8326.1 5863.7 6117.0 6119.2 6191.9 6305.5 10253.9 10306.9 10540.7 10550.3 10555.0 10399.6 10464.5 10615.4 10764.8 10860.0 7926.4 8032.4 8149.8 8155.8 8193.1 8665.8 8705.4 8737.5 8737.6 8739.6 7761.9 7946.0 7952.8 7991.9 7998.7 7472.9 7477.5 7491.6 7571.7 7640.5 7129.9 7172.1 7186.8 7195.0 7202.5 5079.3 5097.9 5123.3 5247.6 5250.1 5165.9 5196.1 5228.0 5344.3 5450.9 14:30:57 INFO - PROCESS | 3358 | 14:30:57 INFO - PROCESS | 3358 | [#4] prototype.html Cycles:180 Average:4556.09 Median:5149.74 stddev:1347.49 (26.2%) stddev-sans-first:1313.21 14:30:57 INFO - PROCESS | 3358 | Values: 319.0 325.6 326.7 328.8 334.7 5300.7 5301.5 5303.7 5308.8 5309.7 5202.8 5264.7 5265.2 5266.6 5278.2 3833.8 3928.2 4019.4 4025.3 4037.9 4125.7 4147.7 4154.8 4158.1 4161.2 4101.0 4116.9 4146.8 4152.5 4169.7 3944.2 4015.4 4097.8 4160.7 4162.9 3595.8 3611.0 3612.6 3618.2 3627.7 5117.5 5119.4 5128.2 5160.0 5178.5 4467.3 4686.8 4689.8 4701.1 4709.2 5433.3 5437.2 5478.3 5481.9 5488.3 3940.5 3947.2 3974.8 3982.0 3993.9 5523.4 5731.0 5731.9 5752.9 5753.0 3959.4 3986.8 3990.8 3995.7 4005.4 4069.0 4079.6 4083.2 4086.1 4095.9 4578.0 4682.8 4688.1 4698.9 4703.9 5485.1 5516.8 5522.1 5567.9 5602.2 1390.5 1401.4 1404.4 1410.6 1411.7 867.3 881.9 908.6 915.6 921.5 4786.6 4791.4 4808.9 4823.3 4827.0 5027.1 5051.8 5065.7 5128.7 5164.6 4561.9 4771.4 4808.2 4833.3 4878.1 2665.7 2668.4 2672.6 2672.7 2684.0 5193.7 5203.9 5204.4 5205.2 5213.0 4888.0 5112.7 5135.5 5139.4 5521.7 5663.0 5870.4 5934.1 5954.7 5960.2 5707.0 5722.9 5728.3 5731.2 5756.3 5320.6 5606.3 5635.9 5643.4 5661.3 5793.7 5827.9 5848.9 5857.8 5876.8 3873.3 3897.4 3898.7 3901.6 3910.9 5497.5 5603.9 5604.8 5645.9 5665.4 5515.9 5523.7 5546.4 5551.2 5556.2 5277.6 5490.9 5521.9 5531.8 5532.5 5491.9 5500.6 5509.4 5517.7 5520.6 5511.3 5530.5 5540.4 5555.7 5574.1 5261.8 5423.4 5431.4 5444.7 5445.2 14:30:57 INFO - PROCESS | 3358 | 14:30:57 INFO - PROCESS | 3358 | [#5] yui.html Cycles:180 Average:21133.41 Median:4013.71 stddev:29766.36 (741.6%) stddev-sans-first:29810.39 14:30:57 INFO - PROCESS | 3358 | Values: 716.4 734.2 749.2 756.7 757.2 16063.1 16562.3 16592.6 16606.3 16618.3 15927.4 16743.2 16763.5 17283.4 17465.9 667.5 815.4 816.6 834.0 834.0 791.5 820.5 824.8 825.7 826.4 853.8 855.3 855.6 856.1 856.8 702.0 841.7 849.8 849.9 852.4 628.8 628.8 629.0 629.1 632.2 16614.0 16619.0 16663.7 16673.8 16678.1 14497.9 15066.1 15150.5 15225.5 15245.2 11655.8 12253.0 14012.6 14120.9 14268.4 3918.8 3965.4 4013.2 4014.2 4147.8 69295.7 70474.0 71111.0 82782.6 83988.2 11807.8 12005.9 12046.4 12113.6 12400.2 20463.8 20535.8 20539.8 20565.3 20575.5 9076.9 9095.9 9134.8 9249.0 9466.2 4885.5 4963.3 4989.7 5031.5 5255.7 3569.3 3707.5 3708.6 3708.8 3721.8 678.2 696.1 703.9 704.7 706.1 727.7 742.2 771.4 773.7 773.7 9716.5 9928.5 10166.6 10211.1 10683.2 624.6 672.4 701.9 738.9 745.3 4818.6 5021.3 5407.7 5499.3 5646.2 113421.4 114929.4 116456.0 118048.0 130726.0 87064.0 97270.1 97999.5 98943.0 99708.0 72999.6 85182.6 85356.6 87371.0 88562.6 9924.3 10194.2 10244.8 10573.1 10627.6 38848.8 47078.0 48281.8 51233.0 52657.7 72443.6 73855.3 75387.0 76116.2 80001.0 13709.8 13741.9 13742.8 14073.7 14076.7 15508.2 15550.1 15957.5 15997.3 16026.2 14399.4 14819.9 15216.2 15369.5 15891.0 13373.5 14777.7 14888.3 15150.3 15178.8 13632.9 13678.3 13730.2 14197.6 14300.9 11724.9 12112.8 12215.1 12281.5 12350.7 11600.8 12173.1 12216.5 12984.4 13009.5 14:30:57 INFO - PROCESS | 3358 | -------- Summary: end -------- 14:30:57 INFO - PROCESS | 3358 | 14:30:58 INFO - TEST-INFO | 3358: exit 0 14:30:58 INFO - TEST-OK | dromaeo_css | took 1115064ms 14:30:58 INFO - TEST-START | kraken 14:30:58 INFO - operating with platform_type : linux_ 14:30:58 INFO - Initialising browser for kraken test... 14:30:58 INFO - TEST-INFO | started process 3553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIxtPTe/profile http://localhost:33993/getInfo.html) 14:31:02 INFO - PROCESS | 3553 | __metrics Screen width/height:1600/1200 14:31:02 INFO - PROCESS | 3553 | colorDepth:24 14:31:02 INFO - PROCESS | 3553 | Browser inner width/height: 1024/697 14:31:02 INFO - PROCESS | 3553 | __metrics 14:31:03 INFO - PROCESS | 3553 | 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" 14:31:03 INFO - PROCESS | 3553 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:04 INFO - TEST-INFO | 3553: exit 0 14:31:04 INFO - Browser initialized. 14:31:04 INFO - Running cycle 1/1 for kraken test... 14:31:04 INFO - TEST-INFO | started process 3633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIxtPTe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:15 INFO - PROCESS | 3633 | RSS: Main: 157605888 14:31:15 INFO - PROCESS | 3633 | 14:31:18 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33993/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:19 INFO - PROCESS | 3633 | RSS: Main: 215556096 14:31:19 INFO - PROCESS | 3633 | 14:31:21 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33993/tests/kraken/driver.html?testName=audio-dft) 14:31:22 INFO - PROCESS | 3633 | RSS: Main: 203714560 14:31:22 INFO - PROCESS | 3633 | 14:31:25 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33993/tests/kraken/driver.html?testName=audio-fft) 14:31:26 INFO - PROCESS | 3633 | RSS: Main: 269934592 14:31:26 INFO - PROCESS | 3633 | 14:31:28 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33993/tests/kraken/driver.html?testName=audio-oscillator) 14:31:28 INFO - PROCESS | 3633 | RSS: Main: 180801536 14:31:28 INFO - PROCESS | 3633 | 14:31:30 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33993/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:31 INFO - PROCESS | 3633 | RSS: Main: 184459264 14:31:31 INFO - PROCESS | 3633 | 14:31:34 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33993/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:35 INFO - PROCESS | 3633 | RSS: Main: 219549696 14:31:35 INFO - PROCESS | 3633 | 14:31:38 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33993/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:39 INFO - PROCESS | 3633 | RSS: Main: 221274112 14:31:39 INFO - PROCESS | 3633 | 14:31:41 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33993/tests/kraken/driver.html?testName=json-parse-financial) 14:31:42 INFO - PROCESS | 3633 | RSS: Main: 221265920 14:31:42 INFO - PROCESS | 3633 | 14:31:43 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33993/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:44 INFO - PROCESS | 3633 | RSS: Main: 208699392 14:31:44 INFO - PROCESS | 3633 | 14:31:46 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33993/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:46 INFO - PROCESS | 3633 | RSS: Main: 212758528 14:31:46 INFO - PROCESS | 3633 | 14:31:48 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33993/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:49 INFO - PROCESS | 3633 | RSS: Main: 209956864 14:31:49 INFO - PROCESS | 3633 | 14:31:52 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:52 INFO - PROCESS | 3633 | RSS: Main: 225951744 14:31:52 INFO - PROCESS | 3633 | 14:31:55 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:55 INFO - PROCESS | 3633 | RSS: Main: 225845248 14:31:55 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | Cycle 1(1): loaded http://localhost:33993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33993/tests/kraken/driver.html?testName=ai-astar) 14:31:57 INFO - PROCESS | 3633 | RSS: Main: 267980800 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | __start_tp_report 14:31:57 INFO - PROCESS | 3633 | _x_x_mozilla_page_load 14:31:57 INFO - PROCESS | 3633 | _x_x_mozilla_page_load_details 14:31:57 INFO - PROCESS | 3633 | |i|pagename|runs| 14:31:57 INFO - PROCESS | 3633 | |0;ai-astar;102;111;111;111;111;114;113;111;110;110 14:31:57 INFO - PROCESS | 3633 | |1;audio-beat-detection;149;117;117;176;116;118;148;118;151;116 14:31:57 INFO - PROCESS | 3633 | |2;audio-dft;161;162;161;162;159;160;160;159;161;161 14:31:57 INFO - PROCESS | 3633 | |3;audio-fft;76;75;76;125;74;75;74;75;108;75 14:31:57 INFO - PROCESS | 3633 | |4;audio-oscillator;83;84;107;84;84;84;120;84;84;133 14:31:57 INFO - PROCESS | 3633 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;116;117;117 14:31:57 INFO - PROCESS | 3633 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;145;146 14:31:57 INFO - PROCESS | 3633 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 14:31:57 INFO - PROCESS | 3633 | |8;json-parse-financial;53;53;52;52;52;53;54;55;53;53 14:31:57 INFO - PROCESS | 3633 | |9;json-stringify-tinderbox;62;62;61;61;62;62;61;61;60;61 14:31:57 INFO - PROCESS | 3633 | |10;stanford-crypto-aes;76;79;74;75;80;76;75;75;84;84 14:31:57 INFO - PROCESS | 3633 | |11;stanford-crypto-ccm;118;117;117;121;117;125;120;129;173;123 14:31:57 INFO - PROCESS | 3633 | |12;stanford-crypto-pbkdf2;160;157;163;162;159;155;156;160;154;156 14:31:57 INFO - PROCESS | 3633 | |13;stanford-crypto-sha256-iterative;63;63;62;62;63;62;63;61;61;60 14:31:57 INFO - PROCESS | 3633 | __end_tp_report 14:31:57 INFO - PROCESS | 3633 | __start_cc_report 14:31:57 INFO - PROCESS | 3633 | _x_x_mozilla_cycle_collect,1655 14:31:57 INFO - PROCESS | 3633 | __end_cc_report 14:31:57 INFO - PROCESS | 3633 | __startTimestamp1468272717870__endTimestamp 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | ------- Summary: start ------- 14:31:57 INFO - PROCESS | 3633 | Number of tests: 14 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:1.32 14:31:57 INFO - PROCESS | 3633 | Values: 102.0 111.0 111.0 111.0 111.0 114.0 113.0 111.0 110.0 110.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:133.00 stddev:21.58 (16.2%) stddev-sans-first:22.06 14:31:57 INFO - PROCESS | 3633 | Values: 149.0 117.0 117.0 176.0 116.0 118.0 148.0 118.0 151.0 116.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 14:31:57 INFO - PROCESS | 3633 | Values: 161.0 162.0 161.0 162.0 159.0 160.0 160.0 159.0 161.0 161.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:17.96 (24.0%) stddev-sans-first:18.86 14:31:57 INFO - PROCESS | 3633 | Values: 76.0 75.0 76.0 125.0 74.0 75.0 74.0 75.0 108.0 75.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:84.00 stddev:18.51 (22.0%) stddev-sans-first:19.14 14:31:57 INFO - PROCESS | 3633 | Values: 83.0 84.0 107.0 84.0 84.0 84.0 120.0 84.0 84.0 133.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:31:57 INFO - PROCESS | 3633 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:31:57 INFO - PROCESS | 3633 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:31:57 INFO - PROCESS | 3633 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 14:31:57 INFO - PROCESS | 3633 | Values: 53.0 53.0 52.0 52.0 52.0 53.0 54.0 55.0 53.0 53.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 14:31:57 INFO - PROCESS | 3633 | Values: 62.0 62.0 61.0 61.0 62.0 62.0 61.0 61.0 60.0 61.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:77.50 stddev:3.77 (4.9%) stddev-sans-first:3.94 14:31:57 INFO - PROCESS | 3633 | Values: 76.0 79.0 74.0 75.0 80.0 76.0 75.0 75.0 84.0 84.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:122.00 stddev:16.98 (13.9%) stddev-sans-first:17.77 14:31:57 INFO - PROCESS | 3633 | Values: 118.0 117.0 117.0 121.0 117.0 125.0 120.0 129.0 173.0 123.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:159.50 stddev:3.05 (1.9%) stddev-sans-first:3.16 14:31:57 INFO - PROCESS | 3633 | Values: 160.0 157.0 163.0 162.0 159.0 155.0 156.0 160.0 154.0 156.0 14:31:57 INFO - PROCESS | 3633 | 14:31:57 INFO - PROCESS | 3633 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.50 stddev:1.05 (1.7%) stddev-sans-first:1.05 14:31:57 INFO - PROCESS | 3633 | Values: 63.0 63.0 62.0 62.0 63.0 62.0 63.0 61.0 61.0 60.0 14:31:57 INFO - PROCESS | 3633 | -------- Summary: end -------- 14:31:57 INFO - PROCESS | 3633 | 14:31:58 INFO - TEST-INFO | 3633: exit 0 14:31:58 INFO - TEST-OK | kraken | took 60608ms 14:31:58 INFO - SUITE-END | took 1175s 14:31:59 INFO - Completed test suite (00:19:35) 14:31:59 INFO - javascript benchmark 14:31:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.922276943076, 3143.8428078596066, 3163.066895265898, 3169.9366012679748, 3183.6657150999145, 5331.680099194051, 5408.756605952732, 5413.079776438005, 5481.260029895963, 5544.47327503887, 5419.3225846769155, 5424.674519528831, 5453.263809385731, 5454.945450545493, 5466.863328416782, 4894.0, 4920.434150072734, 4975.104481193383, 4986.75066246688, 5095.184770436731, 5032.6477146599755, 5034.496550344955, 5071.543561079502, 5086.491350864921, 5098.209777484477, 4782.856514304559, 4840.975795121037, 4915.3855768029, 4937.407511098655, 5019.799208031674, 4912.263160525949, 4967.925481117786, 4987.0, 4995.750212489361, 5012.774425150877, 4910.705357678551, 4933.062718083553, 4950.603951683856, 4955.1080805455, 4989.65072444929, 5259.921101183485, 5393.325834270716, 5468.781248750045, 5474.233607294982, 5515.669059856381, 5927.407259274038, 5947.881042379128, 5956.838416508783, 5973.8805223895715, 5974.761009559613, 5682.232898558683, 5952.672603006833, 5996.730147143389, 6010.909836352458, 6013.4888534474185, 5404.486573775485, 5454.890902181974, 5461.290032295776, 5538.47384498472, 5540.2243685884005, 5984.1323008164445, 5989.640621562633, 5998.520118390518, 5999.160117583542, 6003.249593800775, 5649.689267090267, 5651.943480565142, 5656.236408084938, 5702.714864256771, 5714.542836573064, 5784.971075144597, 5846.093855452326, 5878.470937615635, 5879.911801322984, 5892.6759028253, 5763.7982670606325, 5813.244278243886, 5818.505427038749, 5823.388544202882, 5856.531477481876, 5623.662580245198, 5776.422357764274, 5829.387914269026, 5830.154627579062, 5835.533157347402, 4481.977590112094, 4499.235130027903, 4503.977480112644, 4541.364209010741, 4542.568455996675, 3995.300822356076, 4010.63904248619, 4011.29802284599, 4017.5580686124504, 4046.008727861693, 5412.323459567554, 5476.698781567052, 5489.313835770528, 5553.389127196006, 5629.4652008059165, 5855.092460668603, 5870.941290587125, 5878.382769809108, 5880.647161170344, 5922.822315330547, 5565.387807341189, 5580.051391263495, 5582.91625625616, 5583.4137415571595, 5587.916181257285, 4951.851444456672, 5055.241713742968, 5100.668456550312, 5104.05574968632, 5132.461091585405, 6134.6625935573975, 6136.171616831671, 6137.171481849982, 6141.570090093651, 6145.692715364214, 5621.775128994795, 5889.204957330706, 5905.498032667099, 5909.527237820878, 5912.379200184091, 6098.664573448503, 6101.095933926211, 6105.15650299495, 6164.630122192682, 6174.289956654862, 5787.659633813393, 5840.503557197516, 5844.590878638624, 5844.590878638624, 5900.734466948912, 5636.577256705681, 5791.247137872049, 5997.610155339889, 6002.489788368038, 6007.579469437097, 5727.341355743976, 5777.22007528995, 5787.276590426197, 5788.450097240755, 5842.977478941083, 5698.430156984434, 5729.914051289317, 5744.798932037359, 5747.597668163188, 5751.8562035949435, 5484.040292948798, 5630.0428927081675, 5690.174924635988, 5728.656280623176, 5739.368669446274, 5774.162746401664, 5774.855628609318, 5800.187973683604, 5823.4467725566, 5832.037713777349, 5615.6630602164005, 5652.547796176378, 5655.88688226225, 5661.631993920382, 5669.574781891292], "value": 5407.202532240135, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1576004194022, 607.8996965500692, 617.305531277313, 620.1906512001841, 631.0408179567055, 33320.0, 35377.64622353779, 35379.0, 44054.779726101326, 45172.3224151638, 46206.53793462065, 46369.536304636946, 46577.53422465774, 46578.0, 46599.534004659945, 8943.0, 9079.228265597432, 9086.681966131187, 9103.408278461879, 9106.86339704905, 8959.910400896006, 9020.909790902073, 9048.592813323383, 9049.773755656128, 9054.637814487412, 9055.547222638874, 9091.727248182566, 9101.590428430703, 9104.772380690503, 9106.499142547158, 9039.638414463414, 9068.365214434927, 9073.818523629556, 9078.77303067422, 9086.545672716404, 8975.461472311683, 9020.233280171193, 9057.139571740674, 9058.456492610465, 9063.229625481841, 44018.0, 44297.0, 44419.77790111061, 44436.11127777426, 44594.0, 3530.593981692087, 3592.479090531858, 3628.5827129880136, 3771.7235331632774, 4118.217538667644, 33364.6663533364, 33409.6659033409, 33626.83186584051, 34013.6598634013, 34966.0, 4481.610700682799, 4505.684602077856, 4536.795844186987, 4562.954370456286, 4594.770261486946, 345670.0, 347311.0, 347671.0, 349501.0, 350676.0, 57641.0, 60073.0, 60864.69567652133, 60923.390766092656, 61058.0, 57948.420515795144, 58198.709006455545, 58242.417575823696, 62289.68855155695, 63830.0, 16566.58583535397, 17039.40362087321, 17085.145742713063, 17094.0, 17113.14434278306, 13013.869861301266, 13053.934730326477, 13127.606171814861, 13135.934320328528, 13185.736285274432, 16753.162341882857, 18880.24479020851, 18915.810841891405, 19004.23983040663, 19134.138963746664, 6426.164598602152, 6664.666766661648, 6721.327867213239, 6741.59550426976, 6791.320867913268, 928.3130483442204, 983.3559018842669, 1053.942033188182, 1076.3272954403499, 1169.082270417718, 33175.17062073419, 34016.48975265373, 34211.65788342134, 34322.82838585791, 34363.4845477318, 1108.5731993182521, 1164.1501703756305, 1174.8590169179754, 1239.69007748063, 1272.783626783449, 17355.91322043407, 17753.201105950004, 17941.0, 17942.37201697934, 17998.280068797103, 516914.0, 518192.0, 520819.0, 521559.0, 522673.0, 59549.0, 59758.10362844474, 59818.40181598216, 59849.0, 59894.0, 1312.9277889716157, 1330.1752913193882, 1393.895457840666, 1397.874191322786, 1404.1154072934191, 33053.504197436574, 33737.493937590465, 34091.65908340885, 34160.0, 34194.82902585471, 53760.73119634377, 54086.0, 54164.0, 54254.728726357695, 54256.0, 338553.0, 342934.0, 344476.0, 344561.0, 345018.0, 36500.26999460049, 42413.575864240964, 43667.126657467306, 44339.55660443354, 44439.0, 46730.53269467262, 47874.76062619804, 48496.757516212194, 48861.75569122132, 49023.754881225366, 39185.608143918194, 40583.0, 41457.79271103625, 41990.0, 42354.576454235066, 40640.39039414352, 41072.79463602782, 41100.0, 41177.588224117375, 41870.1625967485, 40503.79748101241, 41160.176796464504, 41195.0, 41759.7912010438, 42057.15885682208, 35740.28519429545, 35909.1022724434, 36033.0, 36943.81528092342, 37038.44442333313, 27734.861325693244, 28366.31955727282, 28368.29079272952, 28416.43167136687, 28467.715322846507], "value": 20524.59800528735, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.3925246706833, 376.3376457434915, 382.90810205550656, 391.1707180776753, 417.4573055028464, 17517.29930802768, 19673.409797706056, 19689.901550492265, 19715.704264436026, 20805.0, 19648.803511964878, 19678.311259105933, 20279.89860050698, 20317.695234571493, 20479.897600511977, 5694.5159661428825, 5703.99999999999, 5859.560532960024, 5867.0, 5876.08920617305, 5529.115341545354, 5691.032524470829, 5705.372409035002, 5759.740811663464, 5763.279590051244, 5638.323401191842, 5697.886042279152, 5746.856328591777, 5777.797777077803, 5778.624389414675, 5691.060974939151, 5761.308642962829, 5766.942330576682, 5789.0, 5796.0, 4958.355413796219, 5160.48395160481, 5188.143956247215, 5191.714455704935, 5192.870178245574, 23770.524589508284, 24085.39786505334, 24303.63544546833, 24643.876780616163, 24655.876720616463, 2186.9562608747897, 2393.748656391071, 2408.1812183857573, 2458.1519375815315, 2531.1520640585427, 10073.597056117747, 10187.592496300213, 10456.268061235716, 10726.624568140078, 10881.020708136306, 1937.3122541497846, 1972.36884197057, 1972.6843705007273, 1996.2015193922548, 2057.9588408231753, 86493.13506864976, 87359.56320218422, 87900.12099879047, 88895.88014981273, 89086.10913890907, 11081.833772493419, 11219.439028048564, 11430.1998860079, 11447.370394628375, 11557.422128893522, 15368.0, 15511.767323490156, 15597.610059748597, 15616.531504054896, 15622.29699663518, 8220.547869867214, 8461.492310461268, 8493.532855692873, 8574.399792014623, 8608.65565377378, 8228.794280143044, 8253.8349233015, 8282.627281772335, 8305.018522090484, 8381.49711017341, 4465.977670111629, 4596.49438561758, 4637.25803871379, 4759.452662943737, 4889.877753056131, 1955.1690531524046, 2006.3078238007863, 2010.7888671689554, 2020.8787472751683, 2076.3355726167483, 907.3603109807569, 959.1894848852709, 978.921686265097, 1006.5017816180891, 1094.141099237095, 19832.10755516005, 19905.805651660947, 19919.203231870564, 19992.90003549973, 20050.699239511418, 1018.7351288665001, 1027.9434631095212, 1047.6961681112543, 1054.7943151085617, 1064.6646306413454, 10710.946445267724, 11067.391293478937, 11137.632454134076, 11253.0, 11273.436328183558, 497914.0, 503362.0, 507231.0, 514854.6630803171, 516547.0, 94083.52958235165, 94692.52653736825, 95642.52178739062, 95784.52107739417, 95901.0, 945.8061097475002, 952.4095061062047, 974.8099120671401, 974.985375219358, 975.4976187263424, 17557.648847022734, 17734.73397899007, 18045.548861278574, 18069.457916262534, 18278.268869245083, 30647.846760766053, 37099.629003710696, 37502.0, 40776.59223407728, 41792.79103604584, 60212.69893650504, 60259.69870150621, 61279.08081378694, 62099.068513971426, 62328.376716234074, 8437.198466145706, 8510.82978340442, 8539.8719019216, 8651.95674021626, 9016.819663606822, 9080.318976076689, 13221.0, 13643.86356136426, 13744.381502832197, 14635.341409636805, 11832.70418239551, 12194.57318993831, 12836.486540538648, 13117.73764524685, 13289.069765116736, 12188.268703877795, 12449.0, 12697.301648409426, 12847.871521284667, 12882.613521594367, 12551.0, 12595.811062833882, 12913.09608327408, 12919.22484650924, 13022.02334824873, 8947.59735811877, 8995.685151019683, 9007.0, 9094.454332740057, 9215.216706580015, 9387.483688396931, 12607.936960315139, 12613.30626815534, 12705.936470317589, 12925.28910909909], "value": 9415.224751675918, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.802779583063, 1445.89155813314, 1508.2835653064794, 1617.2075682915374, 1799.451167393945, 8310.0, 8733.694320698776, 8734.170253825885, 8919.687810926618, 8933.0, 8685.348598855095, 8800.91199088009, 8819.559022048905, 8830.60262288197, 8898.0, 1956.1392987085637, 2224.688543603897, 2282.075759317471, 2291.346966114662, 2340.730815956161, 2329.860208387502, 2337.4039619896903, 2338.8012018978407, 2340.0, 2341.4848733278736, 2266.0822366941416, 2272.693186419837, 2284.5430913817304, 2291.5531471363092, 2310.9884450577806, 1904.552430178907, 1961.5978724361614, 2167.089822274648, 2204.9228277010307, 2216.6342553478657, 2232.6427771556473, 2247.820174386045, 2248.550289942018, 2249.5950728868797, 2250.088714070788, 8543.743687689317, 8589.184027517376, 8594.484330940164, 8594.527300998443, 8598.2261596456, 5113.693178409308, 5233.738313084331, 5244.239585260116, 5254.106801843657, 5259.474052594748, 3426.9143271418166, 3477.547918770569, 3635.581908080578, 3642.1258897864586, 3663.8351274192723, 1170.3563040327786, 1221.8350522679414, 1225.7916154253799, 1231.901447884167, 2176.858504197222, 11916.702082447922, 12196.207246528948, 12309.507619695201, 12332.321722305269, 12339.0, 4456.309272062836, 4475.4181956345465, 4492.887677808081, 4533.639908027644, 4538.931916021263, 9576.994415586263, 9659.372140810825, 9675.951620241854, 9676.12914837654, 9689.321747477608, 5183.585313175013, 5195.2986346843445, 5199.194124910645, 5200.6619569727845, 5205.27126202332, 4387.648988080946, 4751.429828420612, 4811.230203167476, 4848.781804818792, 4909.0672772173175, 3697.334479793663, 3747.6439738224826, 3787.8295476703065, 3823.063349479395, 3866.149447121629, 1008.9192864570816, 1078.6925726168004, 1114.6154576671036, 1121.4112590889847, 1123.646051493777, 924.4176169013479, 924.542351535994, 930.4882314726873, 955.0878910640322, 963.982997937169, 5945.464908158287, 6075.544334174954, 6150.0, 6174.289956654952, 6208.410201030895, 925.9074092590687, 956.8469044952774, 976.3409698453515, 984.8571957066185, 1012.8987101289812, 4099.651529620016, 4220.78896055196, 4253.2769429197115, 4254.574542545721, 4278.4010238566625, 10692.518836652369, 11137.0, 11187.32876027441, 11200.551977920955, 11203.271787333797, 10998.010179083922, 11018.228723989243, 11021.44892755359, 11050.557977680803, 11068.667939961813, 7748.57382843949, 8145.144759800254, 8170.060443049126, 8318.459300145592, 8326.12575679557, 5863.706814659336, 6116.969415152896, 6119.173911522065, 6191.907121393093, 6305.464035557029, 10253.948730256301, 10306.948465257627, 10540.736481588021, 10550.314229575053, 10555.0, 10399.636012739518, 10464.47677616101, 10615.363078215332, 10764.784704305714, 10860.0, 7926.365890728613, 8032.437729359122, 8149.755507334789, 8155.79610509742, 8193.057798353266, 8665.826683466421, 8705.390622656354, 8737.519436430803, 8737.56312184401, 8739.56302184901, 7761.883571746315, 7945.960270198843, 7952.840943180989, 7991.920080799117, 7998.720044798404, 7472.887906681295, 7477.476576639583, 7491.625418729151, 7571.659275332513, 7640.541567505968, 7129.857402852018, 7172.13934327884, 7186.820329491805, 7195.0, 7202.53183543068, 5079.263506791568, 5097.9490205098955, 5123.282740416419, 5247.58019358458, 5250.133727934848, 5165.9483405166975, 5196.064708352382, 5228.0, 5344.331958505187, 5450.91823622638], "value": 4647.487289953969, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.95375170600266, 325.62065194048904, 326.74350634751727, 328.764933072853, 334.74726581431014, 5300.734963251836, 5301.469853014697, 5303.7348132593315, 5308.787648494061, 5309.73451327434, 5202.817901373443, 5264.710440925747, 5265.210218467222, 5266.552343050846, 5278.181881808317, 3833.750806197588, 3928.155446578985, 4019.437278780973, 4025.29557327468, 4037.919241615166, 4125.66994640428, 4147.668186545069, 4154.81587747492, 4158.08522125132, 4161.2093702196635, 4101.015756218516, 4116.917661646765, 4146.751194928299, 4152.480939882515, 4169.72896761711, 3944.15200731844, 4015.377616469452, 4097.815598298054, 4160.729552579072, 4162.875113746577, 3595.7842529448317, 3610.963890361089, 3612.6206748291575, 3618.203995121069, 3627.7460577759566, 5117.53942145205, 5119.360079990001, 5128.153864608737, 5160.045391602565, 5178.508041736029, 4467.307567327037, 4686.835960741392, 4689.812407503696, 4701.130290896195, 4709.246520556729, 5433.293671822637, 5437.211604317352, 5478.260434841285, 5481.917771233395, 5488.313960754906, 3940.527136743609, 3947.230290093433, 3974.8012599370204, 3981.9601803981877, 3993.940090898639, 5523.420040895729, 5730.971345143289, 5731.914021289643, 5752.884942301131, 5752.9712351437975, 3959.366501359769, 3986.8405263789123, 3990.8204130814183, 3995.6603688686787, 4005.3991901214467, 4069.04377471294, 4079.5920407958965, 4083.224187404384, 4086.141910198832, 4095.91808163841, 4577.954220457753, 4682.765861706901, 4688.132695451352, 4698.919248572779, 4703.882402939886, 5485.052806253802, 5516.80691175815, 5522.067276453289, 5567.944320556823, 5602.187682786055, 1390.5272207449516, 1401.4044031286662, 1404.4452441285634, 1410.6050305914155, 1411.703542256117, 867.3278209387774, 881.8809460722848, 908.6456282050005, 915.6337465014047, 921.4703592037187, 4786.617070634341, 4791.377120974321, 4808.855734327975, 4823.324734537167, 4826.95173048265, 5027.134533315975, 5051.797928082909, 5065.744774389531, 5128.743562821844, 5164.586833053347, 4561.885952851139, 4771.379720636295, 4808.206645903387, 4833.299171620095, 4878.146324393288, 2665.7200993895362, 2668.4262883480146, 2672.6391937088633, 2672.665916760405, 2683.9597406038924, 5193.675612718733, 5203.866414769926, 5204.42751297357, 5205.2042045494245, 5212.9739351303, 4888.02239552091, 5112.693238405707, 5135.486451354835, 5139.434662187156, 5521.668699878021, 5662.989638678292, 5870.412958704095, 5934.109883517507, 5954.702264886825, 5960.195373624505, 5707.0, 5722.909628800568, 5728.336323609542, 5731.19763233156, 5756.3380211276235, 5320.627556071193, 5606.327240731139, 5635.915461268166, 5643.3792282848035, 5661.264035675335, 5793.652380857162, 5827.921834460638, 5848.912266315923, 5857.765689372377, 5876.823695289148, 3873.341531939521, 3897.376419772823, 3898.719249239227, 3901.6098390160755, 3910.941335880021, 5497.45025497447, 5603.8792241552665, 5604.8318550443555, 5645.8545752613745, 5665.405132461032, 5515.917261241165, 5523.6685798852195, 5546.389897111395, 5551.195076713773, 5556.194351818883, 5277.572316734345, 5490.945090549043, 5521.917171242354, 5531.778728850962, 5532.5020748132865, 5491.945080549143, 5500.559955203494, 5509.393966663583, 5517.69652669091, 5520.558355331644, 5511.338639363302, 5530.529904958124, 5540.445955404427, 5555.749991250323, 5574.052411090043, 5261.842144735664, 5423.430539793265, 5431.37539182999, 5444.747708027255, 5445.210444485607], "value": 4125.982794440965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.3874886971638, 734.2363941500839, 749.194615788028, 756.678411675038, 757.1973707869658, 16063.116528590923, 16562.254698538578, 16592.585185370343, 16606.25271862766, 16618.33526658932, 15927.44253951112, 16743.24655390507, 16763.497095087136, 17283.395081172162, 17465.91267043666, 667.4927055437878, 815.3843847894846, 816.6284340625031, 833.9666413343489, 834.045018453873, 791.48553440264, 820.4789958376444, 824.826786374862, 825.7027470110785, 826.3554427546524, 853.799357151069, 855.285836326668, 855.5807654249435, 856.0882659967147, 856.8029353248756, 701.9894701579481, 841.7348535211389, 849.8130411309502, 849.902261239956, 852.4288726553193, 628.7516431009772, 628.7862126876838, 628.9842753931189, 629.1255155334089, 632.1876388840318, 16614.0, 16619.0, 16663.6667266654, 16673.83326166735, 16678.082705451194, 14497.855021449755, 15066.09603423798, 15150.54548363551, 15225.543233703007, 15245.23773811305, 11655.825162622483, 12253.019758419305, 14012.649683757885, 14120.85879141216, 14268.357923893449, 3918.784466854322, 3965.381120495761, 4013.177298653769, 4014.237294913957, 4147.7926103695, 69295.65352173206, 70474.0, 71111.0, 82782.58608706978, 83988.16011839865, 11807.822882656767, 12005.92959356324, 12046.397680115959, 12113.636590902288, 12400.19398739097, 20463.79536204619, 20535.794642053686, 20539.794602054088, 20565.280215192397, 20575.485612859797, 9076.909230907606, 9095.863562046574, 9134.771630709285, 9248.953755231181, 9466.242700583936, 4885.5358740919555, 4963.255511673206, 4989.675671081441, 5031.471695471922, 5255.684658920477, 3569.250457403922, 3707.462417949382, 3708.5735140458655, 3708.8331025103935, 3721.7580857244734, 678.1624693503519, 696.0916004614028, 703.8838591632426, 704.7357241034612, 706.1208795050093, 727.6507276507306, 742.2132539508139, 771.4060173666246, 773.7137259214127, 773.7369294439804, 9716.465594392235, 9928.50357482123, 10166.593336266467, 10211.081002709792, 10683.198760092868, 624.5596854217765, 672.428435829541, 701.8876979683226, 738.9371903388164, 745.3440971944763, 4818.640451454685, 5021.271915572222, 5407.675539467645, 5499.33282358056, 5646.2377579027125, 113421.35918447025, 114929.42535287437, 116456.0, 118048.0, 130726.0, 87064.0, 97270.05459890762, 97999.51000244953, 98943.0, 99708.0, 72999.6350018257, 85182.57408712916, 85356.57321713351, 87371.0, 88562.55718721365, 9924.255680824112, 10194.235432342752, 10244.846327305246, 10573.101286390744, 10627.628033019117, 38848.805755971036, 47078.0, 48281.75859120682, 51233.0, 52657.736711316196, 72443.63778181287, 73855.26144738699, 75387.0, 76116.23883761092, 80001.0, 13709.794353084511, 13741.862581374458, 13742.793858091936, 14073.718525629634, 14076.718465630425, 15508.224588770741, 15550.144742039296, 15957.521274361789, 15997.258464243543, 16026.198690065217, 14399.42402303896, 14819.851801481847, 15216.239188040776, 15369.538913832603, 15891.0, 13373.465061397435, 14777.704445911237, 14888.255587220812, 15150.25854962413, 15178.848211518185, 13632.863671363159, 13678.31608419555, 13730.244836534086, 14197.574072777834, 14300.928495357457, 11724.88275117238, 12112.818307725214, 12215.144939854124, 12281.508739650313, 12350.691232719253, 11600.825987610362, 12173.147879648339, 12216.511339546674, 12984.35078246065, 13009.479620815062], "value": 7871.310686333703, "unit": "score"}], "name": "dromaeo_css", "value": 7350.546111382968, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 111.0, 111.0, 114.0, 113.0, 111.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 117.0, 176.0, 116.0, 118.0, 148.0, 118.0, 151.0, 116.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 159.0, 160.0, 160.0, 159.0, 161.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 125.0, 74.0, 75.0, 74.0, 75.0, 108.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 107.0, 84.0, 84.0, 84.0, 120.0, 84.0, 84.0, 133.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 52.0, 52.0, 53.0, 54.0, 55.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 60.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 74.0, 75.0, 80.0, 76.0, 75.0, 75.0, 84.0, 84.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 121.0, 117.0, 125.0, 120.0, 129.0, 173.0, 123.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 163.0, 162.0, 159.0, 155.0, 156.0, 160.0, 154.0, 156.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 61.0, 61.0, 60.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1477.2, "alertThreshold": 2.0}]} 14:31:59 INFO - Return code: 0 14:31:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:59 INFO - # TBPL SUCCESS # 14:31:59 INFO - Running post-action listener: _resource_record_post_action 14:31:59 INFO - ##### 14:31:59 INFO - ##### Finished run-tests step (success) 14:31:59 INFO - ##### 14:31:59 INFO - Running post-run listener: _resource_record_post_run 14:31:59 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 423841792; Read time: 1772; Write time: 394324 14:31:59 INFO - TinderboxPrint: CPU usage
13.0% 14:31:59 INFO - TinderboxPrint: I/O read bytes / time
7,811,072 / 1,772 14:31:59 INFO - TinderboxPrint: I/O write bytes / time
423,841,792 / 394,324 14:31:59 INFO - TinderboxPrint: CPU idle
8,281.9 (87.0%) 14:31:59 INFO - TinderboxPrint: CPU user
1,195.6 (12.6%) 14:31:59 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 93794304; Read time: 232; Write time: 80208 14:31:59 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5570560; Write bytes: 330047488; Read time: 1388; Write time: 314116 14:31:59 INFO - Running post-run listener: _upload_blobber_files 14:31:59 INFO - Blob upload gear active. 14:31:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:32:00 INFO - (blobuploader) - INFO - Open directory for files ... 14:32:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:32:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:03 INFO - (blobuploader) - INFO - Done attempting. 14:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:05 INFO - (blobuploader) - INFO - Done attempting. 14:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:05 INFO - (blobuploader) - INFO - Done attempting. 14:32:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:32:05 INFO - Return code: 0 14:32:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:32:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:32:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3ecece653db90cfd6bc890ed74befbfab0cb06708d189f8b5eb79c4b0f6b693b184480f72cd443ced4148295387dbaec5e79e8a69726185bf2e3dcca2da9dbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56ac51d675b275f960f174ae08869c82f50fec7a603a28dd8a50f370dae0aeeed6b97415163e34efa62f8187676be5508127a2f9ed5098e3d93d861f831fe14f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f09544dccf80fb6292a845628d497bc15517c0678f2b028b5541a34de4ae91b4831566572fc5ea4d652a2013ee0ac98cdfbd72058bb7e1ed697f712cbae19be8"} 14:32:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:32:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:32:05 INFO - Contents: 14:32:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3ecece653db90cfd6bc890ed74befbfab0cb06708d189f8b5eb79c4b0f6b693b184480f72cd443ced4148295387dbaec5e79e8a69726185bf2e3dcca2da9dbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56ac51d675b275f960f174ae08869c82f50fec7a603a28dd8a50f370dae0aeeed6b97415163e34efa62f8187676be5508127a2f9ed5098e3d93d861f831fe14f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f09544dccf80fb6292a845628d497bc15517c0678f2b028b5541a34de4ae91b4831566572fc5ea4d652a2013ee0ac98cdfbd72058bb7e1ed697f712cbae19be8"} 14:32:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:32:05 INFO - Copying logs to upload dir... 14:32:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:32:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.800278 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-11 14:32:05.819267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 14:32:05.822680) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3ecece653db90cfd6bc890ed74befbfab0cb06708d189f8b5eb79c4b0f6b693b184480f72cd443ced4148295387dbaec5e79e8a69726185bf2e3dcca2da9dbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56ac51d675b275f960f174ae08869c82f50fec7a603a28dd8a50f370dae0aeeed6b97415163e34efa62f8187676be5508127a2f9ed5098e3d93d861f831fe14f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f09544dccf80fb6292a845628d497bc15517c0678f2b028b5541a34de4ae91b4831566572fc5ea4d652a2013ee0ac98cdfbd72058bb7e1ed697f712cbae19be8"} build_url:https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/OSw-R0rJRPG8GMygcX8iEg/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/Fx-Team/sha512/f3ecece653db90cfd6bc890ed74befbfab0cb06708d189f8b5eb79c4b0f6b693b184480f72cd443ced4148295387dbaec5e79e8a69726185bf2e3dcca2da9dbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56ac51d675b275f960f174ae08869c82f50fec7a603a28dd8a50f370dae0aeeed6b97415163e34efa62f8187676be5508127a2f9ed5098e3d93d861f831fe14f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f09544dccf80fb6292a845628d497bc15517c0678f2b028b5541a34de4ae91b4831566572fc5ea4d652a2013ee0ac98cdfbd72058bb7e1ed697f712cbae19be8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 14:32:05.847777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 14:32:05.848111) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468270644.317302-614429351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 14:32:05.932911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 14:32:05.933670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 14:32:05.933967) ========= ========= Total master_lag: 0.43 =========