builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1467732874.89 results: success (0) buildid: 20160701143005 builduid: b3caa12a714e45b6986d80cb0953b536 revision: 3bde90c197be1b2f60db5c3d5127d69950ba3b2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:34.893208) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:34.893684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:34.893977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:34.908820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:34.909182) ========= 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=232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 08:34:36-- 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% 70.8M=0s 2016-07-05 08:34:36 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:35.060054) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:35.060380) ========= 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=232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015156 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:35.110081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 08:34:35.110451) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3bde90c197be1b2f60db5c3d5127d69950ba3b2f --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 3bde90c197be1b2f60db5c3d5127d69950ba3b2f --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=232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 08:34:36,831 truncating revision to first 12 chars 2016-07-05 08:34:36,831 Setting DEBUG logging. 2016-07-05 08:34:36,831 attempt 1/10 2016-07-05 08:34:36,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3bde90c197be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 08:34:37,813 unpacking tar archive at: fx-team-3bde90c197be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313016 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 08:34:36.437753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:36.438159) ========= script_repo_revision: 3bde90c197be1b2f60db5c3d5127d69950ba3b2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:36.438587) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:36.438852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:34:36.449942) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-05 08:34:36.450341) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:34:38 INFO - MultiFileLogger online at 20160705 08:34:38 in /builds/slave/test 08:34:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:34:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:38 INFO - {'append_to_log': False, 08:34:38 INFO - 'base_work_dir': '/builds/slave/test', 08:34:38 INFO - 'blob_upload_branch': 'Fx-Team', 08:34:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:38 INFO - 'branch': 'Fx-Team', 08:34:38 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:38 INFO - 'config_files': ('talos/linux_config.py',), 08:34:38 INFO - 'default_actions': ('clobber', 08:34:38 INFO - 'read-buildbot-config', 08:34:38 INFO - 'download-and-extract', 08:34:38 INFO - 'populate-webroot', 08:34:38 INFO - 'create-virtualenv', 08:34:38 INFO - 'install', 08:34:38 INFO - 'run-tests'), 08:34:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:38 INFO - 'download_minidump_stackwalk': True, 08:34:38 INFO - 'download_symbols': 'ondemand', 08:34:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:38 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:38 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:38 INFO - 'installer_path': 'installer.exe', 08:34:38 INFO - 'log_level': 'info', 08:34:38 INFO - 'log_name': 'talos', 08:34:38 INFO - 'log_to_console': True, 08:34:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:34:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:34:38 INFO - 'opt_config_files': (), 08:34:38 INFO - 'pip_index': False, 08:34:38 INFO - 'sps_profile': False, 08:34:38 INFO - 'sps_profile_interval': 0, 08:34:38 INFO - 'suite': 'dromaeojs-e10s', 08:34:38 INFO - 'system_bits': '32', 08:34:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:38 INFO - 'title': 'talos-linux64-ix-025', 08:34:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:38 INFO - 'use_talos_json': True, 08:34:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:38 INFO - 'work_dir': 'build'} 08:34:38 INFO - ##### 08:34:38 INFO - ##### Running clobber step. 08:34:38 INFO - ##### 08:34:38 INFO - Running pre-action listener: _resource_record_pre_action 08:34:38 INFO - Running main action method: clobber 08:34:38 INFO - rmtree: /builds/slave/test/build 08:34:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:38 INFO - Running post-action listener: _resource_record_post_action 08:34:38 INFO - ##### 08:34:38 INFO - ##### Finished clobber step (success) 08:34:38 INFO - ##### 08:34:38 INFO - ##### 08:34:38 INFO - ##### Running read-buildbot-config step. 08:34:38 INFO - ##### 08:34:38 INFO - Running pre-action listener: _resource_record_pre_action 08:34:38 INFO - Running main action method: read_buildbot_config 08:34:38 INFO - Using buildbot properties: 08:34:38 INFO - { 08:34:38 INFO - "project": "", 08:34:38 INFO - "product": "firefox", 08:34:38 INFO - "script_repo_revision": "production", 08:34:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:34:38 INFO - "repository": "", 08:34:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:34:38 INFO - "buildid": "20160701143005", 08:34:38 INFO - "pgo_build": "True", 08:34:38 INFO - "basedir": "/builds/slave/test", 08:34:38 INFO - "buildnumber": 886, 08:34:38 INFO - "slavename": "talos-linux64-ix-025", 08:34:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:34:38 INFO - "platform": "ubuntu64_hw", 08:34:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:34:38 INFO - "branch": "fx-team", 08:34:38 INFO - "repo_path": "integration/fx-team", 08:34:38 INFO - "revision": "3bde90c197be1b2f60db5c3d5127d69950ba3b2f", 08:34:38 INFO - "stage_platform": "linux64-pgo", 08:34:38 INFO - "builduid": "b3caa12a714e45b6986d80cb0953b536", 08:34:38 INFO - "slavebuilddir": "test" 08:34:38 INFO - } 08:34:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:34:38 INFO - Running post-action listener: _resource_record_post_action 08:34:38 INFO - ##### 08:34:38 INFO - ##### Finished read-buildbot-config step (success) 08:34:38 INFO - ##### 08:34:38 INFO - ##### 08:34:38 INFO - ##### Running download-and-extract step. 08:34:38 INFO - ##### 08:34:38 INFO - Running pre-action listener: _resource_record_pre_action 08:34:38 INFO - Running main action method: download_and_extract 08:34:38 INFO - mkdir: /builds/slave/test/build/tests 08:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:38 INFO - https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:34:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:34:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:34:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:39 INFO - Downloaded 1361 bytes. 08:34:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:34:39 INFO - Using the following test package requirements: 08:34:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:34:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:34:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:34:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:39 INFO - u'jsshell-linux-x86_64.zip'], 08:34:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:34:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:34:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:34:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:34:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:34:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:34:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:34: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')]} 08:34:39 INFO - https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:34:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:34:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:34:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:40 INFO - Downloaded 24271105 bytes. 08:34:40 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'] 08:34:40 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 08:34:41 INFO - Return code: 0 08:34:41 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 08:34:41 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')]} 08:34:41 INFO - https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:34:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:34:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:34:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:43 INFO - Downloaded 24271105 bytes. 08:34:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:34:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:34:44 INFO - Return code: 0 08:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:44 INFO - https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:34:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:45 INFO - Downloaded 14405242 bytes. 08:34:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:34:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:34:45 INFO - Return code: 0 08:34: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')]} 08:34:45 INFO - https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:34:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:34:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:34:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1QeAVmLRH2dauOKklu7uQ/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 08:34:47 INFO - Downloaded 60338634 bytes. 08:34:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:34:47 INFO - mkdir: /builds/slave/test/properties 08:34:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:34:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:34:47 INFO - Contents: 08:34:47 INFO - build_url:https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:34:48 INFO - Running post-action listener: _resource_record_post_action 08:34:48 INFO - Running post-action listener: set_extra_try_arguments 08:34:48 INFO - ##### 08:34:48 INFO - ##### Finished download-and-extract step (success) 08:34:48 INFO - ##### 08:34:48 INFO - ##### 08:34:48 INFO - ##### Running populate-webroot step. 08:34:48 INFO - ##### 08:34:48 INFO - Running pre-action listener: _resource_record_pre_action 08:34:48 INFO - Running main action method: populate_webroot 08:34:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:34:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:34:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:34:48 INFO - '--tppagecycles', 08:34:48 INFO - '7'], 08:34:48 INFO - 'tests': ['tsvgm']}}, 08:34:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:34:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:34:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:34:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:34:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:48 INFO - 'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:48 INFO - 'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['damp', 'tps']}, 08:34:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:48 INFO - 'tests': ['damp', 'tps']}, 08:34:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['dromaeo_dom']}, 08:34:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:34:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['basic_compositor_video']}, 08:34:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:34:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['a11yr', 08:34:48 INFO - 'ts_paint', 08:34:48 INFO - 'tpaint', 08:34:48 INFO - 'sessionrestore', 08:34:48 INFO - 'sessionrestore_no_auto_restore', 08:34:48 INFO - 'tabpaint']}, 08:34:48 INFO - 'other-e10s': {'tests': ['a11yr', 08:34:48 INFO - 'ts_paint', 08:34:48 INFO - 'tpaint', 08:34:48 INFO - 'sessionrestore', 08:34:48 INFO - 'sessionrestore_no_auto_restore', 08:34:48 INFO - 'tabpaint']}, 08:34:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:34:48 INFO - 'ts_paint', 08:34:48 INFO - 'tpaint', 08:34:48 INFO - 'sessionrestore', 08:34:48 INFO - 'sessionrestore_no_auto_restore', 08:34:48 INFO - 'tabpaint']}, 08:34:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:34:48 INFO - 'ts_paint', 08:34:48 INFO - 'tpaint', 08:34:48 INFO - 'sessionrestore', 08:34:48 INFO - 'sessionrestore_no_auto_restore', 08:34:48 INFO - 'tabpaint']}, 08:34:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['a11yr', 08:34:48 INFO - 'ts_paint', 08:34:48 INFO - 'tpaint', 08:34:48 INFO - 'sessionrestore', 08:34:48 INFO - 'sessionrestore_no_auto_restore', 08:34:48 INFO - 'tabpaint']}, 08:34:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['a11yr', 08:34:48 INFO - 'ts_paint', 08:34:48 INFO - 'tpaint', 08:34:48 INFO - 'sessionrestore', 08:34:48 INFO - 'sessionrestore_no_auto_restore', 08:34:48 INFO - 'tabpaint']}, 08:34:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['tsvgx', 08:34:48 INFO - 'tsvgr_opacity', 08:34:48 INFO - 'tart', 08:34:48 INFO - 'tscrollx', 08:34:48 INFO - 'cart']}, 08:34:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:34:48 INFO - 'tsvgr_opacity', 08:34:48 INFO - 'tart', 08:34:48 INFO - 'tscrollx', 08:34:48 INFO - 'cart']}, 08:34:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:48 INFO - 'talos_options': ['--disable-e10s'], 08:34:48 INFO - 'tests': ['tp5o']}, 08:34:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:48 INFO - 'tests': ['tp5o']}, 08:34:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:48 INFO - 'talos_options': ['--disable-e10s', 08:34:48 INFO - '--xperf_path', 08:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:48 INFO - 'tests': ['tp5n']}, 08:34:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:48 INFO - 'talos_options': ['--xperf_path', 08:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:48 INFO - 'tests': ['tp5n']}}, 08:34:48 INFO - 'talos.zip': {'path': '', 08:34:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:34:48 INFO - Running post-action listener: _resource_record_post_action 08:34:48 INFO - ##### 08:34:48 INFO - ##### Finished populate-webroot step (success) 08:34:48 INFO - ##### 08:34:48 INFO - ##### 08:34:48 INFO - ##### Running create-virtualenv step. 08:34:48 INFO - ##### 08:34:48 INFO - Running pre-action listener: _resource_record_pre_action 08:34:48 INFO - Running main action method: create_virtualenv 08:34:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:34:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:34:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:34:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:34:48 INFO - Using real prefix '/usr' 08:34:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:34:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:34:50 INFO - Installing pip.................done. 08:34:50 INFO - Return code: 0 08:34:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, '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': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', '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 08:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:34:50 INFO - Using env: {'DISPLAY': ':0', 08:34:50 INFO - 'HOME': '/home/cltbld', 08:34:50 INFO - 'LANG': 'en_US.UTF-8', 08:34:50 INFO - 'LANGUAGE': 'en_US:en', 08:34:50 INFO - 'LOGNAME': 'cltbld', 08:34:50 INFO - 'MAIL': '/var/mail/cltbld', 08:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:50 INFO - 'MOZ_NO_REMOTE': '1', 08:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:50 INFO - 'NO_EM_RESTART': '1', 08:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:50 INFO - 'PWD': '/builds/slave/test', 08:34:50 INFO - 'SHELL': '/bin/bash', 08:34:50 INFO - 'SHLVL': '1', 08:34:50 INFO - 'TERM': 'linux', 08:34:50 INFO - 'TMOUT': '86400', 08:34:50 INFO - 'USER': 'cltbld', 08:34:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:50 INFO - '_': '/tools/buildbot/bin/python'} 08:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:34:50 INFO - Cleaning up... 08:34:50 INFO - Return code: 0 08:34:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1703030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, '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': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', '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 08:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:34:50 INFO - Using env: {'DISPLAY': ':0', 08:34:50 INFO - 'HOME': '/home/cltbld', 08:34:50 INFO - 'LANG': 'en_US.UTF-8', 08:34:50 INFO - 'LANGUAGE': 'en_US:en', 08:34:50 INFO - 'LOGNAME': 'cltbld', 08:34:50 INFO - 'MAIL': '/var/mail/cltbld', 08:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:50 INFO - 'MOZ_NO_REMOTE': '1', 08:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:50 INFO - 'NO_EM_RESTART': '1', 08:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:50 INFO - 'PWD': '/builds/slave/test', 08:34:50 INFO - 'SHELL': '/bin/bash', 08:34:50 INFO - 'SHLVL': '1', 08:34:50 INFO - 'TERM': 'linux', 08:34:50 INFO - 'TMOUT': '86400', 08:34:50 INFO - 'USER': 'cltbld', 08:34:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:50 INFO - '_': '/tools/buildbot/bin/python'} 08:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:51 INFO - Downloading/unpacking psutil>=3.1.1 08:34: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 08:34: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 08:34: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 08:34: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 08:34: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 08:34: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 08:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:34:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:53 INFO - Installing collected packages: psutil 08:34:53 INFO - Running setup.py install for psutil 08:34:53 INFO - building 'psutil._psutil_linux' extension 08:34:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:34:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:34:53 INFO - building 'psutil._psutil_posix' extension 08:34:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:34:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:34:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:53 INFO - Successfully installed psutil 08:34:53 INFO - Cleaning up... 08:34:53 INFO - Return code: 0 08:34:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:34:53 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')]} 08:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:53 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')]} 08:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:53 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 0x1703030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, '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': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', '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 08:34:53 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 08:34:53 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 08:34:53 INFO - Using env: {'DISPLAY': ':0', 08:34:53 INFO - 'HOME': '/home/cltbld', 08:34:53 INFO - 'LANG': 'en_US.UTF-8', 08:34:53 INFO - 'LANGUAGE': 'en_US:en', 08:34:53 INFO - 'LOGNAME': 'cltbld', 08:34:53 INFO - 'MAIL': '/var/mail/cltbld', 08:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:53 INFO - 'MOZ_NO_REMOTE': '1', 08:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:53 INFO - 'NO_EM_RESTART': '1', 08:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:53 INFO - 'PWD': '/builds/slave/test', 08:34:53 INFO - 'SHELL': '/bin/bash', 08:34:53 INFO - 'SHLVL': '1', 08:34:53 INFO - 'TERM': 'linux', 08:34:53 INFO - 'TMOUT': '86400', 08:34:53 INFO - 'USER': 'cltbld', 08:34:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:53 INFO - '_': '/tools/buildbot/bin/python'} 08:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:34:55 INFO - Installing collected packages: mozsystemmonitor 08:34:55 INFO - Running setup.py install for mozsystemmonitor 08:34:55 INFO - Successfully installed mozsystemmonitor 08:34:55 INFO - Cleaning up... 08:34:55 INFO - Return code: 0 08:34:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:34: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')]} 08:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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')]} 08:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:55 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 0x1703030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, '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': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', '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 08:34:55 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 08:34:55 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 08:34:55 INFO - Using env: {'DISPLAY': ':0', 08:34:55 INFO - 'HOME': '/home/cltbld', 08:34:55 INFO - 'LANG': 'en_US.UTF-8', 08:34:55 INFO - 'LANGUAGE': 'en_US:en', 08:34:55 INFO - 'LOGNAME': 'cltbld', 08:34:55 INFO - 'MAIL': '/var/mail/cltbld', 08:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:55 INFO - 'MOZ_NO_REMOTE': '1', 08:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:55 INFO - 'NO_EM_RESTART': '1', 08:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:55 INFO - 'PWD': '/builds/slave/test', 08:34:55 INFO - 'SHELL': '/bin/bash', 08:34:55 INFO - 'SHLVL': '1', 08:34:55 INFO - 'TERM': 'linux', 08:34:55 INFO - 'TMOUT': '86400', 08:34:55 INFO - 'USER': 'cltbld', 08:34:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:55 INFO - '_': '/tools/buildbot/bin/python'} 08:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:56 INFO - Downloading/unpacking jsonschema==2.5.1 08:34: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 08:34: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 08:34: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 08:34: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 08:34: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 08:34: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 08:34:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:34:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:58 INFO - Downloading functools32-3.2.3-2.tar.gz 08:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:34:58 INFO - warning: no files found matching '*.txt' 08:34:58 INFO - no previously-included directories found matching 'build' 08:34:58 INFO - no previously-included directories found matching 'dist' 08:34:58 INFO - no previously-included directories found matching '.git*' 08:34:58 INFO - Installing collected packages: jsonschema, functools32 08:34:58 INFO - Running setup.py install for functools32 08:34:58 INFO - warning: no files found matching '*.txt' 08:34:58 INFO - no previously-included directories found matching 'build' 08:34:58 INFO - no previously-included directories found matching 'dist' 08:34:58 INFO - no previously-included directories found matching '.git*' 08:34:58 INFO - Successfully installed jsonschema functools32 08:34:58 INFO - Cleaning up... 08:34:58 INFO - Return code: 0 08:34:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:58 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 0x1703030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, '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': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', '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 08:34:58 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 08:34:58 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 08:34:58 INFO - Using env: {'DISPLAY': ':0', 08:34:58 INFO - 'HOME': '/home/cltbld', 08:34:58 INFO - 'LANG': 'en_US.UTF-8', 08:34:58 INFO - 'LANGUAGE': 'en_US:en', 08:34:58 INFO - 'LOGNAME': 'cltbld', 08:34:58 INFO - 'MAIL': '/var/mail/cltbld', 08:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:58 INFO - 'MOZ_NO_REMOTE': '1', 08:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:58 INFO - 'NO_EM_RESTART': '1', 08:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:58 INFO - 'PWD': '/builds/slave/test', 08:34:58 INFO - 'SHELL': '/bin/bash', 08:34:58 INFO - 'SHLVL': '1', 08:34:58 INFO - 'TERM': 'linux', 08:34:58 INFO - 'TMOUT': '86400', 08:34:58 INFO - 'USER': 'cltbld', 08:34:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:58 INFO - '_': '/tools/buildbot/bin/python'} 08:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:00 INFO - Downloading blobuploader-1.2.4.tar.gz 08:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:35:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:35:00 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 08:35:00 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 08:35:00 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 08:35:00 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 08:35:00 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 08:35:00 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 08:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:35:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:01 INFO - Downloading docopt-0.6.1.tar.gz 08:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:35:01 INFO - Installing collected packages: blobuploader, requests, docopt 08:35:01 INFO - Running setup.py install for blobuploader 08:35:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:35:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:35:01 INFO - Running setup.py install for requests 08:35:01 INFO - Running setup.py install for docopt 08:35:01 INFO - Successfully installed blobuploader requests docopt 08:35:01 INFO - Cleaning up... 08:35:01 INFO - Return code: 0 08:35:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:01 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 0x1703030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, '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': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', '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 08:35:01 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 08:35:01 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 08:35:01 INFO - Using env: {'DISPLAY': ':0', 08:35:01 INFO - 'HOME': '/home/cltbld', 08:35:01 INFO - 'LANG': 'en_US.UTF-8', 08:35:01 INFO - 'LANGUAGE': 'en_US:en', 08:35:01 INFO - 'LOGNAME': 'cltbld', 08:35:01 INFO - 'MAIL': '/var/mail/cltbld', 08:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:01 INFO - 'MOZ_NO_REMOTE': '1', 08:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:01 INFO - 'NO_EM_RESTART': '1', 08:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:01 INFO - 'PWD': '/builds/slave/test', 08:35:01 INFO - 'SHELL': '/bin/bash', 08:35:01 INFO - 'SHLVL': '1', 08:35:01 INFO - 'TERM': 'linux', 08:35:01 INFO - 'TMOUT': '86400', 08:35:01 INFO - 'USER': 'cltbld', 08:35:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:01 INFO - '_': '/tools/buildbot/bin/python'} 08:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:02 INFO - Running setup.py (path:/tmp/pip-7f7IPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:02 INFO - Running setup.py (path:/tmp/pip-NjFCdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:02 INFO - Running setup.py (path:/tmp/pip-cRHC68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:02 INFO - Running setup.py (path:/tmp/pip-O1TlX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:02 INFO - Running setup.py (path:/tmp/pip-fFt4xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:02 INFO - Running setup.py (path:/tmp/pip-PFq66c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:02 INFO - Running setup.py (path:/tmp/pip-EAnkte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:02 INFO - Running setup.py (path:/tmp/pip-3VPmYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:02 INFO - Running setup.py (path:/tmp/pip-YPsnUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:02 INFO - Running setup.py (path:/tmp/pip-iR3bZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:02 INFO - Running setup.py (path:/tmp/pip-MyEjpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:02 INFO - Running setup.py (path:/tmp/pip-dnpO5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:03 INFO - Running setup.py (path:/tmp/pip-VQiMT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:03 INFO - Running setup.py (path:/tmp/pip-RU5JLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:03 INFO - Running setup.py (path:/tmp/pip-pHFKPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:03 INFO - Running setup.py (path:/tmp/pip-zDRG6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:03 INFO - Running setup.py (path:/tmp/pip-w71yHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:35:03 INFO - Running setup.py install for manifestparser 08:35:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:35:03 INFO - Running setup.py install for mozcrash 08:35:03 INFO - Running setup.py install for mozdebug 08:35:03 INFO - Running setup.py install for mozdevice 08:35:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:35:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:35:03 INFO - Running setup.py install for mozfile 08:35:03 INFO - Running setup.py install for mozhttpd 08:35:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Running setup.py install for mozinfo 08:35:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Running setup.py install for mozInstall 08:35:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Running setup.py install for mozleak 08:35:04 INFO - Running setup.py install for mozlog 08:35:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Running setup.py install for moznetwork 08:35:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Running setup.py install for mozprocess 08:35:04 INFO - Running setup.py install for mozprofile 08:35:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Running setup.py install for mozrunner 08:35:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:35:04 INFO - Running setup.py install for mozscreenshot 08:35:04 INFO - Running setup.py install for moztest 08:35:05 INFO - Running setup.py install for mozversion 08:35:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:35:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:35:05 INFO - Cleaning up... 08:35:05 INFO - Return code: 0 08:35:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, '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': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', '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 08:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:05 INFO - Using env: {'DISPLAY': ':0', 08:35:05 INFO - 'HOME': '/home/cltbld', 08:35:05 INFO - 'LANG': 'en_US.UTF-8', 08:35:05 INFO - 'LANGUAGE': 'en_US:en', 08:35:05 INFO - 'LOGNAME': 'cltbld', 08:35:05 INFO - 'MAIL': '/var/mail/cltbld', 08:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:05 INFO - 'MOZ_NO_REMOTE': '1', 08:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:05 INFO - 'NO_EM_RESTART': '1', 08:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:05 INFO - 'PWD': '/builds/slave/test', 08:35:05 INFO - 'SHELL': '/bin/bash', 08:35:05 INFO - 'SHLVL': '1', 08:35:05 INFO - 'TERM': 'linux', 08:35:05 INFO - 'TMOUT': '86400', 08:35:05 INFO - 'USER': 'cltbld', 08:35:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:05 INFO - '_': '/tools/buildbot/bin/python'} 08:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:05 INFO - Running setup.py (path:/tmp/pip-51UgW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:05 INFO - Running setup.py (path:/tmp/pip-O5cka8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:05 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)) 08:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:05 INFO - Running setup.py (path:/tmp/pip-y8mv8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:05 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)) 08:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:05 INFO - Running setup.py (path:/tmp/pip-p25hUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:05 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)) 08:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:05 INFO - Running setup.py (path:/tmp/pip-oYQpzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:05 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)) 08:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:05 INFO - Running setup.py (path:/tmp/pip-qLZvWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:05 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)) 08:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:05 INFO - Running setup.py (path:/tmp/pip-GMEwsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:05 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)) 08:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:05 INFO - Running setup.py (path:/tmp/pip-GVRRyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:05 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)) 08:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:06 INFO - Running setup.py (path:/tmp/pip-7kKRWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:06 INFO - Running setup.py (path:/tmp/pip-B79gUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:06 INFO - Running setup.py (path:/tmp/pip-mEtFZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:06 INFO - Running setup.py (path:/tmp/pip-x_j6ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:06 INFO - Running setup.py (path:/tmp/pip-XyIInH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:06 INFO - Running setup.py (path:/tmp/pip-D_xyjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:06 INFO - Running setup.py (path:/tmp/pip-mESiFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:06 INFO - Running setup.py (path:/tmp/pip-lpahz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:06 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)) 08:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:06 INFO - Running setup.py (path:/tmp/pip-8C7gxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:06 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 08:35:06 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 08:35:06 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 08:35:06 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 08:35:06 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 08:35:06 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 08:35:08 INFO - Downloading blessings-1.6.tar.gz 08:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:35:08 INFO - Installing collected packages: blessings 08:35:08 INFO - Running setup.py install for blessings 08:35:08 INFO - Successfully installed blessings 08:35:08 INFO - Cleaning up... 08:35:08 INFO - Return code: 0 08:35:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:09 INFO - Reading from file tmpfile_stdout 08:35:09 INFO - Current package versions: 08:35:09 INFO - argparse == 1.2.1 08:35:09 INFO - blessings == 1.6 08:35:09 INFO - blobuploader == 1.2.4 08:35:09 INFO - docopt == 0.6.1 08:35:09 INFO - functools32 == 3.2.3-2 08:35:09 INFO - jsonschema == 2.5.1 08:35:09 INFO - manifestparser == 1.1 08:35:09 INFO - mozInstall == 1.12 08:35:09 INFO - mozcrash == 0.17 08:35:09 INFO - mozdebug == 0.1 08:35:09 INFO - mozdevice == 0.48 08:35:09 INFO - mozfile == 1.2 08:35:09 INFO - mozhttpd == 0.7 08:35:09 INFO - mozinfo == 0.9 08:35:09 INFO - mozleak == 0.1 08:35:09 INFO - mozlog == 3.2 08:35:09 INFO - moznetwork == 0.27 08:35:09 INFO - mozprocess == 0.22 08:35:09 INFO - mozprofile == 0.28 08:35:09 INFO - mozrunner == 6.11 08:35:09 INFO - mozscreenshot == 0.1 08:35:09 INFO - mozsystemmonitor == 0.3 08:35:09 INFO - moztest == 0.7 08:35:09 INFO - mozversion == 1.4 08:35:09 INFO - psutil == 3.1.1 08:35:09 INFO - requests == 1.2.3 08:35:09 INFO - wsgiref == 0.1.2 08:35:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, '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': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', '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 08:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:09 INFO - Using env: {'DISPLAY': ':0', 08:35:09 INFO - 'HOME': '/home/cltbld', 08:35:09 INFO - 'LANG': 'en_US.UTF-8', 08:35:09 INFO - 'LANGUAGE': 'en_US:en', 08:35:09 INFO - 'LOGNAME': 'cltbld', 08:35:09 INFO - 'MAIL': '/var/mail/cltbld', 08:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:09 INFO - 'MOZ_NO_REMOTE': '1', 08:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:09 INFO - 'NO_EM_RESTART': '1', 08:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:09 INFO - 'PWD': '/builds/slave/test', 08:35:09 INFO - 'SHELL': '/bin/bash', 08:35:09 INFO - 'SHLVL': '1', 08:35:09 INFO - 'TERM': 'linux', 08:35:09 INFO - 'TMOUT': '86400', 08:35:09 INFO - 'USER': 'cltbld', 08:35:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:09 INFO - '_': '/tools/buildbot/bin/python'} 08:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:35:09 INFO - Cleaning up... 08:35:09 INFO - Return code: 0 08:35:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, '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': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', '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 08:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:35:09 INFO - Using env: {'DISPLAY': ':0', 08:35:09 INFO - 'HOME': '/home/cltbld', 08:35:09 INFO - 'LANG': 'en_US.UTF-8', 08:35:09 INFO - 'LANGUAGE': 'en_US:en', 08:35:09 INFO - 'LOGNAME': 'cltbld', 08:35:09 INFO - 'MAIL': '/var/mail/cltbld', 08:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:09 INFO - 'MOZ_NO_REMOTE': '1', 08:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:09 INFO - 'NO_EM_RESTART': '1', 08:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:09 INFO - 'PWD': '/builds/slave/test', 08:35:09 INFO - 'SHELL': '/bin/bash', 08:35:09 INFO - 'SHLVL': '1', 08:35:09 INFO - 'TERM': 'linux', 08:35:09 INFO - 'TMOUT': '86400', 08:35:09 INFO - 'USER': 'cltbld', 08:35:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:09 INFO - '_': '/tools/buildbot/bin/python'} 08:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:35:09 INFO - Cleaning up... 08:35:09 INFO - Return code: 0 08:35:09 INFO - Running post-action listener: _resource_record_post_action 08:35:09 INFO - Running post-action listener: _start_resource_monitoring 08:35:09 INFO - Starting resource monitoring. 08:35:09 INFO - ##### 08:35:09 INFO - ##### Finished create-virtualenv step (success) 08:35:09 INFO - ##### 08:35:09 INFO - ##### 08:35:09 INFO - ##### Running install step. 08:35:09 INFO - ##### 08:35:09 INFO - Running pre-action listener: _resource_record_pre_action 08:35:09 INFO - Running main action method: install 08:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:09 INFO - Reading from file tmpfile_stdout 08:35:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:35:09 INFO - Reading from file tmpfile_stdout 08:35:09 INFO - Output received: 08:35:09 INFO - Usage: mozinstall [options] installer 08:35:09 INFO - Options: 08:35:09 INFO - -h, --help show this help message and exit 08:35:09 INFO - -d DEST, --destination=DEST 08:35:09 INFO - Directory to install application into. [default: 08:35:09 INFO - "/builds/slave/test"] 08:35:09 INFO - --app=APP Application being installed. [default: firefox] 08:35:09 INFO - mkdir: /builds/slave/test/build/application 08:35:09 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'] 08:35:09 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 08:35:26 INFO - Reading from file tmpfile_stdout 08:35:26 INFO - Output received: 08:35:26 INFO - /builds/slave/test/build/application/firefox/firefox 08:35:26 INFO - Running post-action listener: _resource_record_post_action 08:35:26 INFO - ##### 08:35:26 INFO - ##### Finished install step (success) 08:35:26 INFO - ##### 08:35:26 INFO - ##### 08:35:26 INFO - ##### Running run-tests step. 08:35:26 INFO - ##### 08:35:26 INFO - Running pre-action listener: _resource_record_pre_action 08:35:26 INFO - Running main action method: run_tests 08:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:35:26 INFO - Python 2.7.3 08:35:26 INFO - Return code: 0 08:35:26 INFO - grabbing minidump binary from tooltool 08:35:26 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')]} 08:35:26 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 0x19c23b0>, '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 0x19c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:35:26 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 08:35:26 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 08:35:26 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 08:35:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:35:27 INFO - Return code: 0 08:35:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:35:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:35:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:35:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:35:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:35:27 INFO - Using env: {'DISPLAY': ':0', 08:35:27 INFO - 'HOME': '/home/cltbld', 08:35:27 INFO - 'LANG': 'en_US.UTF-8', 08:35:27 INFO - 'LANGUAGE': 'en_US:en', 08:35:27 INFO - 'LOGNAME': 'cltbld', 08:35:27 INFO - 'MAIL': '/var/mail/cltbld', 08:35:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:35:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:27 INFO - 'MOZ_NO_REMOTE': '1', 08:35:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:27 INFO - 'NO_EM_RESTART': '1', 08:35:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:27 INFO - 'PWD': '/builds/slave/test', 08:35:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:35:27 INFO - 'SHELL': '/bin/bash', 08:35:27 INFO - 'SHLVL': '1', 08:35:27 INFO - 'TERM': 'linux', 08:35:27 INFO - 'TMOUT': '86400', 08:35:27 INFO - 'USER': 'cltbld', 08:35:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754', 08:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:27 INFO - '_': '/tools/buildbot/bin/python'} 08:35:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:35:27 INFO - mozversion application_buildid: 20160701143005 08:35:27 INFO - mozversion application_changeset: 3bde90c197be1b2f60db5c3d5127d69950ba3b2f 08:35:27 INFO - mozversion application_display_name: Nightly 08:35:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:35:27 INFO - mozversion application_name: Firefox 08:35:27 INFO - mozversion application_remotingname: firefox 08:35:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:35:27 INFO - mozversion application_vendor: Mozilla 08:35:27 INFO - mozversion application_version: 50.0a1 08:35:27 INFO - mozversion platform_buildid: 20160701143005 08:35:27 INFO - mozversion platform_changeset: 3bde90c197be1b2f60db5c3d5127d69950ba3b2f 08:35:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:35:27 INFO - mozversion platform_version: 50.0a1 08:35:27 INFO - using testdate: 1467732927 08:35:27 INFO - actual date: 1467732927 08:35:27 INFO - starting webserver on 'localhost:36944' 08:35:27 INFO - SUITE-START | Running 2 tests 08:35:27 INFO - TEST-START | dromaeo_css 08:35:27 INFO - operating with platform_type : linux_ 08:35:27 INFO - Initialising browser for dromaeo_css test... 08:35:27 INFO - TEST-INFO | started process 9356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJGnJAq/profile http://localhost:36944/getInfo.html) 08:35:31 INFO - PROCESS | 9356 | __metrics Screen width/height:1600/1200 08:35:31 INFO - PROCESS | 9356 | colorDepth:24 08:35:31 INFO - PROCESS | 9356 | Browser inner width/height: 1024/697 08:35:31 INFO - PROCESS | 9356 | __metrics 08:35:32 ERROR - PROCESS | 9356 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:35:33 INFO - TEST-INFO | 9356: exit 0 08:35:33 INFO - Browser initialized. 08:35:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:35:33 INFO - TEST-INFO | started process 9477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJGnJAq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:45 INFO - PROCESS | 9477 | RSS: Main: 168820736 08:35:45 INFO - PROCESS | 9477 | 08:36:34 INFO - PROCESS | 9477 | 1467732994660 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] 08:38:42 INFO - PROCESS | 9477 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36944/tests/dromaeo/cssquery-ext.html) 08:38:43 INFO - PROCESS | 9477 | RSS: Main: 172359680 08:38:43 INFO - PROCESS | 9477 | 08:41:45 INFO - PROCESS | 9477 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-ext.html (next: http://localhost:36944/tests/dromaeo/cssquery-jquery.html) 08:41:46 INFO - PROCESS | 9477 | RSS: Main: 168460288 08:41:46 INFO - PROCESS | 9477 | 08:44:48 INFO - PROCESS | 9477 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36944/tests/dromaeo/cssquery-mootools.html) 08:44:48 INFO - PROCESS | 9477 | RSS: Main: 172064768 08:44:48 INFO - PROCESS | 9477 | 08:47:50 INFO - PROCESS | 9477 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36944/tests/dromaeo/cssquery-prototype.html) 08:47:51 INFO - PROCESS | 9477 | RSS: Main: 167563264 08:47:51 INFO - PROCESS | 9477 | 08:50:53 INFO - PROCESS | 9477 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36944/tests/dromaeo/cssquery-yui.html) 08:50:54 INFO - PROCESS | 9477 | RSS: Main: 169246720 08:50:54 INFO - PROCESS | 9477 | 08:53:57 INFO - PROCESS | 9477 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-yui.html (next: http://localhost:36944/tests/dromaeo/cssquery-dojo.html) 08:53:57 INFO - PROCESS | 9477 | RSS: Main: 170573824 08:53:57 INFO - PROCESS | 9477 | 08:53:57 INFO - PROCESS | 9477 | __start_tp_report 08:53:57 INFO - PROCESS | 9477 | _x_x_mozilla_page_load 08:53:57 INFO - PROCESS | 9477 | _x_x_mozilla_page_load_details 08:53:57 INFO - PROCESS | 9477 | |i|pagename|runs| 08:53:57 INFO - PROCESS | 9477 | |0;dojo.html;3116.766242531811;3158.5104308832124;3170.286685495764;3204.311073119282;3221.822799746013;5598.048331783596;5627.577931655127;5670.234518340023;5675.205471234025;5687.2606561146995;5386.676799392039;5519.889602207963;5535.169724541311;5542.889142217154;5557.305336832896;4967.652264341488;4989.476105008976;5098.770555325019;5136.126858434057;5189.377274727038;196.0104226197015;5017.473165317644;5100.183970564711;5118.820841270556;5146.588272938156;5093.236014597803;5113.897722045557;5125.574074258556;5126.615503837208;5146.871328216825;4916.803327866881;5134.2812006319145;5135.922961155586;5150.742462876841;5151.6908985461;4941.283513890502;4987.326710894019;4989.65072444929;5009.624278179114;5027.245913113063;5496.203050557687;5500.669959802424;5542.334919809608;5576.107822748381;5634.605577609569;5804.071348584206;5916.964531207064;5926.733297001602;5932;5934.465898069151;6022.09668549721;6092.817215483543;6113.572049956505;6115.694215289218;6143.78496752616;5639.68981706006;5645.745941432645;5657.660540367591;5665.3201615806365;5673.23411339468;5926.377730338339;5929.0513517836935;5938.673372964442;6195.380461953769;6210.472109870711;5787.9131813021995;5795.304563452329;5796.855078623068;5817.127430885401;5864.4428779266755;5829;5874.383189765099;5877.970610146922;5897.203877476486;5910.261217347832;5786.681732504752;5857.062869940789;5866.061430171152;5916.290045194518;5952.8809423812145;5760.855978600569;5795.1017592273265;5832.562557808182;5850.239468869105;6014.36849130835;4489.6408287336935;4492.932606010912;4493.775311234425;4503.774811259424;4535.297028960516;3961.8217180226957;4003.259397011562;4030.9922519370157;4037.8788636340955;4096.426500289962;5587.161925711176;5623.212750214973;5643.492085712305;5649.774009039593;5682.602217844711;5954.55340849438;5975.940240597625;5988.3113441953865;5989;5989.071693887455;5542.722863856791;5548.0845660465575;5570.470805273492;5577.2191893135;5658.5473162147755;5110.105731496973;5211.765470553834;5212.947870521246;5216.347956505437;5256.211568264791;6239.095331176954;6257.7184026718905;6266.780662676784;6268.028455589391;6278.340774218733;5817.883642327045;5919.496842768241;5946.910796337972;6076.939230607726;6117.296510901126;6105.6947152641305;6111.470193407285;6126.9757403264;6236.34518375564;6242.375762423721;5935.9109613356695;5936.13925980739;5946.197263369563;5956.106584012433;5962.25471816023;5874.295084589877;5894.174815525744;6038;6039.396060394101;6062.393760624079;5733.799317023884;5810.709464526842;5836.299644042742;5839.591228613956;5893.734781934909;5666.2350582670815;5723.399043100415;5738.971305143615;5770.163326317745;5777.62445441045;5443.7822487100075;5575.804846830341;5621.550275977994;5695.7436915338085;5707.743151558273;5873.588848780544;5887.087501437284;5890.2342695449315;5944.1975333331175;5987.940120598738;5742.856428589319;5750;5784.190213370216;5795.304563452412;5814.796482123105 08:53:57 INFO - PROCESS | 9477 | |1;ext.html;583.4661284924294;594.4026253615116;594.5243804956035;621.028091037526;622.6730966242721;42488.36267455987;43865.12269754603;43866.99999999996;43963.78018109909;47160.29259561109;37673.24653506935;38019.809900950524;38086.61913380865;38119.23761524768;38130.618693813056;8649.827003459943;8757.56212189388;8791.032986371494;8791.20879120879;8793.604287807031;8637.481751094923;8640;8681.95659021704;8694.434861733998;8698.130186981283;8695.39132260742;8704.651813927436;8739.563021848913;8766.386352955296;8768.298536117127;8669.95665021674;8677.783055423602;8694.739157825275;8706.477611343307;8729.170728780755;8890.822183556358;8963.686270980485;8984.775380615472;8988;8991.370604057718;35516.82241588801;35622.82188589066;36006.27987440237;36027.27945441103;36119.81940090283;3573.4818451324413;3671.3391589513876;3672.944905826415;3741.38267185914;4136.172765446892;28239.717602823916;28413.57379639307;28656.426871462663;28762;29852.55221171684;4412.75729834859;4482.731036137842;4518.457785065781;4616.76916154191;4638.976805115986;356819;358504;358582;359080;359520;31905.128538431654;32510.83744581262;32696.673033269362;57298.7135064322;57359.426405736245;33475.656704030975;33496.83251583727;33526.83236583802;33633;33736.49395259073;15144.091354518765;15214.163221022729;15357.923210383877;15383.692326153414;15456.768148477782;12429.937850310691;12460.750784984431;12514.937425312815;12561.434735436927;12573.119881608383;8860.911390886138;8892.377533572588;8902.376833621714;8955.955220223988;8974.326925480615;3375.7636965412676;3386.2211691311136;3402.0984439123654;3433.124553238958;3461.6365281645067;1018.872640919885;1059.3855563772993;1063.500154927183;1070.5057216685104;1088.2654208409292;32902.67097329044;33202.50196247058;33262.50106248408;33450.49824252638;33583.83208083944;1091.3397394576325;1137.6643890052455;1150.2178518607261;1156.919015668912;1166.6441735270655;16977.236024378934;17373.391931282345;17486.47540573785;17638.735418968725;17654.11729413524;554918;559674;566611;566639;567395;56947.14579281314;58023.4197658018;58582.70708646515;58709.41290587125;58849.411505884396;1151.6896499469603;1165.9883401166048;1175.1773758369177;1178.216486036776;1304.6151385341348;31147.065588032394;32605.18487037843;32762.672373275964;33015.83492082524;33067.17332066718;50787.746061269456;51627.48372516377;51694.48305517047;51702.741486292325;51816.74091629518;428749;433489;435868;435883;438024;29469.526523674158;29609;29703.405931881673;29865.701342986293;29867.253318667208;48135;48960.75519622522;49625;49999;50651.24023139729;40910.386344204264;41843.581564183965;42170.15659686728;42221.577784222995;42416.455012699334;41434.171316572894;41593.58406416018;41661.37507937444;42328.78835605802;43030.569694302656;40926.59073409228;41541.37687934623;41577;42285.94285142896;42451.575484244764;32064.35871282608;32796.83601581977;32894.34211315712;33264;33468.33063338768;28093.297667557657;28327.2918177039;28343.858280708464;28517.714822851507;28645.570316445686 08:53:57 INFO - PROCESS | 9477 | |2;jquery.html;402.8267844826727;403.48958567412217;405.1168452772954;410.4971410022722;425.1666733202922;18805.341813036546;19060.237590496363;19997;20394;20638.071286792092;12220.32788196651;12316.692082697937;12351.876481235186;12417.937910310458;12722.872771272285;5188.792448302063;5428.131498960167;5460.535854452376;5462.672239665613;5477.20580515825;5214.60890433219;5278.868028299285;5360.142377219646;5360.463953604647;5417.810376636819;5353.705546194958;5366.409694933554;5377.166539186433;5392.433794451585;5398.649087809299;5258.316418865561;5341.252224688546;5416.485433883775;5420.4850539198715;5429.809956651518;5195.090859099642;5195.896082078338;5223.503767142115;5235.712035838027;5247.081760691902;14049.157050576998;14359;14363.281835908163;14425;14441.85558144426;2233.7096177496983;2510.9748902510923;2813.1841765887866;3024.894128705507;3034.2717747740603;10488.370697758159;10618.415987120705;10677.30597511167;10715.08921741653;10727.302725322907;1883.1243471785685;1963.9116239769244;1992.2927360787003;2010.2160157538572;2021.4643119573177;75020.24979750188;75714;77797.61101194515;81535;90829;9741.951290243504;10280.177585793119;10393.272470926962;10595.417252051211;10736.818949915503;14300;14312.141271523742;14335.856641433453;14356.928215358856;14409.711805763825;8235.711750088718;8555.786105347292;8557.871631925525;8706.6517339307;8734.344924130715;8509.27671147947;8546.829063418696;8657.523836188944;8768.386212965032;8876.778080548038;4269.188854117708;4295.52749197588;4375.190589740844;4385.407969924019;4517.322401639714;1891.1678861300984;1950.6488832010375;2101.8318534517202;2140.989295053546;2169.28413623507;895.5701263393607;955.1690029674228;975.6829030565095;1006.9899301007042;1023.2785885950387;19905;20028;20120.39638810838;20205.191792328435;20263.189472420938;965.7875267441152;967.7193613852045;986.5215370545279;994.7314225159312;1051.164324362134;10515.474226288656;10616.681499555025;10749.247552671239;11152.776944461066;11170.664880053611;486845;493184;504950.55397403304;507652;508106;91809.54095229614;92899;94500.10999779966;97542;98064;894.1505569708803;969.7672558585889;975.7609385700407;987.7481242283171;990.6681261777385;17634.294628214728;17676.381326653507;18162.545936351697;18208.36270730518;18289.359872404402;43896.34155487606;44124.11751765011;44493.55506444894;44573.55426445694;44818.21762040242;56920;57017.58332958362;59303.703481484044;60785.0882236758;61343.38656613377;7724.266194711493;8122.228388303101;8247.422680412554;8454.746357609281;8875.068117847533;13275.40260688252;13880.54254303324;14247.928760356132;14716.411343546566;14948.850511494746;11070.446477676245;12098.334591597546;12527.937360313505;12561.246325220516;12767.553135640208;12773.61679149627;12856.614301570968;12857.678558036125;12930.935345323212;12950.611481655566;12489.687757806127;12722.809157862825;12759.234445933274;13121.147125436815;13223.867761322264;9038.728838134866;9189.77025574366;9190.862137067816;9226.953865230631;9370.10983956523;9258.861117083385;12659;12663.050271229878;12675.239485630524;12845.229286242855 08:53:57 INFO - PROCESS | 9477 | |3;mootools.html;1325.814385985962;1378.2350795308605;1438.6115748747839;1441.913485190888;1737.166160243084;8038.718644847431;8548.700795472152;8573.442726222791;9117.58970846311;9129.954350228249;8661.653533858638;8883;8909.420887642298;8980.191782739552;8987.236084932772;2343.2033108743067;2380.75002124777;2383.2135395319588;2392;2398.1606437746736;2376.4415362389823;2391.4260577461373;2398.424378149249;2403.3270684208364;2411.5056413435204;2365.3495288795634;2374.252110585169;2382.797462215705;2389.6415537669313;2392.342105920877;2333.3349995251274;2349;2352.752960939102;2362.3857796972825;2371.5968285391523;2326.1974618756503;2344.601417758985;2348.107719066744;2348.248560460653;2357.5284943011466;9068.591913363915;9083;9120.179183873417;9124.270058395312;9134.954325228398;5207.323048003773;5322.680639161624;5338.119210330291;5343.625946183769;5344.706041167734;3323.501474778778;3372.241245719718;3402.659734026602;3415.2315728961034;3482.355764183634;1119.1326721790597;1121.5625905896707;1148.5922497513345;1161.8373427720126;1163.650904728578;12628.936855315756;12737.172083814523;12752.617421477278;12778.936105319506;12780.297083660394;4727.456342520585;4730.454196062733;4763.571278584944;4831.444383895827;4887.413510378778;10667.199960002876;10688.412137332522;10755.623553175601;10765.246432749633;10775.6228532001;5261;5274.604404669665;5283.762230699551;5302.416734159239;5309.840704778863;4263.55232700562;4775.379200703956;4842.346283251786;4900.240462728283;4907.263910413395;4045.1707399982934;4071.1043570414463;4075.7146999709735;4083.4691490106097;4089.828944009152;1333.280028784465;1334.9666258343618;1342.5099838559051;1345.3945724424048;1351.574254109952;854.7179430787825;860.5396113079597;865.1564724393666;878.0297770963122;885.526243459746;5902.5277977762535;5994.730237139339;6020.849478763066;6025.849353766191;6135.049067394561;444.2492188201993;451.4988362917159;452.6084936529878;460.8617414775621;464.98372556960345;3869.7871617061332;3874.845006199777;3887.9222415552094;3930.9213815723524;4009.258287216874;11130.610428634958;11334.206605537533;11396.14528910335;11423.371714555613;11522.711932201595;11173.329600224013;11271.09831213501;11276.887231127748;11285.435728213557;11343.716407089723;7982.760517184493;8341;8369;8388.622511986976;8555.058943516207;5851.531877449879;6076.361981992004;6088.208532890696;6141;6185.752569897334;10208.948955255177;10316.587336506456;10374.27380083387;10428.687139385831;10446.947765261126;10125.64560240388;10524.105451036441;10661;10697.572097116028;10800.297980631234;7353.77938661841;7968.282854543119;8067.878981815395;8196.713115040944;8313.750587482386;8422;8662.480251184948;8738.737837864874;8766.34252431083;8820.382573219813;7446.70213191488;7577.848443031219;7679.2704693054075;7717.459777815499;7725.188855170351;7426.628668566658;7530.811729706582;7626.161122276656;7674.2325767425045;7705.499142555716;7163.212046674966;7220.241874603301;7231.240719724353;7246.311600397954;7281.526700764433;5079.466656001215;5124.9743751281;5217.269582258563;5233.6074794389815;5345.064613692666;5060.544550990428;5116.488351164854;5175.534201921845;5178.249153872743;5221.869453263699 08:53:57 INFO - PROCESS | 9477 | |4;prototype.html;342.4059257188779;351.9260955199408;353.88675623800384;357.94809752585877;357.9821008949552;5684.289463817023;5703.657780533171;5786.103154011124;5800.651960882345;5821.50517206037;5633.267675202228;5664.915026274609;5675.602707810455;5678.716064196794;5700.8859822803515;4272.166927449149;4466.9329960050545;4474.574915383034;4477.328400739882;4482.887927801815;4336.891577710567;4339.871633375329;4351.760653164075;4357.651387888977;4368.584984426474;4270.701050926436;4295.269804133305;4295.742255464666;4299.31211006239;4301.827926882921;4282.507511636155;4314.935275970863;4322.178786030644;4328.156009578133;4331.285337919239;3717.368047431943;3853.6724378427866;3855.749376290532;3857.5370955485523;3863.16941857502;5511.173324001392;5534.944650553483;5540.667559946416;5561.972190139064;5577.274954255961;4982.078315511642;5006.973570418056;5068.479456163136;5070.315507406527;5092.159793634046;5624.634398764068;5955.434233747787;5969.283685957713;5971.731272092767;5999.880002399971;4269.765162916038;4310.4396428464415;4312.547182545819;4317.84887528935;4323.200207961537;5544;6186.288576813679;6257.374262573751;6267.5299352548745;6279.686015699197;4336.132773445323;4348.260795664744;4374.731327914933;4375.146846364928;4396.868093957187;4450.753788939102;4461.754603496774;4473.597376236155;4474.232678092136;4478.39541661878;4938.678985865908;5038.34501514808;5096.847094587094;5104.872378190575;5141.38303403594;5981.790637327673;5990.880182396328;5993.400659933972;5994.970025149846;6002.639841609517;1506.9171195584347;1523.8323784383708;1524.3216768538116;1528.0678785940568;1533.1031346662105;939.5302348825587;964.5466630683568;978.6770365779419;978.814025335184;989.5398639632606;4982.950170498321;5074.746262686851;5087.947231661048;5088.313077734459;5118.952419032416;5411.377691565521;5454.563634909197;5455.881544283412;5471.890562188734;5494.203340515603;4939.887216730666;5075.238714192827;5075.6144612032285;5122.206058061007;5123.769430375642;2863.3271181272385;2871.0956048844546;2871.468778275984;2887.768978481716;2903.7096290370796;5436.260396673106;5483.204935284361;5569.106503788731;5569.470900264469;5574.58190635704;5232.090287045201;5466.305445311966;5517.724113794375;5531.25328080712;5535.809800892827;5510.393856675762;5520.806771762969;5521.70849097628;5534.833954981357;5558.77764889408;5355.491228333302;5380.300560927211;5412.918806217831;5427.158790387496;5753.97123014399;5982.641041537521;6101.359357267423;6116.204893363834;6136.938630613815;6141.692915354125;6383.1382763326355;6431.39215196201;6436.613803171825;6443.194600674916;6450.548461607643;4324.805383757802;4399.14216727735;4403.119376124724;4411.1618792429335;4427.645788336861;6098.664573448503;6163.3836616338;6175.197224360804;6195.783147589813;6334.271558770801;5951.9881620123815;5970.731317090655;5993.70031498432;6033.637981721111;6037.939620603738;5760.251167348218;6022.187004754477;6024.385368778873;6039.184710064261;6042.516598672008;5806.158107074366;5891.410858914246;5892.410758924073;5909.52723782105;5929.377415371324;5962.9105563415715;5985.443784615944;6024.8795024100145;6042.335343112342;6075.483583895241;5648.604597678123;5883.323417806836;5934.881302374015;5938.376470470538;5944 08:53:57 INFO - PROCESS | 9477 | |5;yui.html;619.7273199792091;675.7026908160409;700.6916956539123;763.1795819494046;785.9253370929763;13702.657433564165;14737.70524589509;15056.924715376435;15693.843061569396;15788.447404340835;14888.478903238389;14998.550043498712;15055;15056.473023444181;15072.623184420367;550.6558400999376;554.6090006545376;560.99861746782;568.6474385880739;572.6306532286673;570.4466667332681;571.4599703280402;571.8055861007257;572.1132245020223;573.1059547106527;588.4027711872453;593.7150167919401;594.0169020271458;594.194865956629;597.0924195223258;589.0780927847948;589.4812564942845;592.5970340168684;593.6438137117716;595.5354823237838;425.6254496043462;427.6215549238915;429.5854500407122;430.65332407412023;430.67484049542395;14261.928690356586;14271.357788899524;14298;14301.49944751939;14337.78493322601;15620.297086631128;15672.138032408213;15715.921420392939;15744.448944287009;15821.367145314174;12445.75108497825;12480.438380272819;12545.811812822814;12672.6831829205;12699.55551555691;3948.5261768587666;3973.562908080109;4004.799760011988;4095.610916962884;4128.793560321972;78926.21073789246;79371.6031419845;80547;80654;81821.18178818136;11896.16726829131;11899;11920.582779602846;11982.820257695967;12212.084093693009;23092.307230783103;23199.3040208794;23392.298231053097;23508.177213797437;24234;9079.50062746542;9086.637943960644;9140.862887056699;9261.629534818532;9548;4427.579379958899;4527.615152712056;4578.931316030262;4649.697769644962;4674.579287864109;3483.2511010132944;3591.8383672734267;3601.3517566838223;3601.567811862541;3619.8552057917914;584.2959234122872;589.8702285497184;596.4333882811346;601.1523751510349;603.414687752879;722.5484072454716;731.3087836760666;761.919998400171;765.9540427574364;770.3182683325298;9725.319227654138;9946.651867184613;10005.79988400228;10068.39589624625;10335.534900929477;645.4674893213117;662.900564915257;664.7872680742213;677.2685499660355;690.7962151165418;4613.653975951817;4667.463241727177;4811.472591647701;4862.149123903374;4882.26765985098;88223.11776882278;104169.95830041754;117871;120808;124225.37887310506;88643;103814;105356.47321763342;105617.47191263994;105635.4718226404;85258;85521.57239213763;86119.13880861236;86401;87645.56177219073;9721.416714997124;10155.89844101579;10175.491225438847;10237.897621023993;10396.896031039896;50360.748196258784;51028.23457648212;51520.74239628778;51662.74168629133;52458.213126802366;68110;68800.6559967197;76075.23924760682;78031;79180.60409697915;13665;13742.175469471864;13821.792673110112;13839.308034598029;14070.236726731317;15315.923420383273;15557.533274001798;15617.297221624827;15627.531174064796;15700.607484812972;14069.155850648995;14285.928570357082;14377.496787612383;14750.483733069292;14764.261786910396;14535.927320363331;14560.41758329655;14896.925515372353;15034.849651503782;15039.473618423302;11857.809680514296;13695.794563081363;13734.244616546186;13868.375923083284;14278.428862845785;11538.884611154117;11631.127665424958;11755;12064.879351206726;12810.423530940943;11944.76110477803;12295.262284262973;12321.753564928473;12372.81440778371;12424.254544727346 08:53:57 INFO - PROCESS | 9477 | __end_tp_report 08:53:57 INFO - PROCESS | 9477 | __start_cc_report 08:53:57 INFO - PROCESS | 9477 | _x_x_mozilla_cycle_collect,377 08:53:57 INFO - PROCESS | 9477 | __end_cc_report 08:53:57 INFO - PROCESS | 9477 | __startTimestamp1467734037334__endTimestamp 08:53:57 INFO - PROCESS | 9477 | 08:53:57 INFO - PROCESS | 9477 | ------- Summary: start ------- 08:53:57 INFO - PROCESS | 9477 | Number of tests: 6 08:53:57 INFO - PROCESS | 9477 | 08:53:57 INFO - PROCESS | 9477 | [#0] dojo.html Cycles:165 Average:5500.57 Median:5733.80 stddev:761.01 (13.3%) stddev-sans-first:740.01 08:53:57 INFO - PROCESS | 9477 | Values: 3116.8 3158.5 3170.3 3204.3 3221.8 5598.0 5627.6 5670.2 5675.2 5687.3 5386.7 5519.9 5535.2 5542.9 5557.3 4967.7 4989.5 5098.8 5136.1 5189.4 196.0 5017.5 5100.2 5118.8 5146.6 5093.2 5113.9 5125.6 5126.6 5146.9 4916.8 5134.3 5135.9 5150.7 5151.7 4941.3 4987.3 4989.7 5009.6 5027.2 5496.2 5500.7 5542.3 5576.1 5634.6 5804.1 5917.0 5926.7 5932.0 5934.5 6022.1 6092.8 6113.6 6115.7 6143.8 5639.7 5645.7 5657.7 5665.3 5673.2 5926.4 5929.1 5938.7 6195.4 6210.5 5787.9 5795.3 5796.9 5817.1 5864.4 5829.0 5874.4 5878.0 5897.2 5910.3 5786.7 5857.1 5866.1 5916.3 5952.9 5760.9 5795.1 5832.6 5850.2 6014.4 4489.6 4492.9 4493.8 4503.8 4535.3 3961.8 4003.3 4031.0 4037.9 4096.4 5587.2 5623.2 5643.5 5649.8 5682.6 5954.6 5975.9 5988.3 5989.0 5989.1 5542.7 5548.1 5570.5 5577.2 5658.5 5110.1 5211.8 5212.9 5216.3 5256.2 6239.1 6257.7 6266.8 6268.0 6278.3 5817.9 5919.5 5946.9 6076.9 6117.3 6105.7 6111.5 6127.0 6236.3 6242.4 5935.9 5936.1 5946.2 5956.1 5962.3 5874.3 5894.2 6038.0 6039.4 6062.4 5733.8 5810.7 5836.3 5839.6 5893.7 5666.2 5723.4 5739.0 5770.2 5777.6 5443.8 5575.8 5621.6 5695.7 5707.7 5873.6 5887.1 5890.2 5944.2 5987.9 5742.9 5750.0 5784.2 5795.3 5814.8 08:53:57 INFO - PROCESS | 9477 | 08:53:57 INFO - PROCESS | 9477 | [#1] ext.html Cycles:180 Average:59282.55 Median:38124.93 stddev:122390.53 (321.0%) stddev-sans-first:122654.52 08:53:57 INFO - PROCESS | 9477 | Values: 583.5 594.4 594.5 621.0 622.7 42488.4 43865.1 43867.0 43963.8 47160.3 37673.2 38019.8 38086.6 38119.2 38130.6 8649.8 8757.6 8791.0 8791.2 8793.6 8637.5 8640.0 8682.0 8694.4 8698.1 8695.4 8704.7 8739.6 8766.4 8768.3 8670.0 8677.8 8694.7 8706.5 8729.2 8890.8 8963.7 8984.8 8988.0 8991.4 35516.8 35622.8 36006.3 36027.3 36119.8 3573.5 3671.3 3672.9 3741.4 4136.2 28239.7 28413.6 28656.4 28762.0 29852.6 4412.8 4482.7 4518.5 4616.8 4639.0 356819.0 358504.0 358582.0 359080.0 359520.0 31905.1 32510.8 32696.7 57298.7 57359.4 33475.7 33496.8 33526.8 33633.0 33736.5 15144.1 15214.2 15357.9 15383.7 15456.8 12429.9 12460.8 12514.9 12561.4 12573.1 8860.9 8892.4 8902.4 8956.0 8974.3 3375.8 3386.2 3402.1 3433.1 3461.6 1018.9 1059.4 1063.5 1070.5 1088.3 32902.7 33202.5 33262.5 33450.5 33583.8 1091.3 1137.7 1150.2 1156.9 1166.6 16977.2 17373.4 17486.5 17638.7 17654.1 554918.0 559674.0 566611.0 566639.0 567395.0 56947.1 58023.4 58582.7 58709.4 58849.4 1151.7 1166.0 1175.2 1178.2 1304.6 31147.1 32605.2 32762.7 33015.8 33067.2 50787.7 51627.5 51694.5 51702.7 51816.7 428749.0 433489.0 435868.0 435883.0 438024.0 29469.5 29609.0 29703.4 29865.7 29867.3 48135.0 48960.8 49625.0 49999.0 50651.2 40910.4 41843.6 42170.2 42221.6 42416.5 41434.2 41593.6 41661.4 42328.8 43030.6 40926.6 41541.4 41577.0 42285.9 42451.6 32064.4 32796.8 32894.3 33264.0 33468.3 28093.3 28327.3 28343.9 28517.7 28645.6 08:53:57 INFO - PROCESS | 9477 | 08:53:57 INFO - PROCESS | 9477 | [#2] jquery.html Cycles:180 Average:29155.10 Median:2347.18 stddev:82540.72 (3516.6%) stddev-sans-first:82744.04 08:53:57 INFO - PROCESS | 9477 | Values: 402.8 403.5 405.1 410.5 425.2 18805.3 19060.2 19997.0 20394.0 20638.1 12220.3 12316.7 12351.9 12417.9 12722.9 5188.8 5428.1 5460.5 5462.7 5477.2 5214.6 5278.9 5360.1 5360.5 5417.8 5353.7 5366.4 5377.2 5392.4 5398.6 5258.3 5341.3 5416.5 5420.5 5429.8 5195.1 5195.9 5223.5 5235.7 5247.1 14049.2 14359.0 14363.3 14425.0 14441.9 2233.7 2511.0 2813.2 3024.9 3034.3 10488.4 10618.4 10677.3 10715.1 10727.3 1883.1 1963.9 1992.3 2010.2 2021.5 75020.2 75714.0 77797.6 81535.0 90829.0 9742.0 10280.2 10393.3 10595.4 10736.8 14300.0 14312.1 14335.9 14356.9 14409.7 8235.7 8555.8 8557.9 8706.7 8734.3 8509.3 8546.8 8657.5 8768.4 8876.8 4269.2 4295.5 4375.2 4385.4 4517.3 1891.2 1950.6 2101.8 2141.0 2169.3 895.6 955.2 975.7 1007.0 1023.3 19905.0 20028.0 20120.4 20205.2 20263.2 965.8 967.7 986.5 994.7 1051.2 10515.5 10616.7 10749.2 11152.8 11170.7 486845.0 493184.0 504950.6 507652.0 508106.0 91809.5 92899.0 94500.1 97542.0 98064.0 894.2 969.8 975.8 987.7 990.7 17634.3 17676.4 18162.5 18208.4 18289.4 43896.3 44124.1 44493.6 44573.6 44818.2 56920.0 57017.6 59303.7 60785.1 61343.4 7724.3 8122.2 8247.4 8454.7 8875.1 13275.4 13880.5 14247.9 14716.4 14948.9 11070.4 12098.3 12527.9 12561.2 12767.6 12773.6 12856.6 12857.7 12930.9 12950.6 12489.7 12722.8 12759.2 13121.1 13223.9 9038.7 9189.8 9190.9 9227.0 9370.1 9258.9 12659.0 12663.1 12675.2 12845.2 08:53:57 INFO - PROCESS | 9477 | 08:53:57 INFO - PROCESS | 9477 | [#3] mootools.html Cycles:180 Average:5894.43 Median:2596.22 stddev:3431.85 (132.2%) stddev-sans-first:3424.31 08:53:57 INFO - PROCESS | 9477 | Values: 1325.8 1378.2 1438.6 1441.9 1737.2 8038.7 8548.7 8573.4 9117.6 9130.0 8661.7 8883.0 8909.4 8980.2 8987.2 2343.2 2380.8 2383.2 2392.0 2398.2 2376.4 2391.4 2398.4 2403.3 2411.5 2365.3 2374.3 2382.8 2389.6 2392.3 2333.3 2349.0 2352.8 2362.4 2371.6 2326.2 2344.6 2348.1 2348.2 2357.5 9068.6 9083.0 9120.2 9124.3 9135.0 5207.3 5322.7 5338.1 5343.6 5344.7 3323.5 3372.2 3402.7 3415.2 3482.4 1119.1 1121.6 1148.6 1161.8 1163.7 12628.9 12737.2 12752.6 12778.9 12780.3 4727.5 4730.5 4763.6 4831.4 4887.4 10667.2 10688.4 10755.6 10765.2 10775.6 5261.0 5274.6 5283.8 5302.4 5309.8 4263.6 4775.4 4842.3 4900.2 4907.3 4045.2 4071.1 4075.7 4083.5 4089.8 1333.3 1335.0 1342.5 1345.4 1351.6 854.7 860.5 865.2 878.0 885.5 5902.5 5994.7 6020.8 6025.8 6135.0 444.2 451.5 452.6 460.9 465.0 3869.8 3874.8 3887.9 3930.9 4009.3 11130.6 11334.2 11396.1 11423.4 11522.7 11173.3 11271.1 11276.9 11285.4 11343.7 7982.8 8341.0 8369.0 8388.6 8555.1 5851.5 6076.4 6088.2 6141.0 6185.8 10208.9 10316.6 10374.3 10428.7 10446.9 10125.6 10524.1 10661.0 10697.6 10800.3 7353.8 7968.3 8067.9 8196.7 8313.8 8422.0 8662.5 8738.7 8766.3 8820.4 7446.7 7577.8 7679.3 7717.5 7725.2 7426.6 7530.8 7626.2 7674.2 7705.5 7163.2 7220.2 7231.2 7246.3 7281.5 5079.5 5125.0 5217.3 5233.6 5345.1 5060.5 5116.5 5175.5 5178.2 5221.9 08:53:57 INFO - PROCESS | 9477 | 08:53:57 INFO - PROCESS | 9477 | [#4] prototype.html Cycles:180 Average:4878.10 Median:5477.55 stddev:1432.49 (26.2%) stddev-sans-first:1395.47 08:53:57 INFO - PROCESS | 9477 | Values: 342.4 351.9 353.9 357.9 358.0 5684.3 5703.7 5786.1 5800.7 5821.5 5633.3 5664.9 5675.6 5678.7 5700.9 4272.2 4466.9 4474.6 4477.3 4482.9 4336.9 4339.9 4351.8 4357.7 4368.6 4270.7 4295.3 4295.7 4299.3 4301.8 4282.5 4314.9 4322.2 4328.2 4331.3 3717.4 3853.7 3855.7 3857.5 3863.2 5511.2 5534.9 5540.7 5562.0 5577.3 4982.1 5007.0 5068.5 5070.3 5092.2 5624.6 5955.4 5969.3 5971.7 5999.9 4269.8 4310.4 4312.5 4317.8 4323.2 5544.0 6186.3 6257.4 6267.5 6279.7 4336.1 4348.3 4374.7 4375.1 4396.9 4450.8 4461.8 4473.6 4474.2 4478.4 4938.7 5038.3 5096.8 5104.9 5141.4 5981.8 5990.9 5993.4 5995.0 6002.6 1506.9 1523.8 1524.3 1528.1 1533.1 939.5 964.5 978.7 978.8 989.5 4983.0 5074.7 5087.9 5088.3 5119.0 5411.4 5454.6 5455.9 5471.9 5494.2 4939.9 5075.2 5075.6 5122.2 5123.8 2863.3 2871.1 2871.5 2887.8 2903.7 5436.3 5483.2 5569.1 5569.5 5574.6 5232.1 5466.3 5517.7 5531.3 5535.8 5510.4 5520.8 5521.7 5534.8 5558.8 5355.5 5380.3 5412.9 5427.2 5754.0 5982.6 6101.4 6116.2 6136.9 6141.7 6383.1 6431.4 6436.6 6443.2 6450.5 4324.8 4399.1 4403.1 4411.2 4427.6 6098.7 6163.4 6175.2 6195.8 6334.3 5952.0 5970.7 5993.7 6033.6 6037.9 5760.3 6022.2 6024.4 6039.2 6042.5 5806.2 5891.4 5892.4 5909.5 5929.4 5962.9 5985.4 6024.9 6042.3 6075.5 5648.6 5883.3 5934.9 5938.4 5944.0 08:53:57 INFO - PROCESS | 9477 | 08:53:57 INFO - PROCESS | 9477 | [#5] yui.html Cycles:180 Average:21138.79 Median:3961.04 stddev:30042.65 (758.5%) stddev-sans-first:30087.42 08:53:57 INFO - PROCESS | 9477 | Values: 619.7 675.7 700.7 763.2 785.9 13702.7 14737.7 15056.9 15693.8 15788.4 14888.5 14998.6 15055.0 15056.5 15072.6 550.7 554.6 561.0 568.6 572.6 570.4 571.5 571.8 572.1 573.1 588.4 593.7 594.0 594.2 597.1 589.1 589.5 592.6 593.6 595.5 425.6 427.6 429.6 430.7 430.7 14261.9 14271.4 14298.0 14301.5 14337.8 15620.3 15672.1 15715.9 15744.4 15821.4 12445.8 12480.4 12545.8 12672.7 12699.6 3948.5 3973.6 4004.8 4095.6 4128.8 78926.2 79371.6 80547.0 80654.0 81821.2 11896.2 11899.0 11920.6 11982.8 12212.1 23092.3 23199.3 23392.3 23508.2 24234.0 9079.5 9086.6 9140.9 9261.6 9548.0 4427.6 4527.6 4578.9 4649.7 4674.6 3483.3 3591.8 3601.4 3601.6 3619.9 584.3 589.9 596.4 601.2 603.4 722.5 731.3 761.9 766.0 770.3 9725.3 9946.7 10005.8 10068.4 10335.5 645.5 662.9 664.8 677.3 690.8 4613.7 4667.5 4811.5 4862.1 4882.3 88223.1 104170.0 117871.0 120808.0 124225.4 88643.0 103814.0 105356.5 105617.5 105635.5 85258.0 85521.6 86119.1 86401.0 87645.6 9721.4 10155.9 10175.5 10237.9 10396.9 50360.7 51028.2 51520.7 51662.7 52458.2 68110.0 68800.7 76075.2 78031.0 79180.6 13665.0 13742.2 13821.8 13839.3 14070.2 15315.9 15557.5 15617.3 15627.5 15700.6 14069.2 14285.9 14377.5 14750.5 14764.3 14535.9 14560.4 14896.9 15034.8 15039.5 11857.8 13695.8 13734.2 13868.4 14278.4 11538.9 11631.1 11755.0 12064.9 12810.4 11944.8 12295.3 12321.8 12372.8 12424.3 08:53:57 INFO - PROCESS | 9477 | -------- Summary: end -------- 08:53:57 INFO - PROCESS | 9477 | 08:53:58 INFO - TEST-INFO | 9477: exit 0 08:53:58 INFO - TEST-OK | dromaeo_css | took 1110837ms 08:53:58 INFO - TEST-START | kraken 08:53:58 INFO - operating with platform_type : linux_ 08:53:58 INFO - Initialising browser for kraken test... 08:53:58 INFO - TEST-INFO | started process 9718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyR1FR6/profile http://localhost:36944/getInfo.html) 08:54:02 INFO - PROCESS | 9718 | __metrics Screen width/height:1600/1200 08:54:02 INFO - PROCESS | 9718 | colorDepth:24 08:54:02 INFO - PROCESS | 9718 | Browser inner width/height: 1024/697 08:54:02 INFO - PROCESS | 9718 | __metrics 08:54:03 ERROR - PROCESS | 9718 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:54:04 INFO - TEST-INFO | 9718: exit 0 08:54:04 INFO - Browser initialized. 08:54:04 INFO - Running cycle 1/1 for kraken test... 08:54:04 INFO - TEST-INFO | started process 9838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyR1FR6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:16 INFO - PROCESS | 9838 | RSS: Main: 168325120 08:54:16 INFO - PROCESS | 9838 | 08:54:18 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36944/tests/kraken/driver.html?testName=audio-beat-detection) 08:54:19 INFO - PROCESS | 9838 | RSS: Main: 173744128 08:54:19 INFO - PROCESS | 9838 | 08:54:22 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36944/tests/kraken/driver.html?testName=audio-dft) 08:54:22 INFO - PROCESS | 9838 | RSS: Main: 173899776 08:54:22 INFO - PROCESS | 9838 | 08:54:25 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36944/tests/kraken/driver.html?testName=audio-fft) 08:54:26 INFO - PROCESS | 9838 | RSS: Main: 168288256 08:54:26 INFO - PROCESS | 9838 | 08:54:28 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36944/tests/kraken/driver.html?testName=audio-oscillator) 08:54:28 INFO - PROCESS | 9838 | RSS: Main: 169357312 08:54:28 INFO - PROCESS | 9838 | 08:54:31 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:54:31 INFO - PROCESS | 9838 | RSS: Main: 169271296 08:54:31 INFO - PROCESS | 9838 | 08:54:34 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36944/tests/kraken/driver.html?testName=imaging-darkroom) 08:54:35 INFO - PROCESS | 9838 | RSS: Main: 169353216 08:54:35 INFO - PROCESS | 9838 | 08:54:38 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36944/tests/kraken/driver.html?testName=imaging-desaturate) 08:54:39 INFO - PROCESS | 9838 | RSS: Main: 167870464 08:54:39 INFO - PROCESS | 9838 | 08:54:42 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36944/tests/kraken/driver.html?testName=json-parse-financial) 08:54:43 INFO - PROCESS | 9838 | RSS: Main: 168505344 08:54:43 INFO - PROCESS | 9838 | 08:54:44 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:54:45 INFO - PROCESS | 9838 | RSS: Main: 169086976 08:54:45 INFO - PROCESS | 9838 | 08:54:46 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:54:47 INFO - PROCESS | 9838 | RSS: Main: 169127936 08:54:47 INFO - PROCESS | 9838 | 08:54:49 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:54:50 INFO - PROCESS | 9838 | RSS: Main: 169570304 08:54:50 INFO - PROCESS | 9838 | 08:54:52 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:54:53 INFO - PROCESS | 9838 | RSS: Main: 169885696 08:54:53 INFO - PROCESS | 9838 | 08:54:56 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:54:56 INFO - PROCESS | 9838 | RSS: Main: 169553920 08:54:56 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36944/tests/kraken/driver.html?testName=ai-astar) 08:54:58 INFO - PROCESS | 9838 | RSS: Main: 170323968 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | __start_tp_report 08:54:58 INFO - PROCESS | 9838 | _x_x_mozilla_page_load 08:54:58 INFO - PROCESS | 9838 | _x_x_mozilla_page_load_details 08:54:58 INFO - PROCESS | 9838 | |i|pagename|runs| 08:54:58 INFO - PROCESS | 9838 | |0;ai-astar;102;112;104;114;111;112;118;113;112;113 08:54:58 INFO - PROCESS | 9838 | |1;audio-beat-detection;145;117;152;182;123;148;148;119;188;119 08:54:58 INFO - PROCESS | 9838 | |2;audio-dft;164;164;163;162;162;166;178;164;162;164 08:54:58 INFO - PROCESS | 9838 | |3;audio-fft;75;76;76;167;75;75;76;75;162;80 08:54:58 INFO - PROCESS | 9838 | |4;audio-oscillator;84;84;151;83;85;84;134;86;89;143 08:54:58 INFO - PROCESS | 9838 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;117;118;118 08:54:58 INFO - PROCESS | 9838 | |6;imaging-darkroom;148;148;147;147;148;147;147;146;148;148 08:54:58 INFO - PROCESS | 9838 | |7;imaging-desaturate;96;96;96;96;96;101;95;96;95;95 08:54:58 INFO - PROCESS | 9838 | |8;json-parse-financial;54;53;53;55;55;53;54;53;52;55 08:54:58 INFO - PROCESS | 9838 | |9;json-stringify-tinderbox;61;61;60;60;61;60;60;60;61;61 08:54:58 INFO - PROCESS | 9838 | |10;stanford-crypto-aes;76;73;75;83;74;79;75;80;79;79 08:54:58 INFO - PROCESS | 9838 | |11;stanford-crypto-ccm;122;127;120;117;119;123;120;122;170;118 08:54:58 INFO - PROCESS | 9838 | |12;stanford-crypto-pbkdf2;157;156;151;155;153;155;153;157;154;156 08:54:58 INFO - PROCESS | 9838 | |13;stanford-crypto-sha256-iterative;63;64;62;70;60;62;62;63;66;64 08:54:58 INFO - PROCESS | 9838 | __end_tp_report 08:54:58 INFO - PROCESS | 9838 | __start_cc_report 08:54:58 INFO - PROCESS | 9838 | _x_x_mozilla_cycle_collect,927 08:54:58 INFO - PROCESS | 9838 | __end_cc_report 08:54:58 INFO - PROCESS | 9838 | __startTimestamp1467734098732__endTimestamp 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | ------- Summary: start ------- 08:54:58 INFO - PROCESS | 9838 | Number of tests: 14 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:4.70 (4.2%) stddev-sans-first:3.66 08:54:58 INFO - PROCESS | 9838 | Values: 102.0 112.0 104.0 114.0 111.0 112.0 118.0 113.0 112.0 113.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:148.00 stddev:25.60 (17.3%) stddev-sans-first:27.15 08:54:58 INFO - PROCESS | 9838 | Values: 145.0 117.0 152.0 182.0 123.0 148.0 148.0 119.0 188.0 119.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:4.77 (2.9%) stddev-sans-first:5.05 08:54:58 INFO - PROCESS | 9838 | Values: 164.0 164.0 163.0 162.0 162.0 166.0 178.0 164.0 162.0 164.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.50 stddev:37.36 (49.5%) stddev-sans-first:39.01 08:54:58 INFO - PROCESS | 9838 | Values: 75.0 76.0 76.0 167.0 75.0 75.0 76.0 75.0 162.0 80.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.00 stddev:28.19 (33.6%) stddev-sans-first:29.11 08:54:58 INFO - PROCESS | 9838 | Values: 84.0 84.0 151.0 83.0 85.0 84.0 134.0 86.0 89.0 143.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:54:58 INFO - PROCESS | 9838 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 08:54:58 INFO - PROCESS | 9838 | Values: 148.0 148.0 147.0 147.0 148.0 147.0 147.0 146.0 148.0 148.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.75 (1.8%) stddev-sans-first:1.86 08:54:58 INFO - PROCESS | 9838 | Values: 96.0 96.0 96.0 96.0 96.0 101.0 95.0 96.0 95.0 95.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.06 (2.0%) stddev-sans-first:1.12 08:54:58 INFO - PROCESS | 9838 | Values: 54.0 53.0 53.0 55.0 55.0 53.0 54.0 53.0 52.0 55.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 08:54:58 INFO - PROCESS | 9838 | Values: 61.0 61.0 60.0 60.0 61.0 60.0 60.0 60.0 61.0 61.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:79.00 stddev:3.16 (4.0%) stddev-sans-first:3.32 08:54:58 INFO - PROCESS | 9838 | Values: 76.0 73.0 75.0 83.0 74.0 79.0 75.0 80.0 79.0 79.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:122.00 stddev:15.79 (12.9%) stddev-sans-first:16.69 08:54:58 INFO - PROCESS | 9838 | Values: 122.0 127.0 120.0 117.0 119.0 123.0 120.0 122.0 170.0 118.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.50 stddev:1.95 (1.3%) stddev-sans-first:1.88 08:54:58 INFO - PROCESS | 9838 | Values: 157.0 156.0 151.0 155.0 153.0 155.0 153.0 157.0 154.0 156.0 08:54:58 INFO - PROCESS | 9838 | 08:54:58 INFO - PROCESS | 9838 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:2.76 (4.3%) stddev-sans-first:2.92 08:54:58 INFO - PROCESS | 9838 | Values: 63.0 64.0 62.0 70.0 60.0 62.0 62.0 63.0 66.0 64.0 08:54:58 INFO - PROCESS | 9838 | -------- Summary: end -------- 08:54:58 INFO - PROCESS | 9838 | 08:54:59 INFO - TEST-INFO | 9838: exit 0 08:54:59 INFO - TEST-OK | kraken | took 61639ms 08:54:59 INFO - SUITE-END | took 1172s 08:54:59 INFO - Completed test suite (00:19:32) 08:54:59 INFO - javascript benchmark 08:54:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7191.317726689486, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.766242531811, 3158.5104308832124, 3170.286685495764, 3204.311073119282, 3221.822799746013, 5598.048331783596, 5627.577931655127, 5670.234518340023, 5675.205471234025, 5687.2606561146995, 5386.676799392039, 5519.889602207963, 5535.169724541311, 5542.889142217154, 5557.305336832896, 4967.652264341488, 4989.476105008976, 5098.770555325019, 5136.126858434057, 5189.377274727038, 196.0104226197015, 5017.473165317644, 5100.183970564711, 5118.820841270556, 5146.588272938156, 5093.236014597803, 5113.897722045557, 5125.574074258556, 5126.615503837208, 5146.871328216825, 4916.803327866881, 5134.2812006319145, 5135.922961155586, 5150.742462876841, 5151.6908985461, 4941.283513890502, 4987.326710894019, 4989.65072444929, 5009.624278179114, 5027.245913113063, 5496.203050557687, 5500.669959802424, 5542.334919809608, 5576.107822748381, 5634.605577609569, 5804.071348584206, 5916.964531207064, 5926.733297001602, 5932.0, 5934.465898069151, 6022.09668549721, 6092.817215483543, 6113.572049956505, 6115.694215289218, 6143.78496752616, 5639.68981706006, 5645.745941432645, 5657.660540367591, 5665.3201615806365, 5673.23411339468, 5926.377730338339, 5929.0513517836935, 5938.673372964442, 6195.380461953769, 6210.472109870711, 5787.9131813021995, 5795.304563452329, 5796.855078623068, 5817.127430885401, 5864.4428779266755, 5829.0, 5874.383189765099, 5877.970610146922, 5897.203877476486, 5910.261217347832, 5786.681732504752, 5857.062869940789, 5866.061430171152, 5916.290045194518, 5952.8809423812145, 5760.855978600569, 5795.1017592273265, 5832.562557808182, 5850.239468869105, 6014.36849130835, 4489.6408287336935, 4492.932606010912, 4493.775311234425, 4503.774811259424, 4535.297028960516, 3961.8217180226957, 4003.259397011562, 4030.9922519370157, 4037.8788636340955, 4096.426500289962, 5587.161925711176, 5623.212750214973, 5643.492085712305, 5649.774009039593, 5682.602217844711, 5954.55340849438, 5975.940240597625, 5988.3113441953865, 5989.0, 5989.071693887455, 5542.722863856791, 5548.0845660465575, 5570.470805273492, 5577.2191893135, 5658.5473162147755, 5110.105731496973, 5211.765470553834, 5212.947870521246, 5216.347956505437, 5256.211568264791, 6239.095331176954, 6257.7184026718905, 6266.780662676784, 6268.028455589391, 6278.340774218733, 5817.883642327045, 5919.496842768241, 5946.910796337972, 6076.939230607726, 6117.296510901126, 6105.6947152641305, 6111.470193407285, 6126.9757403264, 6236.34518375564, 6242.375762423721, 5935.9109613356695, 5936.13925980739, 5946.197263369563, 5956.106584012433, 5962.25471816023, 5874.295084589877, 5894.174815525744, 6038.0, 6039.396060394101, 6062.393760624079, 5733.799317023884, 5810.709464526842, 5836.299644042742, 5839.591228613956, 5893.734781934909, 5666.2350582670815, 5723.399043100415, 5738.971305143615, 5770.163326317745, 5777.62445441045, 5443.7822487100075, 5575.804846830341, 5621.550275977994, 5695.7436915338085, 5707.743151558273, 5873.588848780544, 5887.087501437284, 5890.2342695449315, 5944.1975333331175, 5987.940120598738, 5742.856428589319, 5750.0, 5784.190213370216, 5795.304563452412, 5814.796482123105], "value": 5450.769141120816, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4661284924294, 594.4026253615116, 594.5243804956035, 621.028091037526, 622.6730966242721, 42488.36267455987, 43865.12269754603, 43866.99999999996, 43963.78018109909, 47160.29259561109, 37673.24653506935, 38019.809900950524, 38086.61913380865, 38119.23761524768, 38130.618693813056, 8649.827003459943, 8757.56212189388, 8791.032986371494, 8791.20879120879, 8793.604287807031, 8637.481751094923, 8640.0, 8681.95659021704, 8694.434861733998, 8698.130186981283, 8695.39132260742, 8704.651813927436, 8739.563021848913, 8766.386352955296, 8768.298536117127, 8669.95665021674, 8677.783055423602, 8694.739157825275, 8706.477611343307, 8729.170728780755, 8890.822183556358, 8963.686270980485, 8984.775380615472, 8988.0, 8991.370604057718, 35516.82241588801, 35622.82188589066, 36006.27987440237, 36027.27945441103, 36119.81940090283, 3573.4818451324413, 3671.3391589513876, 3672.944905826415, 3741.38267185914, 4136.172765446892, 28239.717602823916, 28413.57379639307, 28656.426871462663, 28762.0, 29852.55221171684, 4412.75729834859, 4482.731036137842, 4518.457785065781, 4616.76916154191, 4638.976805115986, 356819.0, 358504.0, 358582.0, 359080.0, 359520.0, 31905.128538431654, 32510.83744581262, 32696.673033269362, 57298.7135064322, 57359.426405736245, 33475.656704030975, 33496.83251583727, 33526.83236583802, 33633.0, 33736.49395259073, 15144.091354518765, 15214.163221022729, 15357.923210383877, 15383.692326153414, 15456.768148477782, 12429.937850310691, 12460.750784984431, 12514.937425312815, 12561.434735436927, 12573.119881608383, 8860.911390886138, 8892.377533572588, 8902.376833621714, 8955.955220223988, 8974.326925480615, 3375.7636965412676, 3386.2211691311136, 3402.0984439123654, 3433.124553238958, 3461.6365281645067, 1018.872640919885, 1059.3855563772993, 1063.500154927183, 1070.5057216685104, 1088.2654208409292, 32902.67097329044, 33202.50196247058, 33262.50106248408, 33450.49824252638, 33583.83208083944, 1091.3397394576325, 1137.6643890052455, 1150.2178518607261, 1156.919015668912, 1166.6441735270655, 16977.236024378934, 17373.391931282345, 17486.47540573785, 17638.735418968725, 17654.11729413524, 554918.0, 559674.0, 566611.0, 566639.0, 567395.0, 56947.14579281314, 58023.4197658018, 58582.70708646515, 58709.41290587125, 58849.411505884396, 1151.6896499469603, 1165.9883401166048, 1175.1773758369177, 1178.216486036776, 1304.6151385341348, 31147.065588032394, 32605.18487037843, 32762.672373275964, 33015.83492082524, 33067.17332066718, 50787.746061269456, 51627.48372516377, 51694.48305517047, 51702.741486292325, 51816.74091629518, 428749.0, 433489.0, 435868.0, 435883.0, 438024.0, 29469.526523674158, 29609.0, 29703.405931881673, 29865.701342986293, 29867.253318667208, 48135.0, 48960.75519622522, 49625.0, 49999.0, 50651.24023139729, 40910.386344204264, 41843.581564183965, 42170.15659686728, 42221.577784222995, 42416.455012699334, 41434.171316572894, 41593.58406416018, 41661.37507937444, 42328.78835605802, 43030.569694302656, 40926.59073409228, 41541.37687934623, 41577.0, 42285.94285142896, 42451.575484244764, 32064.35871282608, 32796.83601581977, 32894.34211315712, 33264.0, 33468.33063338768, 28093.297667557657, 28327.2918177039, 28343.858280708464, 28517.714822851507, 28645.570316445686], "value": 18650.357395352337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.8267844826727, 403.48958567412217, 405.1168452772954, 410.4971410022722, 425.1666733202922, 18805.341813036546, 19060.237590496363, 19997.0, 20394.0, 20638.071286792092, 12220.32788196651, 12316.692082697937, 12351.876481235186, 12417.937910310458, 12722.872771272285, 5188.792448302063, 5428.131498960167, 5460.535854452376, 5462.672239665613, 5477.20580515825, 5214.60890433219, 5278.868028299285, 5360.142377219646, 5360.463953604647, 5417.810376636819, 5353.705546194958, 5366.409694933554, 5377.166539186433, 5392.433794451585, 5398.649087809299, 5258.316418865561, 5341.252224688546, 5416.485433883775, 5420.4850539198715, 5429.809956651518, 5195.090859099642, 5195.896082078338, 5223.503767142115, 5235.712035838027, 5247.081760691902, 14049.157050576998, 14359.0, 14363.281835908163, 14425.0, 14441.85558144426, 2233.7096177496983, 2510.9748902510923, 2813.1841765887866, 3024.894128705507, 3034.2717747740603, 10488.370697758159, 10618.415987120705, 10677.30597511167, 10715.08921741653, 10727.302725322907, 1883.1243471785685, 1963.9116239769244, 1992.2927360787003, 2010.2160157538572, 2021.4643119573177, 75020.24979750188, 75714.0, 77797.61101194515, 81535.0, 90829.0, 9741.951290243504, 10280.177585793119, 10393.272470926962, 10595.417252051211, 10736.818949915503, 14300.0, 14312.141271523742, 14335.856641433453, 14356.928215358856, 14409.711805763825, 8235.711750088718, 8555.786105347292, 8557.871631925525, 8706.6517339307, 8734.344924130715, 8509.27671147947, 8546.829063418696, 8657.523836188944, 8768.386212965032, 8876.778080548038, 4269.188854117708, 4295.52749197588, 4375.190589740844, 4385.407969924019, 4517.322401639714, 1891.1678861300984, 1950.6488832010375, 2101.8318534517202, 2140.989295053546, 2169.28413623507, 895.5701263393607, 955.1690029674228, 975.6829030565095, 1006.9899301007042, 1023.2785885950387, 19905.0, 20028.0, 20120.39638810838, 20205.191792328435, 20263.189472420938, 965.7875267441152, 967.7193613852045, 986.5215370545279, 994.7314225159312, 1051.164324362134, 10515.474226288656, 10616.681499555025, 10749.247552671239, 11152.776944461066, 11170.664880053611, 486845.0, 493184.0, 504950.55397403304, 507652.0, 508106.0, 91809.54095229614, 92899.0, 94500.10999779966, 97542.0, 98064.0, 894.1505569708803, 969.7672558585889, 975.7609385700407, 987.7481242283171, 990.6681261777385, 17634.294628214728, 17676.381326653507, 18162.545936351697, 18208.36270730518, 18289.359872404402, 43896.34155487606, 44124.11751765011, 44493.55506444894, 44573.55426445694, 44818.21762040242, 56920.0, 57017.58332958362, 59303.703481484044, 60785.0882236758, 61343.38656613377, 7724.266194711493, 8122.228388303101, 8247.422680412554, 8454.746357609281, 8875.068117847533, 13275.40260688252, 13880.54254303324, 14247.928760356132, 14716.411343546566, 14948.850511494746, 11070.446477676245, 12098.334591597546, 12527.937360313505, 12561.246325220516, 12767.553135640208, 12773.61679149627, 12856.614301570968, 12857.678558036125, 12930.935345323212, 12950.611481655566, 12489.687757806127, 12722.809157862825, 12759.234445933274, 13121.147125436815, 13223.867761322264, 9038.728838134866, 9189.77025574366, 9190.862137067816, 9226.953865230631, 9370.10983956523, 9258.861117083385, 12659.0, 12663.050271229878, 12675.239485630524, 12845.229286242855], "value": 9103.622881111636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.814385985962, 1378.2350795308605, 1438.6115748747839, 1441.913485190888, 1737.166160243084, 8038.718644847431, 8548.700795472152, 8573.442726222791, 9117.58970846311, 9129.954350228249, 8661.653533858638, 8883.0, 8909.420887642298, 8980.191782739552, 8987.236084932772, 2343.2033108743067, 2380.75002124777, 2383.2135395319588, 2392.0, 2398.1606437746736, 2376.4415362389823, 2391.4260577461373, 2398.424378149249, 2403.3270684208364, 2411.5056413435204, 2365.3495288795634, 2374.252110585169, 2382.797462215705, 2389.6415537669313, 2392.342105920877, 2333.3349995251274, 2349.0, 2352.752960939102, 2362.3857796972825, 2371.5968285391523, 2326.1974618756503, 2344.601417758985, 2348.107719066744, 2348.248560460653, 2357.5284943011466, 9068.591913363915, 9083.0, 9120.179183873417, 9124.270058395312, 9134.954325228398, 5207.323048003773, 5322.680639161624, 5338.119210330291, 5343.625946183769, 5344.706041167734, 3323.501474778778, 3372.241245719718, 3402.659734026602, 3415.2315728961034, 3482.355764183634, 1119.1326721790597, 1121.5625905896707, 1148.5922497513345, 1161.8373427720126, 1163.650904728578, 12628.936855315756, 12737.172083814523, 12752.617421477278, 12778.936105319506, 12780.297083660394, 4727.456342520585, 4730.454196062733, 4763.571278584944, 4831.444383895827, 4887.413510378778, 10667.199960002876, 10688.412137332522, 10755.623553175601, 10765.246432749633, 10775.6228532001, 5261.0, 5274.604404669665, 5283.762230699551, 5302.416734159239, 5309.840704778863, 4263.55232700562, 4775.379200703956, 4842.346283251786, 4900.240462728283, 4907.263910413395, 4045.1707399982934, 4071.1043570414463, 4075.7146999709735, 4083.4691490106097, 4089.828944009152, 1333.280028784465, 1334.9666258343618, 1342.5099838559051, 1345.3945724424048, 1351.574254109952, 854.7179430787825, 860.5396113079597, 865.1564724393666, 878.0297770963122, 885.526243459746, 5902.5277977762535, 5994.730237139339, 6020.849478763066, 6025.849353766191, 6135.049067394561, 444.2492188201993, 451.4988362917159, 452.6084936529878, 460.8617414775621, 464.98372556960345, 3869.7871617061332, 3874.845006199777, 3887.9222415552094, 3930.9213815723524, 4009.258287216874, 11130.610428634958, 11334.206605537533, 11396.14528910335, 11423.371714555613, 11522.711932201595, 11173.329600224013, 11271.09831213501, 11276.887231127748, 11285.435728213557, 11343.716407089723, 7982.760517184493, 8341.0, 8369.0, 8388.622511986976, 8555.058943516207, 5851.531877449879, 6076.361981992004, 6088.208532890696, 6141.0, 6185.752569897334, 10208.948955255177, 10316.587336506456, 10374.27380083387, 10428.687139385831, 10446.947765261126, 10125.64560240388, 10524.105451036441, 10661.0, 10697.572097116028, 10800.297980631234, 7353.77938661841, 7968.282854543119, 8067.878981815395, 8196.713115040944, 8313.750587482386, 8422.0, 8662.480251184948, 8738.737837864874, 8766.34252431083, 8820.382573219813, 7446.70213191488, 7577.848443031219, 7679.2704693054075, 7717.459777815499, 7725.188855170351, 7426.628668566658, 7530.811729706582, 7626.161122276656, 7674.2325767425045, 7705.499142555716, 7163.212046674966, 7220.241874603301, 7231.240719724353, 7246.311600397954, 7281.526700764433, 5079.466656001215, 5124.9743751281, 5217.269582258563, 5233.6074794389815, 5345.064613692666, 5060.544550990428, 5116.488351164854, 5175.534201921845, 5178.249153872743, 5221.869453263699], "value": 4601.44773620518, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.4059257188779, 351.9260955199408, 353.88675623800384, 357.94809752585877, 357.9821008949552, 5684.289463817023, 5703.657780533171, 5786.103154011124, 5800.651960882345, 5821.50517206037, 5633.267675202228, 5664.915026274609, 5675.602707810455, 5678.716064196794, 5700.8859822803515, 4272.166927449149, 4466.9329960050545, 4474.574915383034, 4477.328400739882, 4482.887927801815, 4336.891577710567, 4339.871633375329, 4351.760653164075, 4357.651387888977, 4368.584984426474, 4270.701050926436, 4295.269804133305, 4295.742255464666, 4299.31211006239, 4301.827926882921, 4282.507511636155, 4314.935275970863, 4322.178786030644, 4328.156009578133, 4331.285337919239, 3717.368047431943, 3853.6724378427866, 3855.749376290532, 3857.5370955485523, 3863.16941857502, 5511.173324001392, 5534.944650553483, 5540.667559946416, 5561.972190139064, 5577.274954255961, 4982.078315511642, 5006.973570418056, 5068.479456163136, 5070.315507406527, 5092.159793634046, 5624.634398764068, 5955.434233747787, 5969.283685957713, 5971.731272092767, 5999.880002399971, 4269.765162916038, 4310.4396428464415, 4312.547182545819, 4317.84887528935, 4323.200207961537, 5544.0, 6186.288576813679, 6257.374262573751, 6267.5299352548745, 6279.686015699197, 4336.132773445323, 4348.260795664744, 4374.731327914933, 4375.146846364928, 4396.868093957187, 4450.753788939102, 4461.754603496774, 4473.597376236155, 4474.232678092136, 4478.39541661878, 4938.678985865908, 5038.34501514808, 5096.847094587094, 5104.872378190575, 5141.38303403594, 5981.790637327673, 5990.880182396328, 5993.400659933972, 5994.970025149846, 6002.639841609517, 1506.9171195584347, 1523.8323784383708, 1524.3216768538116, 1528.0678785940568, 1533.1031346662105, 939.5302348825587, 964.5466630683568, 978.6770365779419, 978.814025335184, 989.5398639632606, 4982.950170498321, 5074.746262686851, 5087.947231661048, 5088.313077734459, 5118.952419032416, 5411.377691565521, 5454.563634909197, 5455.881544283412, 5471.890562188734, 5494.203340515603, 4939.887216730666, 5075.238714192827, 5075.6144612032285, 5122.206058061007, 5123.769430375642, 2863.3271181272385, 2871.0956048844546, 2871.468778275984, 2887.768978481716, 2903.7096290370796, 5436.260396673106, 5483.204935284361, 5569.106503788731, 5569.470900264469, 5574.58190635704, 5232.090287045201, 5466.305445311966, 5517.724113794375, 5531.25328080712, 5535.809800892827, 5510.393856675762, 5520.806771762969, 5521.70849097628, 5534.833954981357, 5558.77764889408, 5355.491228333302, 5380.300560927211, 5412.918806217831, 5427.158790387496, 5753.97123014399, 5982.641041537521, 6101.359357267423, 6116.204893363834, 6136.938630613815, 6141.692915354125, 6383.1382763326355, 6431.39215196201, 6436.613803171825, 6443.194600674916, 6450.548461607643, 4324.805383757802, 4399.14216727735, 4403.119376124724, 4411.1618792429335, 4427.645788336861, 6098.664573448503, 6163.3836616338, 6175.197224360804, 6195.783147589813, 6334.271558770801, 5951.9881620123815, 5970.731317090655, 5993.70031498432, 6033.637981721111, 6037.939620603738, 5760.251167348218, 6022.187004754477, 6024.385368778873, 6039.184710064261, 6042.516598672008, 5806.158107074366, 5891.410858914246, 5892.410758924073, 5909.52723782105, 5929.377415371324, 5962.9105563415715, 5985.443784615944, 6024.8795024100145, 6042.335343112342, 6075.483583895241, 5648.604597678123, 5883.323417806836, 5934.881302374015, 5938.376470470538, 5944.0], "value": 4422.8095368139675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.7273199792091, 675.7026908160409, 700.6916956539123, 763.1795819494046, 785.9253370929763, 13702.657433564165, 14737.70524589509, 15056.924715376435, 15693.843061569396, 15788.447404340835, 14888.478903238389, 14998.550043498712, 15055.0, 15056.473023444181, 15072.623184420367, 550.6558400999376, 554.6090006545376, 560.99861746782, 568.6474385880739, 572.6306532286673, 570.4466667332681, 571.4599703280402, 571.8055861007257, 572.1132245020223, 573.1059547106527, 588.4027711872453, 593.7150167919401, 594.0169020271458, 594.194865956629, 597.0924195223258, 589.0780927847948, 589.4812564942845, 592.5970340168684, 593.6438137117716, 595.5354823237838, 425.6254496043462, 427.6215549238915, 429.5854500407122, 430.65332407412023, 430.67484049542395, 14261.928690356586, 14271.357788899524, 14298.0, 14301.49944751939, 14337.78493322601, 15620.297086631128, 15672.138032408213, 15715.921420392939, 15744.448944287009, 15821.367145314174, 12445.75108497825, 12480.438380272819, 12545.811812822814, 12672.6831829205, 12699.55551555691, 3948.5261768587666, 3973.562908080109, 4004.799760011988, 4095.610916962884, 4128.793560321972, 78926.21073789246, 79371.6031419845, 80547.0, 80654.0, 81821.18178818136, 11896.16726829131, 11899.0, 11920.582779602846, 11982.820257695967, 12212.084093693009, 23092.307230783103, 23199.3040208794, 23392.298231053097, 23508.177213797437, 24234.0, 9079.50062746542, 9086.637943960644, 9140.862887056699, 9261.629534818532, 9548.0, 4427.579379958899, 4527.615152712056, 4578.931316030262, 4649.697769644962, 4674.579287864109, 3483.2511010132944, 3591.8383672734267, 3601.3517566838223, 3601.567811862541, 3619.8552057917914, 584.2959234122872, 589.8702285497184, 596.4333882811346, 601.1523751510349, 603.414687752879, 722.5484072454716, 731.3087836760666, 761.919998400171, 765.9540427574364, 770.3182683325298, 9725.319227654138, 9946.651867184613, 10005.79988400228, 10068.39589624625, 10335.534900929477, 645.4674893213117, 662.900564915257, 664.7872680742213, 677.2685499660355, 690.7962151165418, 4613.653975951817, 4667.463241727177, 4811.472591647701, 4862.149123903374, 4882.26765985098, 88223.11776882278, 104169.95830041754, 117871.0, 120808.0, 124225.37887310506, 88643.0, 103814.0, 105356.47321763342, 105617.47191263994, 105635.4718226404, 85258.0, 85521.57239213763, 86119.13880861236, 86401.0, 87645.56177219073, 9721.416714997124, 10155.89844101579, 10175.491225438847, 10237.897621023993, 10396.896031039896, 50360.748196258784, 51028.23457648212, 51520.74239628778, 51662.74168629133, 52458.213126802366, 68110.0, 68800.6559967197, 76075.23924760682, 78031.0, 79180.60409697915, 13665.0, 13742.175469471864, 13821.792673110112, 13839.308034598029, 14070.236726731317, 15315.923420383273, 15557.533274001798, 15617.297221624827, 15627.531174064796, 15700.607484812972, 14069.155850648995, 14285.928570357082, 14377.496787612383, 14750.483733069292, 14764.261786910396, 14535.927320363331, 14560.41758329655, 14896.925515372353, 15034.849651503782, 15039.473618423302, 11857.809680514296, 13695.794563081363, 13734.244616546186, 13868.375923083284, 14278.428862845785, 11538.884611154117, 11631.127665424958, 11755.0, 12064.879351206726, 12810.423530940943, 11944.76110477803, 12295.262284262973, 12321.753564928473, 12372.81440778371, 12424.254544727346], "value": 7342.752603185255, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 104.0, 114.0, 111.0, 112.0, 118.0, 113.0, 112.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 152.0, 182.0, 123.0, 148.0, 148.0, 119.0, 188.0, 119.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 162.0, 162.0, 166.0, 178.0, 164.0, 162.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 167.0, 75.0, 75.0, 76.0, 75.0, 162.0, 80.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 151.0, 83.0, 85.0, 84.0, 134.0, 86.0, 89.0, 143.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 148.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 101.0, 95.0, 96.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 55.0, 55.0, 53.0, 54.0, 53.0, 52.0, 55.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 75.0, 83.0, 74.0, 79.0, 75.0, 80.0, 79.0, 79.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 127.0, 120.0, 117.0, 119.0, 123.0, 120.0, 122.0, 170.0, 118.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 151.0, 155.0, 153.0, 155.0, 153.0, 157.0, 154.0, 156.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 70.0, 60.0, 62.0, 62.0, 63.0, 66.0, 64.0], "value": 63.6, "unit": "score"}]}]} 08:54:59 INFO - Return code: 0 08:55:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:55:00 ERROR - # TBPL SUCCESS # 08:55:00 INFO - Running post-action listener: _resource_record_post_action 08:55:00 INFO - ##### 08:55:00 INFO - ##### Finished run-tests step (success) 08:55:00 INFO - ##### 08:55:00 INFO - Running post-run listener: _resource_record_post_run 08:55:00 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557101056; Read time: 12; Write time: 513344 08:55:00 INFO - TinderboxPrint: CPU usage
13.3% 08:55:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:55:00 INFO - TinderboxPrint: I/O write bytes / time
557,101,056 / 513,344 08:55:00 INFO - TinderboxPrint: CPU idle
8,226.1 (86.6%) 08:55:00 INFO - TinderboxPrint: CPU user
1,213.5 (12.8%) 08:55:00 INFO - TinderboxPrint: Swap in / out
0 / 0 08:55:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 266510336; Read time: 0; Write time: 317756 08:55:00 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 289976320; Read time: 0; Write time: 195588 08:55:00 INFO - Running post-run listener: _upload_blobber_files 08:55:00 INFO - Blob upload gear active. 08:55:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:55:00 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 08:55:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:55:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:06 INFO - (blobuploader) - INFO - Done attempting. 08:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:07 INFO - (blobuploader) - INFO - Done attempting. 08:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:08 INFO - (blobuploader) - INFO - Done attempting. 08:55:08 INFO - (blobuploader) - INFO - Iteration through files over. 08:55:08 INFO - Return code: 0 08:55:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:55:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:55:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ec4c2c926fce6414072ed11b42db6e7b4a06acfce4719df1b52cf002202384f33a3216ae4ea8ae9265845eb4858f796946d2c0b1f894844f67df55747813aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45053ea3b6a67dac33ada38b26d1fd2317cebe43ad0d64f2508a5bf1af853157342c4d5d529f9048d67552c83a8e3bf608803fbd188546f09221461db500fdb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac2c0bd8c6b723f513b6fb4de696b74f86401250a4e3c2664720eae2a90cf23b08d6dc777db7d90baf2d1dd8f48b57419f7a8c1af359231831b9f4e07f4d242d"} 08:55:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:55:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:55:08 INFO - Contents: 08:55:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ec4c2c926fce6414072ed11b42db6e7b4a06acfce4719df1b52cf002202384f33a3216ae4ea8ae9265845eb4858f796946d2c0b1f894844f67df55747813aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45053ea3b6a67dac33ada38b26d1fd2317cebe43ad0d64f2508a5bf1af853157342c4d5d529f9048d67552c83a8e3bf608803fbd188546f09221461db500fdb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac2c0bd8c6b723f513b6fb4de696b74f86401250a4e3c2664720eae2a90cf23b08d6dc777db7d90baf2d1dd8f48b57419f7a8c1af359231831b9f4e07f4d242d"} 08:55:08 INFO - Running post-run listener: copy_logs_to_upload_dir 08:55:08 INFO - Copying logs to upload dir... 08:55:08 INFO - mkdir: /builds/slave/test/build/upload/logs 08:55:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.061101 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-05 08:55:06.512816) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:55:06.516488) ========= 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=232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ec4c2c926fce6414072ed11b42db6e7b4a06acfce4719df1b52cf002202384f33a3216ae4ea8ae9265845eb4858f796946d2c0b1f894844f67df55747813aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45053ea3b6a67dac33ada38b26d1fd2317cebe43ad0d64f2508a5bf1af853157342c4d5d529f9048d67552c83a8e3bf608803fbd188546f09221461db500fdb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac2c0bd8c6b723f513b6fb4de696b74f86401250a4e3c2664720eae2a90cf23b08d6dc777db7d90baf2d1dd8f48b57419f7a8c1af359231831b9f4e07f4d242d"} build_url:https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/U1QeAVmLRH2dauOKklu7uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ec4c2c926fce6414072ed11b42db6e7b4a06acfce4719df1b52cf002202384f33a3216ae4ea8ae9265845eb4858f796946d2c0b1f894844f67df55747813aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45053ea3b6a67dac33ada38b26d1fd2317cebe43ad0d64f2508a5bf1af853157342c4d5d529f9048d67552c83a8e3bf608803fbd188546f09221461db500fdb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac2c0bd8c6b723f513b6fb4de696b74f86401250a4e3c2664720eae2a90cf23b08d6dc777db7d90baf2d1dd8f48b57419f7a8c1af359231831b9f4e07f4d242d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:55:06.541782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:55:06.542112) ========= 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=232498196343f89f466a4a9a000001c8-1467732875.825531-1514989754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:55:06.623752) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:55:06.624071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:55:06.624355) ========= ========= Total master_lag: 0.16 =========