builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1467901800.67 results: success (0) buildid: 20160707070123 builduid: 1830e053c27a4a6282bd3761f34a892c revision: ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:00.666471) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:00.667242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:00.667610) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:00.727457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:00.727779) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 07:30:01-- 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% 104M=0s 2016-07-07 07:30:01 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072576 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:00.825039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:00.825328) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019936 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:00.920613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 07:30:00.921061) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 --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 ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 --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=5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 07:30:01,392 truncating revision to first 12 chars 2016-07-07 07:30:01,392 Setting DEBUG logging. 2016-07-07 07:30:01,392 attempt 1/10 2016-07-07 07:30:01,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba5ff277a3cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 07:30:02,749 unpacking tar archive at: fx-team-ba5ff277a3cd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.816021 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 07:30:02.756218) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:02.758563) ========= script_repo_revision: ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:02.758994) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:02.759266) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:02.769174) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-07 07:30:02.769555) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:30:03 INFO - MultiFileLogger online at 20160707 07:30:03 in /builds/slave/test 07:30:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:30:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:03 INFO - {'append_to_log': False, 07:30:03 INFO - 'base_work_dir': '/builds/slave/test', 07:30:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:30:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:03 INFO - 'branch': 'Fx-Team-Non-PGO', 07:30:03 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:03 INFO - 'config_files': ('talos/linux_config.py',), 07:30:03 INFO - 'default_actions': ('clobber', 07:30:03 INFO - 'read-buildbot-config', 07:30:03 INFO - 'download-and-extract', 07:30:03 INFO - 'populate-webroot', 07:30:03 INFO - 'create-virtualenv', 07:30:03 INFO - 'install', 07:30:03 INFO - 'run-tests'), 07:30:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:03 INFO - 'download_minidump_stackwalk': True, 07:30:03 INFO - 'download_symbols': 'ondemand', 07:30:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:03 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:03 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:03 INFO - 'installer_path': 'installer.exe', 07:30:03 INFO - 'log_level': 'info', 07:30:03 INFO - 'log_name': 'talos', 07:30:03 INFO - 'log_to_console': True, 07:30:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:30:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:30:03 INFO - 'opt_config_files': (), 07:30:03 INFO - 'pip_index': False, 07:30:03 INFO - 'sps_profile': False, 07:30:03 INFO - 'sps_profile_interval': 0, 07:30:03 INFO - 'suite': 'dromaeojs', 07:30:03 INFO - 'system_bits': '32', 07:30:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:03 INFO - 'title': 'talos-linux64-ix-039', 07:30:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:03 INFO - 'use_talos_json': True, 07:30:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:03 INFO - 'work_dir': 'build'} 07:30:03 INFO - ##### 07:30:03 INFO - ##### Running clobber step. 07:30:03 INFO - ##### 07:30:03 INFO - Running pre-action listener: _resource_record_pre_action 07:30:03 INFO - Running main action method: clobber 07:30:03 INFO - rmtree: /builds/slave/test/build 07:30:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:03 INFO - Running post-action listener: _resource_record_post_action 07:30:03 INFO - ##### 07:30:03 INFO - ##### Finished clobber step (success) 07:30:03 INFO - ##### 07:30:03 INFO - ##### 07:30:03 INFO - ##### Running read-buildbot-config step. 07:30:03 INFO - ##### 07:30:03 INFO - Running pre-action listener: _resource_record_pre_action 07:30:03 INFO - Running main action method: read_buildbot_config 07:30:03 INFO - Using buildbot properties: 07:30:03 INFO - { 07:30:03 INFO - "project": "", 07:30:03 INFO - "product": "firefox", 07:30:03 INFO - "script_repo_revision": "production", 07:30:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:30:03 INFO - "repository": "", 07:30:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:30:03 INFO - "buildid": "20160707070123", 07:30:03 INFO - "pgo_build": "False", 07:30:03 INFO - "basedir": "/builds/slave/test", 07:30:03 INFO - "buildnumber": 1941, 07:30:03 INFO - "slavename": "talos-linux64-ix-039", 07:30:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:30:03 INFO - "platform": "ubuntu64_hw", 07:30:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:30:03 INFO - "branch": "fx-team", 07:30:03 INFO - "repo_path": "integration/fx-team", 07:30:03 INFO - "revision": "ba5ff277a3cd1a7f655f8e02a130a395e8f2a225", 07:30:03 INFO - "stage_platform": "linux64", 07:30:03 INFO - "builduid": "1830e053c27a4a6282bd3761f34a892c", 07:30:03 INFO - "slavebuilddir": "test" 07:30:03 INFO - } 07:30:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:30:03 INFO - Running post-action listener: _resource_record_post_action 07:30:03 INFO - ##### 07:30:03 INFO - ##### Finished read-buildbot-config step (success) 07:30:03 INFO - ##### 07:30:03 INFO - ##### 07:30:03 INFO - ##### Running download-and-extract step. 07:30:03 INFO - ##### 07:30:03 INFO - Running pre-action listener: _resource_record_pre_action 07:30:03 INFO - Running main action method: download_and_extract 07:30:03 INFO - mkdir: /builds/slave/test/build/tests 07:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:03 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:30:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:30:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:30:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:18 INFO - Downloaded 1361 bytes. 07:30:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:30:18 INFO - Using the following test package requirements: 07:30:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:30:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:30:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:18 INFO - u'jsshell-linux-x86_64.zip'], 07:30:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:30:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:30:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:30:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:30:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:30:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:18 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:30:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:30:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:30:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:29 INFO - Downloaded 22734516 bytes. 07:30:29 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'] 07:30:29 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 07:30:30 INFO - Return code: 0 07:30:30 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 07:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:30 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:30:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:30:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:30:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:32 INFO - Downloaded 22734516 bytes. 07:30:32 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'] 07:30:32 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 07:30:33 INFO - Return code: 0 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:33 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:34 INFO - Downloaded 14403333 bytes. 07:30:34 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'] 07:30:34 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 07:30:34 INFO - Return code: 0 07:30:34 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')]} 07:30:34 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:30:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:30:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:30:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:36 INFO - Downloaded 56643000 bytes. 07:30:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:30:36 INFO - mkdir: /builds/slave/test/properties 07:30:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:30:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:30:36 INFO - Contents: 07:30:36 INFO - build_url:https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:30:37 INFO - Running post-action listener: _resource_record_post_action 07:30:37 INFO - Running post-action listener: set_extra_try_arguments 07:30:37 INFO - ##### 07:30:37 INFO - ##### Finished download-and-extract step (success) 07:30:37 INFO - ##### 07:30:37 INFO - ##### 07:30:37 INFO - ##### Running populate-webroot step. 07:30:37 INFO - ##### 07:30:37 INFO - Running pre-action listener: _resource_record_pre_action 07:30:37 INFO - Running main action method: populate_webroot 07:30:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:30:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:30:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:30:37 INFO - '--tppagecycles', 07:30:37 INFO - '7'], 07:30:37 INFO - 'tests': ['tsvgm']}}, 07:30:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:30:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:30:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:30:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:30:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:37 INFO - 'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:37 INFO - 'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['damp', 'tps']}, 07:30:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:37 INFO - 'tests': ['damp', 'tps']}, 07:30:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['dromaeo_dom']}, 07:30:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:30:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['basic_compositor_video']}, 07:30:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:30:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['a11yr', 07:30:37 INFO - 'ts_paint', 07:30:37 INFO - 'tpaint', 07:30:37 INFO - 'sessionrestore', 07:30:37 INFO - 'sessionrestore_no_auto_restore', 07:30:37 INFO - 'tabpaint']}, 07:30:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:30:37 INFO - 'ts_paint', 07:30:37 INFO - 'tpaint', 07:30:37 INFO - 'sessionrestore', 07:30:37 INFO - 'sessionrestore_no_auto_restore', 07:30:37 INFO - 'tabpaint']}, 07:30:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:30:37 INFO - 'ts_paint', 07:30:37 INFO - 'tpaint', 07:30:37 INFO - 'sessionrestore', 07:30:37 INFO - 'sessionrestore_no_auto_restore', 07:30:37 INFO - 'tabpaint']}, 07:30:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:30:37 INFO - 'ts_paint', 07:30:37 INFO - 'tpaint', 07:30:37 INFO - 'sessionrestore', 07:30:37 INFO - 'sessionrestore_no_auto_restore', 07:30:37 INFO - 'tabpaint']}, 07:30:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['a11yr', 07:30:37 INFO - 'ts_paint', 07:30:37 INFO - 'tpaint', 07:30:37 INFO - 'sessionrestore', 07:30:37 INFO - 'sessionrestore_no_auto_restore', 07:30:37 INFO - 'tabpaint']}, 07:30:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['a11yr', 07:30:37 INFO - 'ts_paint', 07:30:37 INFO - 'tpaint', 07:30:37 INFO - 'sessionrestore', 07:30:37 INFO - 'sessionrestore_no_auto_restore', 07:30:37 INFO - 'tabpaint']}, 07:30:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['tsvgx', 07:30:37 INFO - 'tsvgr_opacity', 07:30:37 INFO - 'tart', 07:30:37 INFO - 'tscrollx', 07:30:37 INFO - 'cart']}, 07:30:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:30:37 INFO - 'tsvgr_opacity', 07:30:37 INFO - 'tart', 07:30:37 INFO - 'tscrollx', 07:30:37 INFO - 'cart']}, 07:30:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:37 INFO - 'talos_options': ['--disable-e10s'], 07:30:37 INFO - 'tests': ['tp5o']}, 07:30:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:37 INFO - 'tests': ['tp5o']}, 07:30:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:37 INFO - 'talos_options': ['--disable-e10s', 07:30:37 INFO - '--xperf_path', 07:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:37 INFO - 'tests': ['tp5n']}, 07:30:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:37 INFO - 'talos_options': ['--xperf_path', 07:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:37 INFO - 'tests': ['tp5n']}}, 07:30:37 INFO - 'talos.zip': {'path': '', 07:30:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:37 INFO - Running post-action listener: _resource_record_post_action 07:30:37 INFO - ##### 07:30:37 INFO - ##### Finished populate-webroot step (success) 07:30:37 INFO - ##### 07:30:37 INFO - ##### 07:30:37 INFO - ##### Running create-virtualenv step. 07:30:37 INFO - ##### 07:30:37 INFO - Running pre-action listener: _resource_record_pre_action 07:30:37 INFO - Running main action method: create_virtualenv 07:30:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:30:37 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 07:30:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:30:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:30:37 INFO - Using real prefix '/usr' 07:30:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:30:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:30:39 INFO - Installing pip.................done. 07:30:39 INFO - Return code: 0 07:30:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:39 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 0x2007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', '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 07:30:39 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 07:30:39 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 07:30:39 INFO - Using env: {'DISPLAY': ':0', 07:30:39 INFO - 'HOME': '/home/cltbld', 07:30:39 INFO - 'LANG': 'en_US.UTF-8', 07:30:39 INFO - 'LANGUAGE': 'en_US:en', 07:30:39 INFO - 'LOGNAME': 'cltbld', 07:30:39 INFO - 'MAIL': '/var/mail/cltbld', 07:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:39 INFO - 'MOZ_NO_REMOTE': '1', 07:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:39 INFO - 'NO_EM_RESTART': '1', 07:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:39 INFO - 'PWD': '/builds/slave/test', 07:30:39 INFO - 'SHELL': '/bin/bash', 07:30:39 INFO - 'SHLVL': '1', 07:30:39 INFO - 'TERM': 'linux', 07:30:39 INFO - 'TMOUT': '86400', 07:30:39 INFO - 'USER': 'cltbld', 07:30:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:39 INFO - '_': '/tools/buildbot/bin/python'} 07:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:39 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 07:30:39 INFO - Cleaning up... 07:30:39 INFO - Return code: 0 07:30:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:39 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 0x2007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', '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 07:30:39 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 07:30:39 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 07:30:39 INFO - Using env: {'DISPLAY': ':0', 07:30:39 INFO - 'HOME': '/home/cltbld', 07:30:39 INFO - 'LANG': 'en_US.UTF-8', 07:30:39 INFO - 'LANGUAGE': 'en_US:en', 07:30:39 INFO - 'LOGNAME': 'cltbld', 07:30:39 INFO - 'MAIL': '/var/mail/cltbld', 07:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:39 INFO - 'MOZ_NO_REMOTE': '1', 07:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:39 INFO - 'NO_EM_RESTART': '1', 07:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:39 INFO - 'PWD': '/builds/slave/test', 07:30:39 INFO - 'SHELL': '/bin/bash', 07:30:39 INFO - 'SHLVL': '1', 07:30:39 INFO - 'TERM': 'linux', 07:30:39 INFO - 'TMOUT': '86400', 07:30:39 INFO - 'USER': 'cltbld', 07:30:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:39 INFO - '_': '/tools/buildbot/bin/python'} 07:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:40 INFO - Downloading/unpacking psutil>=3.1.1 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 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 07:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:30:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:42 INFO - Installing collected packages: psutil 07:30:42 INFO - Running setup.py install for psutil 07:30:42 INFO - building 'psutil._psutil_linux' extension 07:30:42 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 07:30:42 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 07:30:42 INFO - building 'psutil._psutil_posix' extension 07:30:42 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 07:30:42 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 07:30:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:42 INFO - Successfully installed psutil 07:30:42 INFO - Cleaning up... 07:30:42 INFO - Return code: 0 07:30:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:42 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 0x2007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', '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 07:30:42 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 07:30:42 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 07:30:42 INFO - Using env: {'DISPLAY': ':0', 07:30:42 INFO - 'HOME': '/home/cltbld', 07:30:42 INFO - 'LANG': 'en_US.UTF-8', 07:30:42 INFO - 'LANGUAGE': 'en_US:en', 07:30:42 INFO - 'LOGNAME': 'cltbld', 07:30:42 INFO - 'MAIL': '/var/mail/cltbld', 07:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:42 INFO - 'MOZ_NO_REMOTE': '1', 07:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:42 INFO - 'NO_EM_RESTART': '1', 07:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:42 INFO - 'PWD': '/builds/slave/test', 07:30:42 INFO - 'SHELL': '/bin/bash', 07:30:42 INFO - 'SHLVL': '1', 07:30:42 INFO - 'TERM': 'linux', 07:30:42 INFO - 'TMOUT': '86400', 07:30:42 INFO - 'USER': 'cltbld', 07:30:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:42 INFO - '_': '/tools/buildbot/bin/python'} 07:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:30:42 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 07:30:42 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 07:30:42 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 07:30:42 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 07:30:42 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 07:30:42 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 07:30:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:30:45 INFO - Installing collected packages: mozsystemmonitor 07:30:45 INFO - Running setup.py install for mozsystemmonitor 07:30:45 INFO - Successfully installed mozsystemmonitor 07:30:45 INFO - Cleaning up... 07:30:45 INFO - Return code: 0 07:30:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:30: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')]} 07:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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', '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 0x2007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', '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 07:30: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:30: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 jsonschema==2.5.1 07:30:45 INFO - Using env: {'DISPLAY': ':0', 07:30:45 INFO - 'HOME': '/home/cltbld', 07:30:45 INFO - 'LANG': 'en_US.UTF-8', 07:30:45 INFO - 'LANGUAGE': 'en_US:en', 07:30:45 INFO - 'LOGNAME': 'cltbld', 07:30:45 INFO - 'MAIL': '/var/mail/cltbld', 07:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:45 INFO - 'MOZ_NO_REMOTE': '1', 07:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:45 INFO - 'NO_EM_RESTART': '1', 07:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:45 INFO - 'PWD': '/builds/slave/test', 07:30:45 INFO - 'SHELL': '/bin/bash', 07:30:45 INFO - 'SHLVL': '1', 07:30:45 INFO - 'TERM': 'linux', 07:30:45 INFO - 'TMOUT': '86400', 07:30:45 INFO - 'USER': 'cltbld', 07:30:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:45 INFO - '_': '/tools/buildbot/bin/python'} 07:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:46 INFO - Downloading/unpacking jsonschema==2.5.1 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:30:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 INFO - Downloading functools32-3.2.3-2.tar.gz 07:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:30:48 INFO - warning: no files found matching '*.txt' 07:30:48 INFO - no previously-included directories found matching 'build' 07:30:48 INFO - no previously-included directories found matching 'dist' 07:30:48 INFO - no previously-included directories found matching '.git*' 07:30:48 INFO - Installing collected packages: jsonschema, functools32 07:30:48 INFO - Running setup.py install for functools32 07:30:48 INFO - warning: no files found matching '*.txt' 07:30:48 INFO - no previously-included directories found matching 'build' 07:30:48 INFO - no previously-included directories found matching 'dist' 07:30:48 INFO - no previously-included directories found matching '.git*' 07:30:48 INFO - Successfully installed jsonschema functools32 07:30:48 INFO - Cleaning up... 07:30:48 INFO - Return code: 0 07:30:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', '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 07:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:30:48 INFO - Using env: {'DISPLAY': ':0', 07:30:48 INFO - 'HOME': '/home/cltbld', 07:30:48 INFO - 'LANG': 'en_US.UTF-8', 07:30:48 INFO - 'LANGUAGE': 'en_US:en', 07:30:48 INFO - 'LOGNAME': 'cltbld', 07:30:48 INFO - 'MAIL': '/var/mail/cltbld', 07:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:48 INFO - 'MOZ_NO_REMOTE': '1', 07:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:48 INFO - 'NO_EM_RESTART': '1', 07:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:48 INFO - 'PWD': '/builds/slave/test', 07:30:48 INFO - 'SHELL': '/bin/bash', 07:30:48 INFO - 'SHLVL': '1', 07:30:48 INFO - 'TERM': 'linux', 07:30:48 INFO - 'TMOUT': '86400', 07:30:48 INFO - 'USER': 'cltbld', 07:30:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:48 INFO - '_': '/tools/buildbot/bin/python'} 07:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:50 INFO - Downloading blobuploader-1.2.4.tar.gz 07:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:30:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:30:50 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 07:30:50 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 07:30:50 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 07:30:50 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 07:30:50 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 07:30:50 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 07:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:30:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:51 INFO - Downloading docopt-0.6.1.tar.gz 07:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:30:51 INFO - Installing collected packages: blobuploader, requests, docopt 07:30:51 INFO - Running setup.py install for blobuploader 07:30:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:30:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:30:51 INFO - Running setup.py install for requests 07:30:52 INFO - Running setup.py install for docopt 07:30:52 INFO - Successfully installed blobuploader requests docopt 07:30:52 INFO - Cleaning up... 07:30:52 INFO - Return code: 0 07:30:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:52 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 0x2007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', '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 07:30:52 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 07:30:52 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 07:30:52 INFO - Using env: {'DISPLAY': ':0', 07:30:52 INFO - 'HOME': '/home/cltbld', 07:30:52 INFO - 'LANG': 'en_US.UTF-8', 07:30:52 INFO - 'LANGUAGE': 'en_US:en', 07:30:52 INFO - 'LOGNAME': 'cltbld', 07:30:52 INFO - 'MAIL': '/var/mail/cltbld', 07:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:52 INFO - 'MOZ_NO_REMOTE': '1', 07:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:52 INFO - 'NO_EM_RESTART': '1', 07:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:52 INFO - 'PWD': '/builds/slave/test', 07:30:52 INFO - 'SHELL': '/bin/bash', 07:30:52 INFO - 'SHLVL': '1', 07:30:52 INFO - 'TERM': 'linux', 07:30:52 INFO - 'TMOUT': '86400', 07:30:52 INFO - 'USER': 'cltbld', 07:30:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:52 INFO - '_': '/tools/buildbot/bin/python'} 07:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:52 INFO - Running setup.py (path:/tmp/pip-muKRFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:52 INFO - Running setup.py (path:/tmp/pip-bcinwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:52 INFO - Running setup.py (path:/tmp/pip-17FDEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:52 INFO - Running setup.py (path:/tmp/pip-Jquaca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:52 INFO - Running setup.py (path:/tmp/pip-9YQvZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:52 INFO - Running setup.py (path:/tmp/pip-WlZCpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:52 INFO - Running setup.py (path:/tmp/pip-ugLPZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:52 INFO - Running setup.py (path:/tmp/pip-Gby0V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:52 INFO - Running setup.py (path:/tmp/pip-j4b97P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:53 INFO - Running setup.py (path:/tmp/pip-UdE03Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:53 INFO - Running setup.py (path:/tmp/pip-MrflJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:53 INFO - Running setup.py (path:/tmp/pip-0reADS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:53 INFO - Running setup.py (path:/tmp/pip-ZvpV6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:53 INFO - Running setup.py (path:/tmp/pip-dI3dFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:53 INFO - Running setup.py (path:/tmp/pip-KYXmoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:53 INFO - Running setup.py (path:/tmp/pip-YtgZbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:53 INFO - Running setup.py (path:/tmp/pip-lPDuAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:30:53 INFO - Running setup.py install for manifestparser 07:30:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:30:53 INFO - Running setup.py install for mozcrash 07:30:53 INFO - Running setup.py install for mozdebug 07:30:53 INFO - Running setup.py install for mozdevice 07:30:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Running setup.py install for mozfile 07:30:54 INFO - Running setup.py install for mozhttpd 07:30:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Running setup.py install for mozinfo 07:30:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Running setup.py install for mozInstall 07:30:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Running setup.py install for mozleak 07:30:54 INFO - Running setup.py install for mozlog 07:30:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Running setup.py install for moznetwork 07:30:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Running setup.py install for mozprocess 07:30:54 INFO - Running setup.py install for mozprofile 07:30:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:30:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:30:55 INFO - Running setup.py install for mozrunner 07:30:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:30:55 INFO - Running setup.py install for mozscreenshot 07:30:55 INFO - Running setup.py install for moztest 07:30:55 INFO - Running setup.py install for mozversion 07:30:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:30:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:30:55 INFO - Cleaning up... 07:30:55 INFO - Return code: 0 07:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:55 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')]} 07:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:55 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')]} 07:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:55 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 0x2007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', '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 07:30:55 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 07:30:55 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 07:30:55 INFO - Using env: {'DISPLAY': ':0', 07:30:55 INFO - 'HOME': '/home/cltbld', 07:30:55 INFO - 'LANG': 'en_US.UTF-8', 07:30:55 INFO - 'LANGUAGE': 'en_US:en', 07:30:55 INFO - 'LOGNAME': 'cltbld', 07:30:55 INFO - 'MAIL': '/var/mail/cltbld', 07:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:55 INFO - 'MOZ_NO_REMOTE': '1', 07:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:55 INFO - 'NO_EM_RESTART': '1', 07:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:55 INFO - 'PWD': '/builds/slave/test', 07:30:55 INFO - 'SHELL': '/bin/bash', 07:30:55 INFO - 'SHLVL': '1', 07:30:55 INFO - 'TERM': 'linux', 07:30:55 INFO - 'TMOUT': '86400', 07:30:55 INFO - 'USER': 'cltbld', 07:30:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:55 INFO - '_': '/tools/buildbot/bin/python'} 07:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:55 INFO - Running setup.py (path:/tmp/pip-kw9VKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:55 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)) 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:55 INFO - Running setup.py (path:/tmp/pip-k02Rca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:55 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)) 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:55 INFO - Running setup.py (path:/tmp/pip-UuQLVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:55 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)) 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:55 INFO - Running setup.py (path:/tmp/pip-mIlRlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:55 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)) 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:55 INFO - Running setup.py (path:/tmp/pip-mDu_Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:56 INFO - Running setup.py (path:/tmp/pip-MIZn_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:56 INFO - Running setup.py (path:/tmp/pip-hKb6jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:56 INFO - Running setup.py (path:/tmp/pip-1Wjbcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:56 INFO - Running setup.py (path:/tmp/pip-k16qYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:56 INFO - Running setup.py (path:/tmp/pip-27Ypa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:56 INFO - Running setup.py (path:/tmp/pip-GeFu7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:56 INFO - Running setup.py (path:/tmp/pip-AnxNT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:56 INFO - Running setup.py (path:/tmp/pip-gqnJ2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:56 INFO - Running setup.py (path:/tmp/pip-ebBVvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:56 INFO - Running setup.py (path:/tmp/pip-MdDJ2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:56 INFO - Running setup.py (path:/tmp/pip-bSlYY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:56 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)) 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:56 INFO - Running setup.py (path:/tmp/pip-LX4K1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:56 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)) 07:30:56 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)) 07:30:56 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)) 07:30:56 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)) 07:30:56 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)) 07:30:56 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)) 07:30:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:58 INFO - Downloading blessings-1.6.tar.gz 07:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:30:58 INFO - Installing collected packages: blessings 07:30:58 INFO - Running setup.py install for blessings 07:30:58 INFO - Successfully installed blessings 07:30:58 INFO - Cleaning up... 07:30:59 INFO - Return code: 0 07:30:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:59 INFO - Reading from file tmpfile_stdout 07:30:59 INFO - Current package versions: 07:30:59 INFO - argparse == 1.2.1 07:30:59 INFO - blessings == 1.6 07:30:59 INFO - blobuploader == 1.2.4 07:30:59 INFO - docopt == 0.6.1 07:30:59 INFO - functools32 == 3.2.3-2 07:30:59 INFO - jsonschema == 2.5.1 07:30:59 INFO - manifestparser == 1.1 07:30:59 INFO - mozInstall == 1.12 07:30:59 INFO - mozcrash == 0.17 07:30:59 INFO - mozdebug == 0.1 07:30:59 INFO - mozdevice == 0.48 07:30:59 INFO - mozfile == 1.2 07:30:59 INFO - mozhttpd == 0.7 07:30:59 INFO - mozinfo == 0.9 07:30:59 INFO - mozleak == 0.1 07:30:59 INFO - mozlog == 3.2 07:30:59 INFO - moznetwork == 0.27 07:30:59 INFO - mozprocess == 0.23 07:30:59 INFO - mozprofile == 0.28 07:30:59 INFO - mozrunner == 6.12 07:30:59 INFO - mozscreenshot == 0.1 07:30:59 INFO - mozsystemmonitor == 0.3 07:30:59 INFO - moztest == 0.7 07:30:59 INFO - mozversion == 1.4 07:30:59 INFO - psutil == 3.1.1 07:30:59 INFO - requests == 1.2.3 07:30:59 INFO - wsgiref == 0.1.2 07:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:59 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')]} 07:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:59 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')]} 07:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:59 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 0x2007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', '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 07:30:59 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 07:30:59 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 07:30:59 INFO - Using env: {'DISPLAY': ':0', 07:30:59 INFO - 'HOME': '/home/cltbld', 07:30:59 INFO - 'LANG': 'en_US.UTF-8', 07:30:59 INFO - 'LANGUAGE': 'en_US:en', 07:30:59 INFO - 'LOGNAME': 'cltbld', 07:30:59 INFO - 'MAIL': '/var/mail/cltbld', 07:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:59 INFO - 'MOZ_NO_REMOTE': '1', 07:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:59 INFO - 'NO_EM_RESTART': '1', 07:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:59 INFO - 'PWD': '/builds/slave/test', 07:30:59 INFO - 'SHELL': '/bin/bash', 07:30:59 INFO - 'SHLVL': '1', 07:30:59 INFO - 'TERM': 'linux', 07:30:59 INFO - 'TMOUT': '86400', 07:30:59 INFO - 'USER': 'cltbld', 07:30:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:59 INFO - '_': '/tools/buildbot/bin/python'} 07:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:59 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)) 07:30:59 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)) 07:30:59 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)) 07:30:59 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)) 07:30:59 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)) 07:30:59 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)) 07:30:59 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)) 07:30:59 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)) 07:30:59 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)) 07:30:59 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)) 07:30:59 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)) 07:30:59 INFO - Cleaning up... 07:30:59 INFO - Return code: 0 07:30:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:30:59 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')]} 07:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:59 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')]} 07:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', '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 07:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:30:59 INFO - Using env: {'DISPLAY': ':0', 07:30:59 INFO - 'HOME': '/home/cltbld', 07:30:59 INFO - 'LANG': 'en_US.UTF-8', 07:30:59 INFO - 'LANGUAGE': 'en_US:en', 07:30:59 INFO - 'LOGNAME': 'cltbld', 07:30:59 INFO - 'MAIL': '/var/mail/cltbld', 07:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:59 INFO - 'MOZ_NO_REMOTE': '1', 07:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:59 INFO - 'NO_EM_RESTART': '1', 07:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:59 INFO - 'PWD': '/builds/slave/test', 07:30:59 INFO - 'SHELL': '/bin/bash', 07:30:59 INFO - 'SHLVL': '1', 07:30:59 INFO - 'TERM': 'linux', 07:30:59 INFO - 'TMOUT': '86400', 07:30:59 INFO - 'USER': 'cltbld', 07:30:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:59 INFO - '_': '/tools/buildbot/bin/python'} 07:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:30:59 INFO - Cleaning up... 07:30:59 INFO - Return code: 0 07:30:59 INFO - Running post-action listener: _resource_record_post_action 07:30:59 INFO - Running post-action listener: _start_resource_monitoring 07:30:59 INFO - Starting resource monitoring. 07:30:59 INFO - ##### 07:30:59 INFO - ##### Finished create-virtualenv step (success) 07:30:59 INFO - ##### 07:30:59 INFO - ##### 07:30:59 INFO - ##### Running install step. 07:30:59 INFO - ##### 07:30:59 INFO - Running pre-action listener: _resource_record_pre_action 07:30:59 INFO - Running main action method: install 07:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:59 INFO - Reading from file tmpfile_stdout 07:30:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:31:00 INFO - Reading from file tmpfile_stdout 07:31:00 INFO - Output received: 07:31:00 INFO - Usage: mozinstall [options] installer 07:31:00 INFO - Options: 07:31:00 INFO - -h, --help show this help message and exit 07:31:00 INFO - -d DEST, --destination=DEST 07:31:00 INFO - Directory to install application into. [default: 07:31:00 INFO - "/builds/slave/test"] 07:31:00 INFO - --app=APP Application being installed. [default: firefox] 07:31:00 INFO - mkdir: /builds/slave/test/build/application 07:31:00 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'] 07:31:00 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 07:31:16 INFO - Reading from file tmpfile_stdout 07:31:16 INFO - Output received: 07:31:16 INFO - /builds/slave/test/build/application/firefox/firefox 07:31:16 INFO - Running post-action listener: _resource_record_post_action 07:31:16 INFO - ##### 07:31:16 INFO - ##### Finished install step (success) 07:31:16 INFO - ##### 07:31:16 INFO - ##### 07:31:16 INFO - ##### Running run-tests step. 07:31:16 INFO - ##### 07:31:16 INFO - Running pre-action listener: _resource_record_pre_action 07:31:16 INFO - Running main action method: run_tests 07:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:31:16 INFO - Python 2.7.3 07:31:16 INFO - Return code: 0 07:31:16 INFO - grabbing minidump binary from tooltool 07:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:16 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 0x22c63b0>, '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 0x22c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:31:16 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 07:31:16 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 07:31:16 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 07:31:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:31:16 INFO - Return code: 0 07:31:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:31:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:31:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:31:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:31:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 07:31:16 INFO - Using env: {'DISPLAY': ':0', 07:31:16 INFO - 'HOME': '/home/cltbld', 07:31:16 INFO - 'LANG': 'en_US.UTF-8', 07:31:16 INFO - 'LANGUAGE': 'en_US:en', 07:31:16 INFO - 'LOGNAME': 'cltbld', 07:31:16 INFO - 'MAIL': '/var/mail/cltbld', 07:31:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:31:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:16 INFO - 'MOZ_NO_REMOTE': '1', 07:31:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:16 INFO - 'NO_EM_RESTART': '1', 07:31:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:16 INFO - 'PWD': '/builds/slave/test', 07:31:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:31:16 INFO - 'SHELL': '/bin/bash', 07:31:16 INFO - 'SHLVL': '1', 07:31:16 INFO - 'TERM': 'linux', 07:31:16 INFO - 'TMOUT': '86400', 07:31:16 INFO - 'USER': 'cltbld', 07:31:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955', 07:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:16 INFO - '_': '/tools/buildbot/bin/python'} 07:31:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:31:16 INFO - mozversion application_buildid: 20160707070123 07:31:16 INFO - mozversion application_changeset: ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 07:31:16 INFO - mozversion application_display_name: Nightly 07:31:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:31:16 INFO - mozversion application_name: Firefox 07:31:16 INFO - mozversion application_remotingname: firefox 07:31:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:31:16 INFO - mozversion application_vendor: Mozilla 07:31:16 INFO - mozversion application_version: 50.0a1 07:31:16 INFO - mozversion platform_buildid: 20160707070123 07:31:16 INFO - mozversion platform_changeset: ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 07:31:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:31:16 INFO - mozversion platform_version: 50.0a1 07:31:16 INFO - using testdate: 1467901876 07:31:16 INFO - actual date: 1467901876 07:31:16 INFO - starting webserver on 'localhost:47235' 07:31:16 INFO - SUITE-START | Running 2 tests 07:31:16 INFO - TEST-START | dromaeo_css 07:31:16 INFO - operating with platform_type : linux_ 07:31:16 INFO - Initialising browser for dromaeo_css test... 07:31:16 INFO - TEST-INFO | started process 24348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqDgPBY/profile http://localhost:47235/getInfo.html) 07:31:21 INFO - PROCESS | 24348 | __metrics Screen width/height:1600/1200 07:31:21 INFO - PROCESS | 24348 | colorDepth:24 07:31:21 INFO - PROCESS | 24348 | Browser inner width/height: 1024/697 07:31:21 INFO - PROCESS | 24348 | __metrics 07:31:22 INFO - PROCESS | 24348 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:23 INFO - TEST-INFO | 24348: exit 0 07:31:23 INFO - Browser initialized. 07:31:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:31:23 INFO - TEST-INFO | started process 24429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqDgPBY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:35 INFO - PROCESS | 24429 | RSS: Main: 159170560 07:31:35 INFO - PROCESS | 24429 | 07:32:27 INFO - PROCESS | 24429 | 1467901947674 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] 07:34:39 INFO - PROCESS | 24429 | Cycle 1(1): loaded http://localhost:47235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47235/tests/dromaeo/cssquery-ext.html) 07:34:40 INFO - PROCESS | 24429 | RSS: Main: 272125952 07:34:40 INFO - PROCESS | 24429 | 07:37:43 INFO - PROCESS | 24429 | Cycle 1(1): loaded http://localhost:47235/tests/dromaeo/cssquery-ext.html (next: http://localhost:47235/tests/dromaeo/cssquery-jquery.html) 07:37:43 INFO - PROCESS | 24429 | RSS: Main: 253108224 07:37:43 INFO - PROCESS | 24429 | 07:40:46 INFO - PROCESS | 24429 | Cycle 1(1): loaded http://localhost:47235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47235/tests/dromaeo/cssquery-mootools.html) 07:40:46 INFO - PROCESS | 24429 | RSS: Main: 245174272 07:40:46 INFO - PROCESS | 24429 | 07:43:48 INFO - PROCESS | 24429 | Cycle 1(1): loaded http://localhost:47235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47235/tests/dromaeo/cssquery-prototype.html) 07:43:49 INFO - PROCESS | 24429 | RSS: Main: 244224000 07:43:49 INFO - PROCESS | 24429 | 07:46:52 INFO - PROCESS | 24429 | Cycle 1(1): loaded http://localhost:47235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47235/tests/dromaeo/cssquery-yui.html) 07:46:53 INFO - PROCESS | 24429 | RSS: Main: 214831104 07:46:53 INFO - PROCESS | 24429 | 07:49:56 INFO - PROCESS | 24429 | Cycle 1(1): loaded http://localhost:47235/tests/dromaeo/cssquery-yui.html (next: http://localhost:47235/tests/dromaeo/cssquery-dojo.html) 07:49:56 INFO - PROCESS | 24429 | RSS: Main: 306343936 07:49:56 INFO - PROCESS | 24429 | 07:49:56 INFO - PROCESS | 24429 | __start_tp_report 07:49:56 INFO - PROCESS | 24429 | _x_x_mozilla_page_load 07:49:56 INFO - PROCESS | 24429 | _x_x_mozilla_page_load_details 07:49:56 INFO - PROCESS | 24429 | |i|pagename|runs| 07:49:56 INFO - PROCESS | 24429 | |0;dojo.html;2571.7042540107886;2577.600471926852;2590.417156139868;2606.1790535981163;2608.673915760529;4543.522930092342;4615.515370886059;4702.5532574405415;4707.223308154154;4738.123447162273;4595.379623750792;4595.862124136282;4658.836940707076;4731.172044892147;4738.407699037621;4182.728122672024;4213.831446742127;4254.149170165963;4278.529361770218;4412.073464572443;4344.761038142901;4372.453443319585;4381.671374646899;4404.2512772828695;4424.269995450747;4247.851325203634;4256.829726810924;4308.375285583604;4311.78441077948;4340.522542520336;4282.143571285756;4297.849575264882;4304.569543045671;4367.301231802896;4369.781510924441;4316.115196384765;4320.567943205686;4327.653787696977;4366.541513141138;4369.4319738434115;4592.586667199968;4721.173794585934;4734.83428080019;4735.124002059595;4780.067886762083;4914.557689807899;4970.353853998957;4973.278874563168;5043.167877300241;5044.47033061527;5008.348914641073;5024.045431368028;5056.747162641853;5064.544191022789;5068.391792984866;4626.051659409813;4659.720416775004;4698.036902434993;4739.952600473951;4750.881227969328;5163.432022477525;5183.2743415921805;5190.506901844319;5213.165893457104;5236;4973;5012.799488020439;5015.04714104319;5020;5027.949720502821;4859.878503037452;4972.0801651694555;5012.498750124958;5051.570616497639;5108.055009823194;4963.851084467472;4987.5760560352055;4989.401271847401;4993.400791904995;5011.123053465629;4972.055309491185;4979.701217926936;4982.526659967298;4982.825601103944;5020.723860187724;4086.6526345260986;4122.9381559276635;4148.56440073794;4211.810468528863;4242.342436922282;3647.0335361129323;3661.707063434919;3689.631036896289;3712.535933008374;3716.108134047809;4324.589164029412;4327.697061205686;4328.718633288826;4334.32817913224;4372.256716358163;4919.385076865392;4976.5023497649945;4995.300657907896;5050.646454748133;5094.18493041119;4334.739915605074;4338.240807858612;4338.891527711769;4357.694961352675;4374.147041326974;4489.753063581535;4492.618127459137;4499.505054444008;4506.076254367847;4539.273716205391;4367.781610919505;4595.287730401793;4672.48602653701;4718.764061796828;4771.95228047715;5039.3448851649055;5046.571041461517;5055.393352797688;5059.898802024012;5114;4733.219018861849;4738.07607516531;4738.905221895474;4746.4541577719;4792.664513484023;4821.5178482152905;4921.581665558468;4952.331435256195;4987.725675087905;5006.249062640633;5032.295478632921;5047.4952504749235;5052.520010598987;5068.695878247317;5121.948780512147;4765.928511072268;4920.778564964514;4927.581155601814;4938.43208031081;4987.426445958616;4773.403324584427;4808.567228949411;4816.301636262792;4819.325294458708;4844.103840789465;4774.30772537987;4782.808687652455;4791.281307803857;4825.758712064453;4837;4784.234522476387;4863.3434486343895;4877.804887804448;4884.267359895902;4914.287428322945;4698.177818881751;4725.834595789131;4735.313379560013;4756.881077973078;4783.976080119716 07:49:56 INFO - PROCESS | 24429 | |1;ext.html;581.0586849304127;581.5870731780436;589.6167491130767;590.5216774412725;600.2167171840749;27305.180844574646;40308.19383612326;41104.58895411045;41157.38263926043;45860.77069614656;41425;41819.163616727645;41858.16283674325;41912.58087419125;41971.37042944351;7847.882281765764;7985.720499782508;7988.880166797474;7992.640331185111;7992.680292788282;7673.2326767323375;7883.487573307717;7899.881501777478;7922.9603851980655;7937;7953.323967462744;7996.24035716606;7998.800029999238;7999.160088190743;8001.919980800205;7896.960515197416;7935.960320198362;7948.205179482064;7951.483153594998;7960.960195199016;7871;7932.563708996003;7932.881006784903;7940.483868548584;7941.285284324381;39258.41112383317;39552.60447395547;39659.8017009916;39746.801265993774;39805.60194398048;2985;3097.1482842218343;3113.6730643282353;3146.276356438032;3203.807771533692;29710.85144574263;29881;30220.546691799642;30250.54624180639;30539.847300763355;3627.8548858045647;3641.9453708194396;3653.5250417445827;3664.9633503665154;3665.083729067733;186287;186360;186951;187131;187291;52817.2077418839;53517;53826;53841.73079134579;53857.1921421179;33846.32307353839;34791.4781278281;34891.65108348884;36613.26773464516;56731.149032764544;14193;14373.353199106064;14378.28108594566;14394.928025359806;14403;11440.485178167002;11639.825402618968;11645.825312620149;11649.068074554016;11650.359230242419;18907.24371025171;19029.809701902803;19041.904790475957;19057.428277151706;19080.618387632447;6709.496787740842;6774.424173945171;6776.9322306777285;6899.793006209822;6974.653065710281;834.2200042959852;839.6809212499334;880.7842078690762;919.3059240273551;971.3783178765595;27718.307042324104;28883.42233155325;28929;29284;29394;921.8386782313069;964.4599024546277;976.9804603907882;984.0405604535521;1087.0542627913765;14952;15149.621259468602;15368.923155384375;15526.767098493532;15630.296636651377;367908;368402;369634;370044;372799;49983.25025124626;50516.49483505118;50571;50595.74702126466;50678.69231115323;1040.7346126737634;1096.3257596578046;1123.7078359626555;1172.6423440850451;1206.481213078367;27767.583486247317;28284.434311313245;30180.5472917902;30986.380272394876;31136.377272454876;43514.782426087666;44151.558484414745;44338.55661443473;44346.334804977305;44379.33430998602;327118;332135;332631;333085;333693;38714.6128538711;39718.60281397149;40505;40581.59418405778;40720.79639601783;43738.56261437472;43979;44101.55898441103;44122.33816492691;44183.33724994192;36826;37605.9232003676;37795;37817.24365512729;38739;36880.81559592185;37155.442668360534;37575.43636845504;37674.43488347622;37776.81111594424;36446.817765911;36798.44802327914;36957.44563831491;37108;37114.814425927696;33836.3232735339;33909.66090339164;33988;34340;34688.653113469554;25776.484470310865;25893.870530647226;25950.740492594832;26157.476850462503;26444.86777566177 07:49:56 INFO - PROCESS | 24429 | |2;jquery.html;346.9791812491249;368.90777305673583;370.753448956444;373.9663430291273;389.4586524730625;12977.351132443375;16679.749803752937;16773.412930547434;17331.48005559832;17711.55721106973;16654.1672916354;17115;17160.141992900368;17249.91375043126;17295.13524323785;4380.299152135659;4899.706017638944;5323.760430780605;5336.6531175473665;5339.305890234265;5229.08491014071;5245.239440281157;5269.920951185735;5274.789008439677;5276.762545685453;5008.348914641091;5231.215317702337;5279.313689220396;5286.3392075990505;5393.892122157555;5252.474752524755;5323.920141197885;5326.573874090063;5329.360476742777;5362.088444964365;5195.714235717034;5203.713795741232;5228.346456692913;5242.501962313574;5242.5281724644965;12764.680882977907;12768.106232563725;12796.48814047437;12811.807822882663;13073.215607063512;1836.8438682711985;2051.548659294953;2284.565932472825;2378.63131214662;2416.7321405483767;9036.186743193144;9358;10253.641122560675;10613.46932653372;13869.237191954438;1744.8167942365997;1752.6932786762393;1761.0754353964144;1816.6275913437714;1820.7268909663524;66220.6688966552;66588.33411665919;66711.66644166797;67607;68507.65746171286;8733.912660873437;9203.493807840632;9397.201237894718;9607.13535781769;9833.901660983442;12628.242305461517;13363.465461381631;13374.06381553282;13915.930420347833;13951.95360347978;6984;7293.452991025694;7307.415406767446;7347.963260183665;7468.066491688539;6598.439132673777;6632.734690612418;6725.966370168216;6808.08090907731;6832.487563432763;4343.391925130484;4363.716358436692;4371.038371558252;4400.317950717644;4441.222786012435;1770.5750619851142;1802.765640466731;1808.2857271377995;1839.7148441991512;1842.2446796813242;821.3716506872247;835.8035861572525;848.868425394065;862.4178679391512;916.3677062826629;16757.245923933453;17443.040632765067;17531;17730.379436719653;18002.729959050626;861.4529773593688;863.3352318714554;882.4837470080075;883.7304622090325;903.9728808135767;9337.813243735087;9838;9846.507674616241;9862.309638325392;10002.649907253357;356260;357699;384370;385141;385249;80145;88162;88388.11611883799;89374;89994;914.9039350868196;938.3947353956796;958.2860768727203;958.3195930889008;958.6453012385462;15216;15994.520164395086;16012.439564615182;16045.438409655606;16625.251863665922;35065.824670876485;39294.607053929096;39308.6069139305;40838;41365.37951930783;50141.74929125331;54204.457955421516;54222.18666719923;54342;54683.45316546943;7107.005019297199;7244.673989670372;7297.63511824396;7307.086614173229;7568.091828980558;9922.603095876084;10623;10986.121110311316;11257.155713321697;11339.09287257034;9889.25830562725;9924.206063514757;10104.343217690826;10176.694699159038;10271.07560319545;9857.950710246403;9868.555914983699;9965.950170249102;9976.50117494137;9982.650607228712;9808.607655693977;9891.208703303862;10168.694939151837;10215.642452514126;10249.282550221413;7211.8557628848175;7228.89156662661;7391.260873912781;7434.1450733166375;7638.15980242184;7507.962460187664;9029.729108126767;10016.848062472909;10175.084242418217;10399.792004160026 07:49:56 INFO - PROCESS | 24429 | |3;mootools.html;1239.4236679943824;1360.9659758506036;1414.6675531250155;1485.6657252118275;1693.9237734301955;6775.1531058617675;7531.9623401883055;7828.921710782891;7837.451378403507;8066.2337077977645;7740.767776966686;7890.802729931755;7901.841963160748;7903.723369682062;7932.841343173148;1829.5729331121747;1900.3253844885073;1900.334882791019;2201.4606421426693;2236.3402796175087;1938.1375287996777;2161.416417567256;2235.0836157175563;2236.0720301075035;2258.0177622734163;2207.5915955548194;2219.2676416782424;2227.866328020316;2230.620794464937;2237.910483580663;1838.8069252728537;2203.603351396748;2208.436848603612;2209.3371988403414;2212.8008479236946;2119.279444988711;2180.9781902180935;2182.672599110146;2206.1396055538353;2208.9668654970187;7963.800904977364;8011.8798218026195;8014;8023.839523209562;8026.879596806052;4530.161920044802;4653.953460465385;4663.790129444184;4676.438827340707;4682.906341873178;2788.7211278872155;2843.289177705574;2904.8402337871407;2920.094770621114;2921.8246905185756;903.8327909336793;925.8009527951456;944.4994153098869;949.4635530925005;950.4344914775697;10706.357618542834;10720.195985301134;10783;10797.892021079846;10809.405482698448;4086.8160932758096;4087.89780255496;4309.095090031128;4312.37470566766;4322.935155972663;9098.226650734761;9105;9116.772080698036;9123.589438475285;9136.040715724886;4720.669553131316;4725.621950243973;4731.148393289241;4736.478987311393;4737.976310118427;3624.1120925373452;3646.106703857572;4332.458442694663;4336.284513055373;4340.565943405697;3658.817059147032;3714.888553343404;3810.5617853946596;3813.485179500732;3818.198178382571;1180.2682336951145;1198.1972078707288;1199.5261871560685;1214.5384753793503;1227.1716591300835;577.1717585265158;593.1725243285592;649.162580271454;663.9535232533676;692.1417442371524;4937.975310123426;5075.416327122428;5085.084684756705;5122.282880396748;5197.272381866542;416.08046217858873;419.8908283846161;424.4439783883061;424.980875860587;430.10967297693475;3422.845971931219;3463.89608311746;3502.9124271892897;3511.5083888255663;3692.2430901665093;9247.537623118817;9639.036096390304;9724.222062235005;9739.172170365599;9744.366616170068;9632.75918102053;9645.180159686504;9667.46828924416;9671.516424178904;9674.467904265333;7160.319769621878;7191.460640451987;7225.855482890208;7263.527870688388;7269.164046134762;5166.586673066221;5237.711925844115;5241.423443421144;5242.213667949685;5327.227552005015;8949.060348663557;8959.552022398724;8993.595288212176;9039.954800225956;9076.364654474388;7947.642356093874;9120.407173533698;9239.491827949527;9263.120003599648;9368.718938431857;6295.653739044396;6457.773977910751;6461.386168314003;6575.506836987341;6590.077389165616;7410.555366678017;7470.738524151629;7479.6634151464405;7484.550926944401;7545.245475452411;6919.238883722887;6931.445484361138;6982.581045137308;7016.1580610325045;7021.227664956953;6698.7320507179165;6714.496412768965;6772.492063095386;6847.657617119224;6855.588664679935;5917.970410147922;5940.910886336622;5942.7920022799;5974.342822289632;5981.252343457068;4138.193052354762;4180.247555439928;4219;4274.935875961925;4297.505786834554;4073.1242782800655;4133.0700592366475;4165.021220013234;4204.600562946515;4332.956670433256 07:49:56 INFO - PROCESS | 24429 | |4;prototype.html;297.70824591899935;299.5656298367368;306.6749245799452;308.7884798912746;310.53109804195657;4774.832880849167;4811.8075276988875;4820.5420485053955;4849.563539281473;4851.781669824857;4759.738214398207;4777.450593181785;4787.6169906407495;4825.276208568716;4837.201861692816;3543.964560354396;3656.451532270154;3664.7068234541307;3679.4848721179055;3694.5935947045805;3670.4861319415168;3693.5198424204814;3757.66181043706;3812.5234345706785;3816.656500914917;3720.572134204574;3737.140457694732;3752.437134429844;3769;3778.6977041836585;3554.413521768905;3728.7203459740626;3761.3793724035777;3764.85172022533;3786.56454507731;3258.527513510551;3272.149241197282;3272.887218345774;3278.9016329510155;3293.5389045533643;4669.813207471697;4683.414573178353;4695.534844206784;4702.153612349775;4729.652049166006;4053.5135783706146;4207.347861081537;4211.831526738927;4222.451081359434;4251.213525497762;4929.852104436873;4939.407271127452;4945.332380128709;4972.179590367585;4995.625328100407;3527.3298073365977;3532.7527073104893;3534.452159915217;3544.3974524330924;3545.556805399325;5146.794128234867;5198.6880787152895;5211.42674305826;5265.736713164365;5272.92090618641;3621.6378362163573;3649.7627654202392;3652.543432070991;3654.2045335318503;3671.541057367829;3717.1636381814415;3722.16251343451;3724.031751744566;3734.3672710738865;3735.9813200933822;4241.321388577874;4247.617714405718;4248.9787551062045;4249.235137675187;4274.252005898955;4873.707577545359;4973.776180071905;4991.875203119878;4993.126202914548;5008.248762685626;1269.2130878855169;1279.5457612547411;1284.910056296069;1286.3118231746157;1288.7229245712217;794.7377365469381;808.6441965535146;822.6750433578703;823.5223570329315;823.5758584329076;4257.595528424795;4383.912321753547;4384.114830622799;4388.956110438919;4394.758288294174;5087.23691446286;5133.25567792668;5141.794328226903;5147.2279158126585;5170.45710200431;4372.562743725665;4384.276594361958;4385.956140438619;4412.404325416028;4417.094495628388;2578.303857958341;2714.538528450168;2718.945621087607;2722.4010717642086;2725.441284536665;4799.928001079987;4803.1114243864995;4823.831165909247;4825.179719447702;4827.310441345501;4987.750612469435;5207.869803254949;5209.661372010807;5225.242339860699;5229.137192363293;4781.760911954389;4791.95208047922;4794.784234709517;4824.372831531949;4829.830955916526;5076.771545280398;5078.238264260391;5112.718800465861;5112.747376892685;5119.385673719177;4761.452432970253;4993.126202914548;5010.49895010496;5019.447860735243;5020.698758074527;4812.326274321667;4826.806927722992;4827.806887724451;4828;4850.951490485191;3548.201654627688;3561.2343346180696;3608.476770868262;3619.5475565554307;3620.149264922794;5038.380042377869;5128.974355128201;5137.717425541631;5144.588432925432;5186.818461353985;4928.433230178575;4953.479884612064;4970.478099799614;4973.030259099585;4973.577245933991;4938.48145944685;4951.801927922843;4974.950250497449;4996;5001.849574597935;4763.879658823476;4904.209963363418;4904.485029072039;4922.606191504743;4953.7523123844385;4802.807887684454;4883.267509873547;5009.924851127309;5022.623303252344;5031.84904452867;4897;4904.313396124474;4920.966597014667;4928.67963582366;4965.28003439492 07:49:56 INFO - PROCESS | 24429 | |5;yui.html;622.1942584353259;644.4296797334364;669.3373560175427;711.8398360368915;742.5841528743904;12484.375781210938;12876.549320773775;13453.394597243123;13496.190228586293;13509.392077356506;13125.93437032816;13270;13271.402786874589;13271.800922986164;13300;620.1906512001835;758.1546575568229;758.302361827119;781.527176058485;785.9214078592123;789.0728394136895;794.4637369775407;797.1072398913225;799.8800179973022;799.9480033797813;836.3643630840575;838.3837879158843;839.0728245288959;839.1356902390547;839.5046922315832;651.46905272203;662.569329935541;662.6156829039146;665.3047565294279;838.4633834345993;590.3093380744539;595.380803963877;596.2606368103563;601.9939800601982;602.8523011862078;13257;13286.667833304147;13294;13300.600981970556;13323.733525329537;12662.303573303465;13097.607071787861;13143.474261029547;13162.07865449419;13677.658058548517;9500.144986951207;9798.069183427635;10145;10591.417472039035;10663.253572249945;3284.5894263217097;3311.7516186285884;3392.0502259367418;3441.6214216436174;3478.513008178857;64358;66571.334286657;66971;67304;67429.66285168592;10149.797004059878;10438.321509101885;10638.680839574825;10676.733081673021;10811.40537270442;17366.65266694659;17763.33549967515;17852;19023.61952760937;19042;6983.441324694012;7107.969344445027;7121.323474269936;7135.357817796424;7392.223816499298;3694.2796154750104;3788.6021967693546;3824.2542704172974;3828.4065969774174;3882.495275614152;2921.897733579357;3034.7723920705594;3037.05851186133;3040.619922509686;3041.1788817019283;526.0268503268921;526.739264064283;535.3762866260763;540.1384791257938;540.6404740847371;515.6957395136812;569.7208367899699;614.5882258886556;631.1731631562668;634.1925512290029;7751.534907905431;7894.921050789533;8000.839983200303;8006;8100.756977290691;540.9377921538995;554.6228564576046;567.7104676614956;570.4780126184495;606.887725770725;3562.3231585999097;3658.725595580342;3704.697186456852;3895.474110995036;3967;71722.64138679273;88368;96049.5197524008;98455.50772246237;100409;52021.2196817048;70251;81402.59298703469;82297;82839.17160828314;75711.62144189244;77073.6146319276;77145.91416343396;77962.22037779664;78628.70970322475;7399.59302238382;7607.201243869314;7640.044994375703;7660.5403675779635;8195.877061843958;32653;43737;43900.804959752524;44099.559004409544;45309.546904530536;64375.67812160909;64386;66086;66675;67514.66242668756;11952.82929716479;11979.921807037408;12319.75360492803;12483.375831208221;12840.42218100169;12638;12767.361631918553;12912.16070955385;13215.074944753775;13807.79288310656;11211.439428028729;11466.140039497239;11530.250533715282;11971.221870578385;11996.040316774812;12269;12287.262764234174;12589.24464532131;12806.423710933217;12868.734511151955;10686.839697404701;10980.615678451215;11071.50178241965;11400.315981041163;11403.087752979907;10462.895371046192;10567.154627629618;10680.412577308323;10713.89286107129;10762.40806755636;9313.516778390645;9315.534223288943;9777.315587908779;9872.01284358822;9907.207423405966 07:49:56 INFO - PROCESS | 24429 | __end_tp_report 07:49:56 INFO - PROCESS | 24429 | __start_cc_report 07:49:56 INFO - PROCESS | 24429 | _x_x_mozilla_cycle_collect,1059 07:49:56 INFO - PROCESS | 24429 | __end_cc_report 07:49:56 INFO - PROCESS | 24429 | __startTimestamp1467902996483__endTimestamp 07:49:56 INFO - PROCESS | 24429 | 07:49:56 INFO - PROCESS | 24429 | ------- Summary: start ------- 07:49:56 INFO - PROCESS | 24429 | Number of tests: 6 07:49:56 INFO - PROCESS | 24429 | 07:49:56 INFO - PROCESS | 24429 | [#0] dojo.html Cycles:165 Average:4629.33 Median:4739.95 stddev:494.53 (10.4%) stddev-sans-first:468.96 07:49:56 INFO - PROCESS | 24429 | Values: 2571.7 2577.6 2590.4 2606.2 2608.7 4543.5 4615.5 4702.6 4707.2 4738.1 4595.4 4595.9 4658.8 4731.2 4738.4 4182.7 4213.8 4254.1 4278.5 4412.1 4344.8 4372.5 4381.7 4404.3 4424.3 4247.9 4256.8 4308.4 4311.8 4340.5 4282.1 4297.8 4304.6 4367.3 4369.8 4316.1 4320.6 4327.7 4366.5 4369.4 4592.6 4721.2 4734.8 4735.1 4780.1 4914.6 4970.4 4973.3 5043.2 5044.5 5008.3 5024.0 5056.7 5064.5 5068.4 4626.1 4659.7 4698.0 4740.0 4750.9 5163.4 5183.3 5190.5 5213.2 5236.0 4973.0 5012.8 5015.0 5020.0 5027.9 4859.9 4972.1 5012.5 5051.6 5108.1 4963.9 4987.6 4989.4 4993.4 5011.1 4972.1 4979.7 4982.5 4982.8 5020.7 4086.7 4122.9 4148.6 4211.8 4242.3 3647.0 3661.7 3689.6 3712.5 3716.1 4324.6 4327.7 4328.7 4334.3 4372.3 4919.4 4976.5 4995.3 5050.6 5094.2 4334.7 4338.2 4338.9 4357.7 4374.1 4489.8 4492.6 4499.5 4506.1 4539.3 4367.8 4595.3 4672.5 4718.8 4772.0 5039.3 5046.6 5055.4 5059.9 5114.0 4733.2 4738.1 4738.9 4746.5 4792.7 4821.5 4921.6 4952.3 4987.7 5006.2 5032.3 5047.5 5052.5 5068.7 5121.9 4765.9 4920.8 4927.6 4938.4 4987.4 4773.4 4808.6 4816.3 4819.3 4844.1 4774.3 4782.8 4791.3 4825.8 4837.0 4784.2 4863.3 4877.8 4884.3 4914.3 4698.2 4725.8 4735.3 4756.9 4784.0 07:49:56 INFO - PROCESS | 24429 | 07:49:56 INFO - PROCESS | 24429 | [#1] ext.html Cycles:180 Average:46070.05 Median:37640.18 stddev:80616.32 (214.2%) stddev-sans-first:80770.12 07:49:56 INFO - PROCESS | 24429 | Values: 581.1 581.6 589.6 590.5 600.2 27305.2 40308.2 41104.6 41157.4 45860.8 41425.0 41819.2 41858.2 41912.6 41971.4 7847.9 7985.7 7988.9 7992.6 7992.7 7673.2 7883.5 7899.9 7923.0 7937.0 7953.3 7996.2 7998.8 7999.2 8001.9 7897.0 7936.0 7948.2 7951.5 7961.0 7871.0 7932.6 7932.9 7940.5 7941.3 39258.4 39552.6 39659.8 39746.8 39805.6 2985.0 3097.1 3113.7 3146.3 3203.8 29710.9 29881.0 30220.5 30250.5 30539.8 3627.9 3641.9 3653.5 3665.0 3665.1 186287.0 186360.0 186951.0 187131.0 187291.0 52817.2 53517.0 53826.0 53841.7 53857.2 33846.3 34791.5 34891.7 36613.3 56731.1 14193.0 14373.4 14378.3 14394.9 14403.0 11440.5 11639.8 11645.8 11649.1 11650.4 18907.2 19029.8 19041.9 19057.4 19080.6 6709.5 6774.4 6776.9 6899.8 6974.7 834.2 839.7 880.8 919.3 971.4 27718.3 28883.4 28929.0 29284.0 29394.0 921.8 964.5 977.0 984.0 1087.1 14952.0 15149.6 15368.9 15526.8 15630.3 367908.0 368402.0 369634.0 370044.0 372799.0 49983.3 50516.5 50571.0 50595.7 50678.7 1040.7 1096.3 1123.7 1172.6 1206.5 27767.6 28284.4 30180.5 30986.4 31136.4 43514.8 44151.6 44338.6 44346.3 44379.3 327118.0 332135.0 332631.0 333085.0 333693.0 38714.6 39718.6 40505.0 40581.6 40720.8 43738.6 43979.0 44101.6 44122.3 44183.3 36826.0 37605.9 37795.0 37817.2 38739.0 36880.8 37155.4 37575.4 37674.4 37776.8 36446.8 36798.4 36957.4 37108.0 37114.8 33836.3 33909.7 33988.0 34340.0 34688.7 25776.5 25893.9 25950.7 26157.5 26444.9 07:49:56 INFO - PROCESS | 24429 | 07:49:56 INFO - PROCESS | 24429 | [#2] jquery.html Cycles:180 Average:23944.75 Median:5236.86 stddev:62180.10 (1187.4%) stddev-sans-first:62329.29 07:49:56 INFO - PROCESS | 24429 | Values: 347.0 368.9 370.8 374.0 389.5 12977.4 16679.7 16773.4 17331.5 17711.6 16654.2 17115.0 17160.1 17249.9 17295.1 4380.3 4899.7 5323.8 5336.7 5339.3 5229.1 5245.2 5269.9 5274.8 5276.8 5008.3 5231.2 5279.3 5286.3 5393.9 5252.5 5323.9 5326.6 5329.4 5362.1 5195.7 5203.7 5228.3 5242.5 5242.5 12764.7 12768.1 12796.5 12811.8 13073.2 1836.8 2051.5 2284.6 2378.6 2416.7 9036.2 9358.0 10253.6 10613.5 13869.2 1744.8 1752.7 1761.1 1816.6 1820.7 66220.7 66588.3 66711.7 67607.0 68507.7 8733.9 9203.5 9397.2 9607.1 9833.9 12628.2 13363.5 13374.1 13915.9 13952.0 6984.0 7293.5 7307.4 7348.0 7468.1 6598.4 6632.7 6726.0 6808.1 6832.5 4343.4 4363.7 4371.0 4400.3 4441.2 1770.6 1802.8 1808.3 1839.7 1842.2 821.4 835.8 848.9 862.4 916.4 16757.2 17443.0 17531.0 17730.4 18002.7 861.5 863.3 882.5 883.7 904.0 9337.8 9838.0 9846.5 9862.3 10002.6 356260.0 357699.0 384370.0 385141.0 385249.0 80145.0 88162.0 88388.1 89374.0 89994.0 914.9 938.4 958.3 958.3 958.6 15216.0 15994.5 16012.4 16045.4 16625.3 35065.8 39294.6 39308.6 40838.0 41365.4 50141.7 54204.5 54222.2 54342.0 54683.5 7107.0 7244.7 7297.6 7307.1 7568.1 9922.6 10623.0 10986.1 11257.2 11339.1 9889.3 9924.2 10104.3 10176.7 10271.1 9858.0 9868.6 9966.0 9976.5 9982.7 9808.6 9891.2 10168.7 10215.6 10249.3 7211.9 7228.9 7391.3 7434.1 7638.2 7508.0 9029.7 10016.8 10175.1 10399.8 07:49:56 INFO - PROCESS | 24429 | 07:49:56 INFO - PROCESS | 24429 | [#3] mootools.html Cycles:180 Average:5094.76 Median:5006.70 stddev:2926.70 (58.5%) stddev-sans-first:2920.56 07:49:56 INFO - PROCESS | 24429 | Values: 1239.4 1361.0 1414.7 1485.7 1693.9 6775.2 7532.0 7828.9 7837.5 8066.2 7740.8 7890.8 7901.8 7903.7 7932.8 1829.6 1900.3 1900.3 2201.5 2236.3 1938.1 2161.4 2235.1 2236.1 2258.0 2207.6 2219.3 2227.9 2230.6 2237.9 1838.8 2203.6 2208.4 2209.3 2212.8 2119.3 2181.0 2182.7 2206.1 2209.0 7963.8 8011.9 8014.0 8023.8 8026.9 4530.2 4654.0 4663.8 4676.4 4682.9 2788.7 2843.3 2904.8 2920.1 2921.8 903.8 925.8 944.5 949.5 950.4 10706.4 10720.2 10783.0 10797.9 10809.4 4086.8 4087.9 4309.1 4312.4 4322.9 9098.2 9105.0 9116.8 9123.6 9136.0 4720.7 4725.6 4731.1 4736.5 4738.0 3624.1 3646.1 4332.5 4336.3 4340.6 3658.8 3714.9 3810.6 3813.5 3818.2 1180.3 1198.2 1199.5 1214.5 1227.2 577.2 593.2 649.2 664.0 692.1 4938.0 5075.4 5085.1 5122.3 5197.3 416.1 419.9 424.4 425.0 430.1 3422.8 3463.9 3502.9 3511.5 3692.2 9247.5 9639.0 9724.2 9739.2 9744.4 9632.8 9645.2 9667.5 9671.5 9674.5 7160.3 7191.5 7225.9 7263.5 7269.2 5166.6 5237.7 5241.4 5242.2 5327.2 8949.1 8959.6 8993.6 9040.0 9076.4 7947.6 9120.4 9239.5 9263.1 9368.7 6295.7 6457.8 6461.4 6575.5 6590.1 7410.6 7470.7 7479.7 7484.6 7545.2 6919.2 6931.4 6982.6 7016.2 7021.2 6698.7 6714.5 6772.5 6847.7 6855.6 5918.0 5940.9 5942.8 5974.3 5981.3 4138.2 4180.2 4219.0 4274.9 4297.5 4073.1 4133.1 4165.0 4204.6 4333.0 07:49:56 INFO - PROCESS | 24429 | 07:49:56 INFO - PROCESS | 24429 | [#4] prototype.html Cycles:180 Average:4140.01 Median:4784.69 stddev:1201.73 (25.1%) stddev-sans-first:1169.99 07:49:56 INFO - PROCESS | 24429 | Values: 297.7 299.6 306.7 308.8 310.5 4774.8 4811.8 4820.5 4849.6 4851.8 4759.7 4777.5 4787.6 4825.3 4837.2 3544.0 3656.5 3664.7 3679.5 3694.6 3670.5 3693.5 3757.7 3812.5 3816.7 3720.6 3737.1 3752.4 3769.0 3778.7 3554.4 3728.7 3761.4 3764.9 3786.6 3258.5 3272.1 3272.9 3278.9 3293.5 4669.8 4683.4 4695.5 4702.2 4729.7 4053.5 4207.3 4211.8 4222.5 4251.2 4929.9 4939.4 4945.3 4972.2 4995.6 3527.3 3532.8 3534.5 3544.4 3545.6 5146.8 5198.7 5211.4 5265.7 5272.9 3621.6 3649.8 3652.5 3654.2 3671.5 3717.2 3722.2 3724.0 3734.4 3736.0 4241.3 4247.6 4249.0 4249.2 4274.3 4873.7 4973.8 4991.9 4993.1 5008.2 1269.2 1279.5 1284.9 1286.3 1288.7 794.7 808.6 822.7 823.5 823.6 4257.6 4383.9 4384.1 4389.0 4394.8 5087.2 5133.3 5141.8 5147.2 5170.5 4372.6 4384.3 4386.0 4412.4 4417.1 2578.3 2714.5 2718.9 2722.4 2725.4 4799.9 4803.1 4823.8 4825.2 4827.3 4987.8 5207.9 5209.7 5225.2 5229.1 4781.8 4792.0 4794.8 4824.4 4829.8 5076.8 5078.2 5112.7 5112.7 5119.4 4761.5 4993.1 5010.5 5019.4 5020.7 4812.3 4826.8 4827.8 4828.0 4851.0 3548.2 3561.2 3608.5 3619.5 3620.1 5038.4 5129.0 5137.7 5144.6 5186.8 4928.4 4953.5 4970.5 4973.0 4973.6 4938.5 4951.8 4975.0 4996.0 5001.8 4763.9 4904.2 4904.5 4922.6 4953.8 4802.8 4883.3 5009.9 5022.6 5031.8 4897.0 4904.3 4921.0 4928.7 4965.3 07:49:56 INFO - PROCESS | 24429 | 07:49:56 INFO - PROCESS | 24429 | [#5] yui.html Cycles:180 Average:17551.43 Median:26273.62 stddev:24685.82 (94.0%) stddev-sans-first:24722.34 07:49:56 INFO - PROCESS | 24429 | Values: 622.2 644.4 669.3 711.8 742.6 12484.4 12876.5 13453.4 13496.2 13509.4 13125.9 13270.0 13271.4 13271.8 13300.0 620.2 758.2 758.3 781.5 785.9 789.1 794.5 797.1 799.9 799.9 836.4 838.4 839.1 839.1 839.5 651.5 662.6 662.6 665.3 838.5 590.3 595.4 596.3 602.0 602.9 13257.0 13286.7 13294.0 13300.6 13323.7 12662.3 13097.6 13143.5 13162.1 13677.7 9500.1 9798.1 10145.0 10591.4 10663.3 3284.6 3311.8 3392.1 3441.6 3478.5 64358.0 66571.3 66971.0 67304.0 67429.7 10149.8 10438.3 10638.7 10676.7 10811.4 17366.7 17763.3 17852.0 19023.6 19042.0 6983.4 7108.0 7121.3 7135.4 7392.2 3694.3 3788.6 3824.3 3828.4 3882.5 2921.9 3034.8 3037.1 3040.6 3041.2 526.0 526.7 535.4 540.1 540.6 515.7 569.7 614.6 631.2 634.2 7751.5 7894.9 8000.8 8006.0 8100.8 540.9 554.6 567.7 570.5 606.9 3562.3 3658.7 3704.7 3895.5 3967.0 71722.6 88368.0 96049.5 98455.5 100409.0 52021.2 70251.0 81402.6 82297.0 82839.2 75711.6 77073.6 77145.9 77962.2 78628.7 7399.6 7607.2 7640.0 7660.5 8195.9 32653.0 43737.0 43900.8 44099.6 45309.5 64375.7 64386.0 66086.0 66675.0 67514.7 11952.8 11979.9 12319.8 12483.4 12840.4 12638.0 12767.4 12912.2 13215.1 13807.8 11211.4 11466.1 11530.3 11971.2 11996.0 12269.0 12287.3 12589.2 12806.4 12868.7 10686.8 10980.6 11071.5 11400.3 11403.1 10462.9 10567.2 10680.4 10713.9 10762.4 9313.5 9315.5 9777.3 9872.0 9907.2 07:49:56 INFO - PROCESS | 24429 | -------- Summary: end -------- 07:49:56 INFO - PROCESS | 24429 | 07:49:57 INFO - TEST-INFO | 24429: exit 0 07:49:57 INFO - TEST-OK | dromaeo_css | took 1120589ms 07:49:57 INFO - TEST-START | kraken 07:49:57 INFO - operating with platform_type : linux_ 07:49:57 INFO - Initialising browser for kraken test... 07:49:57 INFO - TEST-INFO | started process 24651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn3aArV/profile http://localhost:47235/getInfo.html) 07:50:01 INFO - PROCESS | 24651 | __metrics Screen width/height:1600/1200 07:50:01 INFO - PROCESS | 24651 | colorDepth:24 07:50:01 INFO - PROCESS | 24651 | Browser inner width/height: 1024/697 07:50:01 INFO - PROCESS | 24651 | __metrics 07:50:02 INFO - PROCESS | 24651 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:50:03 INFO - TEST-INFO | 24651: exit 0 07:50:03 INFO - Browser initialized. 07:50:03 INFO - Running cycle 1/1 for kraken test... 07:50:03 INFO - TEST-INFO | started process 24734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn3aArV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:15 INFO - PROCESS | 24734 | RSS: Main: 158789632 07:50:15 INFO - PROCESS | 24734 | 07:50:18 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47235/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:19 INFO - PROCESS | 24734 | RSS: Main: 216301568 07:50:19 INFO - PROCESS | 24734 | 07:50:21 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47235/tests/kraken/driver.html?testName=audio-dft) 07:50:22 INFO - PROCESS | 24734 | RSS: Main: 203419648 07:50:22 INFO - PROCESS | 24734 | 07:50:25 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47235/tests/kraken/driver.html?testName=audio-fft) 07:50:26 INFO - PROCESS | 24734 | RSS: Main: 271642624 07:50:26 INFO - PROCESS | 24734 | 07:50:28 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47235/tests/kraken/driver.html?testName=audio-oscillator) 07:50:28 INFO - PROCESS | 24734 | RSS: Main: 181448704 07:50:28 INFO - PROCESS | 24734 | 07:50:31 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:50:31 INFO - PROCESS | 24734 | RSS: Main: 186007552 07:50:31 INFO - PROCESS | 24734 | 07:50:34 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47235/tests/kraken/driver.html?testName=imaging-darkroom) 07:50:35 INFO - PROCESS | 24734 | RSS: Main: 221728768 07:50:35 INFO - PROCESS | 24734 | 07:50:39 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47235/tests/kraken/driver.html?testName=imaging-desaturate) 07:50:39 INFO - PROCESS | 24734 | RSS: Main: 217309184 07:50:39 INFO - PROCESS | 24734 | 07:50:42 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47235/tests/kraken/driver.html?testName=json-parse-financial) 07:50:43 INFO - PROCESS | 24734 | RSS: Main: 220520448 07:50:43 INFO - PROCESS | 24734 | 07:50:44 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:50:45 INFO - PROCESS | 24734 | RSS: Main: 205381632 07:50:45 INFO - PROCESS | 24734 | 07:50:47 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47235/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:50:48 INFO - PROCESS | 24734 | RSS: Main: 210550784 07:50:48 INFO - PROCESS | 24734 | 07:50:50 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:50:50 INFO - PROCESS | 24734 | RSS: Main: 214523904 07:50:50 INFO - PROCESS | 24734 | 07:50:53 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:50:54 INFO - PROCESS | 24734 | RSS: Main: 230797312 07:50:54 INFO - PROCESS | 24734 | 07:50:57 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:50:57 INFO - PROCESS | 24734 | RSS: Main: 225648640 07:50:57 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | Cycle 1(1): loaded http://localhost:47235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47235/tests/kraken/driver.html?testName=ai-astar) 07:50:59 INFO - PROCESS | 24734 | RSS: Main: 267567104 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | __start_tp_report 07:50:59 INFO - PROCESS | 24734 | _x_x_mozilla_page_load 07:50:59 INFO - PROCESS | 24734 | _x_x_mozilla_page_load_details 07:50:59 INFO - PROCESS | 24734 | |i|pagename|runs| 07:50:59 INFO - PROCESS | 24734 | |0;ai-astar;104;114;114;113;113;113;113;113;113;112 07:50:59 INFO - PROCESS | 24734 | |1;audio-beat-detection;164;122;127;179;123;127;145;121;155;128 07:50:59 INFO - PROCESS | 24734 | |2;audio-dft;161;162;163;163;161;163;161;162;160;160 07:50:59 INFO - PROCESS | 24734 | |3;audio-fft;75;76;76;135;77;76;75;78;98;76 07:50:59 INFO - PROCESS | 24734 | |4;audio-oscillator;86;86;126;84;85;86;123;86;86;123 07:50:59 INFO - PROCESS | 24734 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 07:50:59 INFO - PROCESS | 24734 | |6;imaging-darkroom;147;148;147;147;146;147;146;147;146;147 07:50:59 INFO - PROCESS | 24734 | |7;imaging-desaturate;95;95;94;96;95;95;96;94;94;95 07:50:59 INFO - PROCESS | 24734 | |8;json-parse-financial;65;64;64;65;63;65;65;66;64;65 07:50:59 INFO - PROCESS | 24734 | |9;json-stringify-tinderbox;65;65;64;64;64;64;66;64;65;64 07:50:59 INFO - PROCESS | 24734 | |10;stanford-crypto-aes;86;89;88;78;79;88;82;80;79;79 07:50:59 INFO - PROCESS | 24734 | |11;stanford-crypto-ccm;128;132;137;125;125;128;129;130;177;136 07:50:59 INFO - PROCESS | 24734 | |12;stanford-crypto-pbkdf2;165;164;162;163;165;167;170;165;162;165 07:50:59 INFO - PROCESS | 24734 | |13;stanford-crypto-sha256-iterative;72;66;68;67;67;66;70;66;66;66 07:50:59 INFO - PROCESS | 24734 | __end_tp_report 07:50:59 INFO - PROCESS | 24734 | __start_cc_report 07:50:59 INFO - PROCESS | 24734 | _x_x_mozilla_cycle_collect,1910 07:50:59 INFO - PROCESS | 24734 | __end_cc_report 07:50:59 INFO - PROCESS | 24734 | __startTimestamp1467903059748__endTimestamp 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | ------- Summary: start ------- 07:50:59 INFO - PROCESS | 24734 | Number of tests: 14 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.60 07:50:59 INFO - PROCESS | 24734 | Values: 104.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:136.50 stddev:20.53 (15.0%) stddev-sans-first:19.70 07:50:59 INFO - PROCESS | 24734 | Values: 164.0 122.0 127.0 179.0 123.0 127.0 145.0 121.0 155.0 128.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 07:50:59 INFO - PROCESS | 24734 | Values: 161.0 162.0 163.0 163.0 161.0 163.0 161.0 162.0 160.0 160.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:19.15 (25.2%) stddev-sans-first:20.02 07:50:59 INFO - PROCESS | 24734 | Values: 75.0 76.0 76.0 135.0 77.0 76.0 75.0 78.0 98.0 76.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:86.00 stddev:18.59 (21.6%) stddev-sans-first:19.28 07:50:59 INFO - PROCESS | 24734 | Values: 86.0 86.0 126.0 84.0 85.0 86.0 123.0 86.0 86.0 123.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:50:59 INFO - PROCESS | 24734 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:50:59 INFO - PROCESS | 24734 | Values: 147.0 148.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 07:50:59 INFO - PROCESS | 24734 | Values: 95.0 95.0 94.0 96.0 95.0 95.0 96.0 94.0 94.0 95.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 07:50:59 INFO - PROCESS | 24734 | Values: 65.0 64.0 64.0 65.0 63.0 65.0 65.0 66.0 64.0 65.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 07:50:59 INFO - PROCESS | 24734 | Values: 65.0 65.0 64.0 64.0 64.0 64.0 66.0 64.0 65.0 64.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:84.00 stddev:4.44 (5.3%) stddev-sans-first:4.56 07:50:59 INFO - PROCESS | 24734 | Values: 86.0 89.0 88.0 78.0 79.0 88.0 82.0 80.0 79.0 79.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:131.00 stddev:15.41 (11.8%) stddev-sans-first:16.15 07:50:59 INFO - PROCESS | 24734 | Values: 128.0 132.0 137.0 125.0 125.0 128.0 129.0 130.0 177.0 136.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.00 stddev:2.39 (1.5%) stddev-sans-first:2.54 07:50:59 INFO - PROCESS | 24734 | Values: 165.0 164.0 162.0 163.0 165.0 167.0 170.0 165.0 162.0 165.0 07:50:59 INFO - PROCESS | 24734 | 07:50:59 INFO - PROCESS | 24734 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:2.07 (3.1%) stddev-sans-first:1.36 07:50:59 INFO - PROCESS | 24734 | Values: 72.0 66.0 68.0 67.0 67.0 66.0 70.0 66.0 66.0 66.0 07:50:59 INFO - PROCESS | 24734 | -------- Summary: end -------- 07:50:59 INFO - PROCESS | 24734 | 07:51:00 INFO - TEST-INFO | 24734: exit 0 07:51:00 INFO - TEST-OK | kraken | took 63577ms 07:51:00 INFO - SUITE-END | took 1184s 07:51:00 INFO - Completed test suite (00:19:44) 07:51:00 INFO - javascript benchmark 07:51:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.7042540107886, 2577.600471926852, 2590.417156139868, 2606.1790535981163, 2608.673915760529, 4543.522930092342, 4615.515370886059, 4702.5532574405415, 4707.223308154154, 4738.123447162273, 4595.379623750792, 4595.862124136282, 4658.836940707076, 4731.172044892147, 4738.407699037621, 4182.728122672024, 4213.831446742127, 4254.149170165963, 4278.529361770218, 4412.073464572443, 4344.761038142901, 4372.453443319585, 4381.671374646899, 4404.2512772828695, 4424.269995450747, 4247.851325203634, 4256.829726810924, 4308.375285583604, 4311.78441077948, 4340.522542520336, 4282.143571285756, 4297.849575264882, 4304.569543045671, 4367.301231802896, 4369.781510924441, 4316.115196384765, 4320.567943205686, 4327.653787696977, 4366.541513141138, 4369.4319738434115, 4592.586667199968, 4721.173794585934, 4734.83428080019, 4735.124002059595, 4780.067886762083, 4914.557689807899, 4970.353853998957, 4973.278874563168, 5043.167877300241, 5044.47033061527, 5008.348914641073, 5024.045431368028, 5056.747162641853, 5064.544191022789, 5068.391792984866, 4626.051659409813, 4659.720416775004, 4698.036902434993, 4739.952600473951, 4750.881227969328, 5163.432022477525, 5183.2743415921805, 5190.506901844319, 5213.165893457104, 5236.0, 4973.0, 5012.799488020439, 5015.04714104319, 5020.0, 5027.949720502821, 4859.878503037452, 4972.0801651694555, 5012.498750124958, 5051.570616497639, 5108.055009823194, 4963.851084467472, 4987.5760560352055, 4989.401271847401, 4993.400791904995, 5011.123053465629, 4972.055309491185, 4979.701217926936, 4982.526659967298, 4982.825601103944, 5020.723860187724, 4086.6526345260986, 4122.9381559276635, 4148.56440073794, 4211.810468528863, 4242.342436922282, 3647.0335361129323, 3661.707063434919, 3689.631036896289, 3712.535933008374, 3716.108134047809, 4324.589164029412, 4327.697061205686, 4328.718633288826, 4334.32817913224, 4372.256716358163, 4919.385076865392, 4976.5023497649945, 4995.300657907896, 5050.646454748133, 5094.18493041119, 4334.739915605074, 4338.240807858612, 4338.891527711769, 4357.694961352675, 4374.147041326974, 4489.753063581535, 4492.618127459137, 4499.505054444008, 4506.076254367847, 4539.273716205391, 4367.781610919505, 4595.287730401793, 4672.48602653701, 4718.764061796828, 4771.95228047715, 5039.3448851649055, 5046.571041461517, 5055.393352797688, 5059.898802024012, 5114.0, 4733.219018861849, 4738.07607516531, 4738.905221895474, 4746.4541577719, 4792.664513484023, 4821.5178482152905, 4921.581665558468, 4952.331435256195, 4987.725675087905, 5006.249062640633, 5032.295478632921, 5047.4952504749235, 5052.520010598987, 5068.695878247317, 5121.948780512147, 4765.928511072268, 4920.778564964514, 4927.581155601814, 4938.43208031081, 4987.426445958616, 4773.403324584427, 4808.567228949411, 4816.301636262792, 4819.325294458708, 4844.103840789465, 4774.30772537987, 4782.808687652455, 4791.281307803857, 4825.758712064453, 4837.0, 4784.234522476387, 4863.3434486343895, 4877.804887804448, 4884.267359895902, 4914.287428322945, 4698.177818881751, 4725.834595789131, 4735.313379560013, 4756.881077973078, 4783.976080119716], "value": 4597.1490367386605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.0586849304127, 581.5870731780436, 589.6167491130767, 590.5216774412725, 600.2167171840749, 27305.180844574646, 40308.19383612326, 41104.58895411045, 41157.38263926043, 45860.77069614656, 41425.0, 41819.163616727645, 41858.16283674325, 41912.58087419125, 41971.37042944351, 7847.882281765764, 7985.720499782508, 7988.880166797474, 7992.640331185111, 7992.680292788282, 7673.2326767323375, 7883.487573307717, 7899.881501777478, 7922.9603851980655, 7937.0, 7953.323967462744, 7996.24035716606, 7998.800029999238, 7999.160088190743, 8001.919980800205, 7896.960515197416, 7935.960320198362, 7948.205179482064, 7951.483153594998, 7960.960195199016, 7871.0, 7932.563708996003, 7932.881006784903, 7940.483868548584, 7941.285284324381, 39258.41112383317, 39552.60447395547, 39659.8017009916, 39746.801265993774, 39805.60194398048, 2985.0, 3097.1482842218343, 3113.6730643282353, 3146.276356438032, 3203.807771533692, 29710.85144574263, 29881.0, 30220.546691799642, 30250.54624180639, 30539.847300763355, 3627.8548858045647, 3641.9453708194396, 3653.5250417445827, 3664.9633503665154, 3665.083729067733, 186287.0, 186360.0, 186951.0, 187131.0, 187291.0, 52817.2077418839, 53517.0, 53826.0, 53841.73079134579, 53857.1921421179, 33846.32307353839, 34791.4781278281, 34891.65108348884, 36613.26773464516, 56731.149032764544, 14193.0, 14373.353199106064, 14378.28108594566, 14394.928025359806, 14403.0, 11440.485178167002, 11639.825402618968, 11645.825312620149, 11649.068074554016, 11650.359230242419, 18907.24371025171, 19029.809701902803, 19041.904790475957, 19057.428277151706, 19080.618387632447, 6709.496787740842, 6774.424173945171, 6776.9322306777285, 6899.793006209822, 6974.653065710281, 834.2200042959852, 839.6809212499334, 880.7842078690762, 919.3059240273551, 971.3783178765595, 27718.307042324104, 28883.42233155325, 28929.0, 29284.0, 29394.0, 921.8386782313069, 964.4599024546277, 976.9804603907882, 984.0405604535521, 1087.0542627913765, 14952.0, 15149.621259468602, 15368.923155384375, 15526.767098493532, 15630.296636651377, 367908.0, 368402.0, 369634.0, 370044.0, 372799.0, 49983.25025124626, 50516.49483505118, 50571.0, 50595.74702126466, 50678.69231115323, 1040.7346126737634, 1096.3257596578046, 1123.7078359626555, 1172.6423440850451, 1206.481213078367, 27767.583486247317, 28284.434311313245, 30180.5472917902, 30986.380272394876, 31136.377272454876, 43514.782426087666, 44151.558484414745, 44338.55661443473, 44346.334804977305, 44379.33430998602, 327118.0, 332135.0, 332631.0, 333085.0, 333693.0, 38714.6128538711, 39718.60281397149, 40505.0, 40581.59418405778, 40720.79639601783, 43738.56261437472, 43979.0, 44101.55898441103, 44122.33816492691, 44183.33724994192, 36826.0, 37605.9232003676, 37795.0, 37817.24365512729, 38739.0, 36880.81559592185, 37155.442668360534, 37575.43636845504, 37674.43488347622, 37776.81111594424, 36446.817765911, 36798.44802327914, 36957.44563831491, 37108.0, 37114.814425927696, 33836.3232735339, 33909.66090339164, 33988.0, 34340.0, 34688.653113469554, 25776.484470310865, 25893.870530647226, 25950.740492594832, 26157.476850462503, 26444.86777566177], "value": 17791.78609980094, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9791812491249, 368.90777305673583, 370.753448956444, 373.9663430291273, 389.4586524730625, 12977.351132443375, 16679.749803752937, 16773.412930547434, 17331.48005559832, 17711.55721106973, 16654.1672916354, 17115.0, 17160.141992900368, 17249.91375043126, 17295.13524323785, 4380.299152135659, 4899.706017638944, 5323.760430780605, 5336.6531175473665, 5339.305890234265, 5229.08491014071, 5245.239440281157, 5269.920951185735, 5274.789008439677, 5276.762545685453, 5008.348914641091, 5231.215317702337, 5279.313689220396, 5286.3392075990505, 5393.892122157555, 5252.474752524755, 5323.920141197885, 5326.573874090063, 5329.360476742777, 5362.088444964365, 5195.714235717034, 5203.713795741232, 5228.346456692913, 5242.501962313574, 5242.5281724644965, 12764.680882977907, 12768.106232563725, 12796.48814047437, 12811.807822882663, 13073.215607063512, 1836.8438682711985, 2051.548659294953, 2284.565932472825, 2378.63131214662, 2416.7321405483767, 9036.186743193144, 9358.0, 10253.641122560675, 10613.46932653372, 13869.237191954438, 1744.8167942365997, 1752.6932786762393, 1761.0754353964144, 1816.6275913437714, 1820.7268909663524, 66220.6688966552, 66588.33411665919, 66711.66644166797, 67607.0, 68507.65746171286, 8733.912660873437, 9203.493807840632, 9397.201237894718, 9607.13535781769, 9833.901660983442, 12628.242305461517, 13363.465461381631, 13374.06381553282, 13915.930420347833, 13951.95360347978, 6984.0, 7293.452991025694, 7307.415406767446, 7347.963260183665, 7468.066491688539, 6598.439132673777, 6632.734690612418, 6725.966370168216, 6808.08090907731, 6832.487563432763, 4343.391925130484, 4363.716358436692, 4371.038371558252, 4400.317950717644, 4441.222786012435, 1770.5750619851142, 1802.765640466731, 1808.2857271377995, 1839.7148441991512, 1842.2446796813242, 821.3716506872247, 835.8035861572525, 848.868425394065, 862.4178679391512, 916.3677062826629, 16757.245923933453, 17443.040632765067, 17531.0, 17730.379436719653, 18002.729959050626, 861.4529773593688, 863.3352318714554, 882.4837470080075, 883.7304622090325, 903.9728808135767, 9337.813243735087, 9838.0, 9846.507674616241, 9862.309638325392, 10002.649907253357, 356260.0, 357699.0, 384370.0, 385141.0, 385249.0, 80145.0, 88162.0, 88388.11611883799, 89374.0, 89994.0, 914.9039350868196, 938.3947353956796, 958.2860768727203, 958.3195930889008, 958.6453012385462, 15216.0, 15994.520164395086, 16012.439564615182, 16045.438409655606, 16625.251863665922, 35065.824670876485, 39294.607053929096, 39308.6069139305, 40838.0, 41365.37951930783, 50141.74929125331, 54204.457955421516, 54222.18666719923, 54342.0, 54683.45316546943, 7107.005019297199, 7244.673989670372, 7297.63511824396, 7307.086614173229, 7568.091828980558, 9922.603095876084, 10623.0, 10986.121110311316, 11257.155713321697, 11339.09287257034, 9889.25830562725, 9924.206063514757, 10104.343217690826, 10176.694699159038, 10271.07560319545, 9857.950710246403, 9868.555914983699, 9965.950170249102, 9976.50117494137, 9982.650607228712, 9808.607655693977, 9891.208703303862, 10168.694939151837, 10215.642452514126, 10249.282550221413, 7211.8557628848175, 7228.89156662661, 7391.260873912781, 7434.1450733166375, 7638.15980242184, 7507.962460187664, 9029.729108126767, 10016.848062472909, 10175.084242418217, 10399.792004160026], "value": 8104.289124433958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1239.4236679943824, 1360.9659758506036, 1414.6675531250155, 1485.6657252118275, 1693.9237734301955, 6775.1531058617675, 7531.9623401883055, 7828.921710782891, 7837.451378403507, 8066.2337077977645, 7740.767776966686, 7890.802729931755, 7901.841963160748, 7903.723369682062, 7932.841343173148, 1829.5729331121747, 1900.3253844885073, 1900.334882791019, 2201.4606421426693, 2236.3402796175087, 1938.1375287996777, 2161.416417567256, 2235.0836157175563, 2236.0720301075035, 2258.0177622734163, 2207.5915955548194, 2219.2676416782424, 2227.866328020316, 2230.620794464937, 2237.910483580663, 1838.8069252728537, 2203.603351396748, 2208.436848603612, 2209.3371988403414, 2212.8008479236946, 2119.279444988711, 2180.9781902180935, 2182.672599110146, 2206.1396055538353, 2208.9668654970187, 7963.800904977364, 8011.8798218026195, 8014.0, 8023.839523209562, 8026.879596806052, 4530.161920044802, 4653.953460465385, 4663.790129444184, 4676.438827340707, 4682.906341873178, 2788.7211278872155, 2843.289177705574, 2904.8402337871407, 2920.094770621114, 2921.8246905185756, 903.8327909336793, 925.8009527951456, 944.4994153098869, 949.4635530925005, 950.4344914775697, 10706.357618542834, 10720.195985301134, 10783.0, 10797.892021079846, 10809.405482698448, 4086.8160932758096, 4087.89780255496, 4309.095090031128, 4312.37470566766, 4322.935155972663, 9098.226650734761, 9105.0, 9116.772080698036, 9123.589438475285, 9136.040715724886, 4720.669553131316, 4725.621950243973, 4731.148393289241, 4736.478987311393, 4737.976310118427, 3624.1120925373452, 3646.106703857572, 4332.458442694663, 4336.284513055373, 4340.565943405697, 3658.817059147032, 3714.888553343404, 3810.5617853946596, 3813.485179500732, 3818.198178382571, 1180.2682336951145, 1198.1972078707288, 1199.5261871560685, 1214.5384753793503, 1227.1716591300835, 577.1717585265158, 593.1725243285592, 649.162580271454, 663.9535232533676, 692.1417442371524, 4937.975310123426, 5075.416327122428, 5085.084684756705, 5122.282880396748, 5197.272381866542, 416.08046217858873, 419.8908283846161, 424.4439783883061, 424.980875860587, 430.10967297693475, 3422.845971931219, 3463.89608311746, 3502.9124271892897, 3511.5083888255663, 3692.2430901665093, 9247.537623118817, 9639.036096390304, 9724.222062235005, 9739.172170365599, 9744.366616170068, 9632.75918102053, 9645.180159686504, 9667.46828924416, 9671.516424178904, 9674.467904265333, 7160.319769621878, 7191.460640451987, 7225.855482890208, 7263.527870688388, 7269.164046134762, 5166.586673066221, 5237.711925844115, 5241.423443421144, 5242.213667949685, 5327.227552005015, 8949.060348663557, 8959.552022398724, 8993.595288212176, 9039.954800225956, 9076.364654474388, 7947.642356093874, 9120.407173533698, 9239.491827949527, 9263.120003599648, 9368.718938431857, 6295.653739044396, 6457.773977910751, 6461.386168314003, 6575.506836987341, 6590.077389165616, 7410.555366678017, 7470.738524151629, 7479.6634151464405, 7484.550926944401, 7545.245475452411, 6919.238883722887, 6931.445484361138, 6982.581045137308, 7016.1580610325045, 7021.227664956953, 6698.7320507179165, 6714.496412768965, 6772.492063095386, 6847.657617119224, 6855.588664679935, 5917.970410147922, 5940.910886336622, 5942.7920022799, 5974.342822289632, 5981.252343457068, 4138.193052354762, 4180.247555439928, 4219.0, 4274.935875961925, 4297.505786834554, 4073.1242782800655, 4133.0700592366475, 4165.021220013234, 4204.600562946515, 4332.956670433256], "value": 3997.810665999231, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.70824591899935, 299.5656298367368, 306.6749245799452, 308.7884798912746, 310.53109804195657, 4774.832880849167, 4811.8075276988875, 4820.5420485053955, 4849.563539281473, 4851.781669824857, 4759.738214398207, 4777.450593181785, 4787.6169906407495, 4825.276208568716, 4837.201861692816, 3543.964560354396, 3656.451532270154, 3664.7068234541307, 3679.4848721179055, 3694.5935947045805, 3670.4861319415168, 3693.5198424204814, 3757.66181043706, 3812.5234345706785, 3816.656500914917, 3720.572134204574, 3737.140457694732, 3752.437134429844, 3769.0, 3778.6977041836585, 3554.413521768905, 3728.7203459740626, 3761.3793724035777, 3764.85172022533, 3786.56454507731, 3258.527513510551, 3272.149241197282, 3272.887218345774, 3278.9016329510155, 3293.5389045533643, 4669.813207471697, 4683.414573178353, 4695.534844206784, 4702.153612349775, 4729.652049166006, 4053.5135783706146, 4207.347861081537, 4211.831526738927, 4222.451081359434, 4251.213525497762, 4929.852104436873, 4939.407271127452, 4945.332380128709, 4972.179590367585, 4995.625328100407, 3527.3298073365977, 3532.7527073104893, 3534.452159915217, 3544.3974524330924, 3545.556805399325, 5146.794128234867, 5198.6880787152895, 5211.42674305826, 5265.736713164365, 5272.92090618641, 3621.6378362163573, 3649.7627654202392, 3652.543432070991, 3654.2045335318503, 3671.541057367829, 3717.1636381814415, 3722.16251343451, 3724.031751744566, 3734.3672710738865, 3735.9813200933822, 4241.321388577874, 4247.617714405718, 4248.9787551062045, 4249.235137675187, 4274.252005898955, 4873.707577545359, 4973.776180071905, 4991.875203119878, 4993.126202914548, 5008.248762685626, 1269.2130878855169, 1279.5457612547411, 1284.910056296069, 1286.3118231746157, 1288.7229245712217, 794.7377365469381, 808.6441965535146, 822.6750433578703, 823.5223570329315, 823.5758584329076, 4257.595528424795, 4383.912321753547, 4384.114830622799, 4388.956110438919, 4394.758288294174, 5087.23691446286, 5133.25567792668, 5141.794328226903, 5147.2279158126585, 5170.45710200431, 4372.562743725665, 4384.276594361958, 4385.956140438619, 4412.404325416028, 4417.094495628388, 2578.303857958341, 2714.538528450168, 2718.945621087607, 2722.4010717642086, 2725.441284536665, 4799.928001079987, 4803.1114243864995, 4823.831165909247, 4825.179719447702, 4827.310441345501, 4987.750612469435, 5207.869803254949, 5209.661372010807, 5225.242339860699, 5229.137192363293, 4781.760911954389, 4791.95208047922, 4794.784234709517, 4824.372831531949, 4829.830955916526, 5076.771545280398, 5078.238264260391, 5112.718800465861, 5112.747376892685, 5119.385673719177, 4761.452432970253, 4993.126202914548, 5010.49895010496, 5019.447860735243, 5020.698758074527, 4812.326274321667, 4826.806927722992, 4827.806887724451, 4828.0, 4850.951490485191, 3548.201654627688, 3561.2343346180696, 3608.476770868262, 3619.5475565554307, 3620.149264922794, 5038.380042377869, 5128.974355128201, 5137.717425541631, 5144.588432925432, 5186.818461353985, 4928.433230178575, 4953.479884612064, 4970.478099799614, 4973.030259099585, 4973.577245933991, 4938.48145944685, 4951.801927922843, 4974.950250497449, 4996.0, 5001.849574597935, 4763.879658823476, 4904.209963363418, 4904.485029072039, 4922.606191504743, 4953.7523123844385, 4802.807887684454, 4883.267509873547, 5009.924851127309, 5022.623303252344, 5031.84904452867, 4897.0, 4904.313396124474, 4920.966597014667, 4928.67963582366, 4965.28003439492], "value": 3758.264198401875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.1942584353259, 644.4296797334364, 669.3373560175427, 711.8398360368915, 742.5841528743904, 12484.375781210938, 12876.549320773775, 13453.394597243123, 13496.190228586293, 13509.392077356506, 13125.93437032816, 13270.0, 13271.402786874589, 13271.800922986164, 13300.0, 620.1906512001835, 758.1546575568229, 758.302361827119, 781.527176058485, 785.9214078592123, 789.0728394136895, 794.4637369775407, 797.1072398913225, 799.8800179973022, 799.9480033797813, 836.3643630840575, 838.3837879158843, 839.0728245288959, 839.1356902390547, 839.5046922315832, 651.46905272203, 662.569329935541, 662.6156829039146, 665.3047565294279, 838.4633834345993, 590.3093380744539, 595.380803963877, 596.2606368103563, 601.9939800601982, 602.8523011862078, 13257.0, 13286.667833304147, 13294.0, 13300.600981970556, 13323.733525329537, 12662.303573303465, 13097.607071787861, 13143.474261029547, 13162.07865449419, 13677.658058548517, 9500.144986951207, 9798.069183427635, 10145.0, 10591.417472039035, 10663.253572249945, 3284.5894263217097, 3311.7516186285884, 3392.0502259367418, 3441.6214216436174, 3478.513008178857, 64358.0, 66571.334286657, 66971.0, 67304.0, 67429.66285168592, 10149.797004059878, 10438.321509101885, 10638.680839574825, 10676.733081673021, 10811.40537270442, 17366.65266694659, 17763.33549967515, 17852.0, 19023.61952760937, 19042.0, 6983.441324694012, 7107.969344445027, 7121.323474269936, 7135.357817796424, 7392.223816499298, 3694.2796154750104, 3788.6021967693546, 3824.2542704172974, 3828.4065969774174, 3882.495275614152, 2921.897733579357, 3034.7723920705594, 3037.05851186133, 3040.619922509686, 3041.1788817019283, 526.0268503268921, 526.739264064283, 535.3762866260763, 540.1384791257938, 540.6404740847371, 515.6957395136812, 569.7208367899699, 614.5882258886556, 631.1731631562668, 634.1925512290029, 7751.534907905431, 7894.921050789533, 8000.839983200303, 8006.0, 8100.756977290691, 540.9377921538995, 554.6228564576046, 567.7104676614956, 570.4780126184495, 606.887725770725, 3562.3231585999097, 3658.725595580342, 3704.697186456852, 3895.474110995036, 3967.0, 71722.64138679273, 88368.0, 96049.5197524008, 98455.50772246237, 100409.0, 52021.2196817048, 70251.0, 81402.59298703469, 82297.0, 82839.17160828314, 75711.62144189244, 77073.6146319276, 77145.91416343396, 77962.22037779664, 78628.70970322475, 7399.59302238382, 7607.201243869314, 7640.044994375703, 7660.5403675779635, 8195.877061843958, 32653.0, 43737.0, 43900.804959752524, 44099.559004409544, 45309.546904530536, 64375.67812160909, 64386.0, 66086.0, 66675.0, 67514.66242668756, 11952.82929716479, 11979.921807037408, 12319.75360492803, 12483.375831208221, 12840.42218100169, 12638.0, 12767.361631918553, 12912.16070955385, 13215.074944753775, 13807.79288310656, 11211.439428028729, 11466.140039497239, 11530.250533715282, 11971.221870578385, 11996.040316774812, 12269.0, 12287.262764234174, 12589.24464532131, 12806.423710933217, 12868.734511151955, 10686.839697404701, 10980.615678451215, 11071.50178241965, 11400.315981041163, 11403.087752979907, 10462.895371046192, 10567.154627629618, 10680.412577308323, 10713.89286107129, 10762.40806755636, 9313.516778390645, 9315.534223288943, 9777.315587908779, 9872.01284358822, 9907.207423405966], "value": 6551.807502641157, "unit": "score"}], "name": "dromaeo_css", "value": 6345.1368856633435, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 122.0, 127.0, 179.0, 123.0, 127.0, 145.0, 121.0, 155.0, 128.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 163.0, 161.0, 163.0, 161.0, 162.0, 160.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 135.0, 77.0, 76.0, 75.0, 78.0, 98.0, 76.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 126.0, 84.0, 85.0, 86.0, 123.0, 86.0, 86.0, 123.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 96.0, 94.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 63.0, 65.0, 65.0, 66.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 64.0, 66.0, 64.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 88.0, 78.0, 79.0, 88.0, 82.0, 80.0, 79.0, 79.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 132.0, 137.0, 125.0, 125.0, 128.0, 129.0, 130.0, 177.0, 136.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 162.0, 163.0, 165.0, 167.0, 170.0, 165.0, 162.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 66.0, 68.0, 67.0, 67.0, 66.0, 70.0, 66.0, 66.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1531.6, "alertThreshold": 2.0}]} 07:51:00 INFO - Return code: 0 07:51:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:51:01 INFO - # TBPL SUCCESS # 07:51:01 INFO - Running post-action listener: _resource_record_post_action 07:51:01 INFO - ##### 07:51:01 INFO - ##### Finished run-tests step (success) 07:51:01 INFO - ##### 07:51:01 INFO - Running post-run listener: _resource_record_post_run 07:51:01 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 2727936; Write bytes: 536248320; Read time: 1052; Write time: 770976 07:51:01 INFO - TinderboxPrint: CPU usage
13.0% 07:51:01 INFO - TinderboxPrint: I/O read bytes / time
2,727,936 / 1,052 07:51:01 INFO - TinderboxPrint: I/O write bytes / time
536,248,320 / 770,976 07:51:01 INFO - TinderboxPrint: CPU idle
8,340.2 (87.0%) 07:51:01 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 07:51:01 INFO - TinderboxPrint: Swap in / out
0 / 0 07:51:01 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 246517760; Read time: 0; Write time: 412648 07:51:01 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 2723840; Write bytes: 289542144; Read time: 1040; Write time: 358280 07:51:01 INFO - Running post-run listener: _upload_blobber_files 07:51:01 INFO - Blob upload gear active. 07:51:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:51:01 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 07:51:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:51:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:51:02 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:51:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:51:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:05 INFO - (blobuploader) - INFO - Done attempting. 07:51:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:51:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:51:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:06 INFO - (blobuploader) - INFO - Done attempting. 07:51:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:51:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:51:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:06 INFO - (blobuploader) - INFO - Done attempting. 07:51:06 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:06 INFO - Return code: 0 07:51:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:51:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/349e414b0879952287a14b17e0848c4069bdd7f3af41b03df2b8f3d89ce102cab3025f6a5343c5defa57a6cd0788fa9376ecdfd8a8147cc895d46f36a597ae92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/962b935e91263fa55b2c3025f7dbba3c9b996002a3425806850f07e68b28905a95a114d1e6c60d6280ce75c94f5e96eeab2af4d74cf0e0ac92df2fe2f29ad434", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/685dcc9bb60a3bb1e1a675a5770784d7301e045178cc0604a43e2d3de7179df1c65f7479cbd924deb5f29449a305bce1fd63f67c93fc881c5ee0d60f785db2fe"} 07:51:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:51:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:51:06 INFO - Contents: 07:51:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/349e414b0879952287a14b17e0848c4069bdd7f3af41b03df2b8f3d89ce102cab3025f6a5343c5defa57a6cd0788fa9376ecdfd8a8147cc895d46f36a597ae92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/962b935e91263fa55b2c3025f7dbba3c9b996002a3425806850f07e68b28905a95a114d1e6c60d6280ce75c94f5e96eeab2af4d74cf0e0ac92df2fe2f29ad434", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/685dcc9bb60a3bb1e1a675a5770784d7301e045178cc0604a43e2d3de7179df1c65f7479cbd924deb5f29449a305bce1fd63f67c93fc881c5ee0d60f785db2fe"} 07:51:06 INFO - Running post-run listener: copy_logs_to_upload_dir 07:51:06 INFO - Copying logs to upload dir... 07:51:06 INFO - mkdir: /builds/slave/test/build/upload/logs 07:51:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.797866 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-07 07:51:06.579102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 07:51:06.582962) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955 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-Non-PGO/sha512/349e414b0879952287a14b17e0848c4069bdd7f3af41b03df2b8f3d89ce102cab3025f6a5343c5defa57a6cd0788fa9376ecdfd8a8147cc895d46f36a597ae92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/962b935e91263fa55b2c3025f7dbba3c9b996002a3425806850f07e68b28905a95a114d1e6c60d6280ce75c94f5e96eeab2af4d74cf0e0ac92df2fe2f29ad434", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/685dcc9bb60a3bb1e1a675a5770784d7301e045178cc0604a43e2d3de7179df1c65f7479cbd924deb5f29449a305bce1fd63f67c93fc881c5ee0d60f785db2fe"} build_url:https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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-Non-PGO/sha512/349e414b0879952287a14b17e0848c4069bdd7f3af41b03df2b8f3d89ce102cab3025f6a5343c5defa57a6cd0788fa9376ecdfd8a8147cc895d46f36a597ae92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/962b935e91263fa55b2c3025f7dbba3c9b996002a3425806850f07e68b28905a95a114d1e6c60d6280ce75c94f5e96eeab2af4d74cf0e0ac92df2fe2f29ad434", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/685dcc9bb60a3bb1e1a675a5770784d7301e045178cc0604a43e2d3de7179df1c65f7479cbd924deb5f29449a305bce1fd63f67c93fc881c5ee0d60f785db2fe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 07:51:06.608638) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:51:06.608978) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467898745.179697-313737955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004757 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:51:06.694421) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 07:51:06.695153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 07:51:06.695882) ========= ========= Total master_lag: 0.23 =========