builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1467191940.59 results: success (0) buildid: 20160628233029 builduid: bcf5534bf1f04266b156d89acb86d2da revision: e1af8a633527ae1c95bf0e630a75f9810be3995d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:00.593166) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:00.594018) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:00.594299) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:00.638703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:00.638995) ========= 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=ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 02:19:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2016-06-29 02:19:01 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097769 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:00.751066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:00.751375) ========= 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=ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017584 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:00.836303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 02:19:00.836667) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1af8a633527ae1c95bf0e630a75f9810be3995d --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 e1af8a633527ae1c95bf0e630a75f9810be3995d --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=ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 02:19:01,456 truncating revision to first 12 chars 2016-06-29 02:19:01,456 Setting DEBUG logging. 2016-06-29 02:19:01,456 attempt 1/10 2016-06-29 02:19:01,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1af8a633527?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 02:19:02,660 unpacking tar archive at: fx-team-e1af8a633527/testing/mozharness/ program finished with exit code 0 elapsedTime=1.561964 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 02:19:02.412764) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:02.413132) ========= script_repo_revision: e1af8a633527ae1c95bf0e630a75f9810be3995d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:02.413595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:02.413872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:02.423741) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 40 secs) (at 2016-06-29 02:19:02.424078) ========= /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=ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:19:03 INFO - MultiFileLogger online at 20160629 02:19:03 in /builds/slave/test 02:19:03 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 02:19:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:19:03 INFO - {'append_to_log': False, 02:19:03 INFO - 'base_work_dir': '/builds/slave/test', 02:19:03 INFO - 'blob_upload_branch': 'Fx-Team', 02:19:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:19:03 INFO - 'branch': 'Fx-Team', 02:19:03 INFO - 'buildbot_json_path': 'buildprops.json', 02:19:03 INFO - 'config_files': ('talos/linux_config.py',), 02:19:03 INFO - 'default_actions': ('clobber', 02:19:03 INFO - 'read-buildbot-config', 02:19:03 INFO - 'download-and-extract', 02:19:03 INFO - 'populate-webroot', 02:19:03 INFO - 'create-virtualenv', 02:19:03 INFO - 'install', 02:19:03 INFO - 'run-tests'), 02:19:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:19:03 INFO - 'download_minidump_stackwalk': True, 02:19:03 INFO - 'download_symbols': 'ondemand', 02:19:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:19:03 INFO - 'tooltool.py': '/tools/tooltool.py', 02:19:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:19:03 INFO - '/tools/misc-python/virtualenv.py')}, 02:19:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:19:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:19:03 INFO - 'installer_path': 'installer.exe', 02:19:03 INFO - 'log_level': 'info', 02:19:03 INFO - 'log_name': 'talos', 02:19:03 INFO - 'log_to_console': True, 02:19:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:19:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:19:03 INFO - 'opt_config_files': (), 02:19:03 INFO - 'pip_index': False, 02:19:03 INFO - 'sps_profile': False, 02:19:03 INFO - 'sps_profile_interval': 0, 02:19:03 INFO - 'suite': 'dromaeojs-e10s', 02:19:03 INFO - 'system_bits': '32', 02:19:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:19:03 INFO - 'title': 'talos-linux64-ix-035', 02:19:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:19:03 INFO - 'use_talos_json': True, 02:19:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:19:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:19:03 INFO - 'work_dir': 'build'} 02:19:03 INFO - ##### 02:19:03 INFO - ##### Running clobber step. 02:19:03 INFO - ##### 02:19:03 INFO - Running pre-action listener: _resource_record_pre_action 02:19:03 INFO - Running main action method: clobber 02:19:03 INFO - rmtree: /builds/slave/test/build 02:19:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:19:04 INFO - Running post-action listener: _resource_record_post_action 02:19:04 INFO - ##### 02:19:04 INFO - ##### Finished clobber step (success) 02:19:04 INFO - ##### 02:19:04 INFO - ##### 02:19:04 INFO - ##### Running read-buildbot-config step. 02:19:04 INFO - ##### 02:19:04 INFO - Running pre-action listener: _resource_record_pre_action 02:19:04 INFO - Running main action method: read_buildbot_config 02:19:04 INFO - Using buildbot properties: 02:19:04 INFO - { 02:19:04 INFO - "project": "", 02:19:04 INFO - "product": "firefox", 02:19:04 INFO - "script_repo_revision": "production", 02:19:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:19:04 INFO - "repository": "", 02:19:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:19:04 INFO - "buildid": "20160628233029", 02:19:04 INFO - "pgo_build": "True", 02:19:04 INFO - "basedir": "/builds/slave/test", 02:19:04 INFO - "buildnumber": 514, 02:19:04 INFO - "slavename": "talos-linux64-ix-035", 02:19:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:19:04 INFO - "platform": "ubuntu64_hw", 02:19:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:19:04 INFO - "branch": "fx-team", 02:19:04 INFO - "repo_path": "integration/fx-team", 02:19:04 INFO - "revision": "e1af8a633527ae1c95bf0e630a75f9810be3995d", 02:19:04 INFO - "stage_platform": "linux64-pgo", 02:19:04 INFO - "builduid": "bcf5534bf1f04266b156d89acb86d2da", 02:19:04 INFO - "slavebuilddir": "test" 02:19:04 INFO - } 02:19:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:19:04 INFO - Running post-action listener: _resource_record_post_action 02:19:04 INFO - ##### 02:19:04 INFO - ##### Finished read-buildbot-config step (success) 02:19:04 INFO - ##### 02:19:04 INFO - ##### 02:19:04 INFO - ##### Running download-and-extract step. 02:19:04 INFO - ##### 02:19:04 INFO - Running pre-action listener: _resource_record_pre_action 02:19:04 INFO - Running main action method: download_and_extract 02:19:04 INFO - mkdir: /builds/slave/test/build/tests 02:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:04 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:19:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:05 INFO - Downloaded 1361 bytes. 02:19:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:05 INFO - Using the following test package requirements: 02:19:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:19:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:19:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:19:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:05 INFO - u'jsshell-linux-x86_64.zip'], 02:19:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:19:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:19:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:19:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:19:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:19:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:19:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:19: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')]} 02:19:05 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:19:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:06 INFO - Downloaded 24267054 bytes. 02:19:06 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'] 02:19:06 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 02:19:07 INFO - Return code: 0 02:19:07 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 02:19:07 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')]} 02:19:07 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:19:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:09 INFO - Downloaded 24267054 bytes. 02:19:09 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'] 02:19:09 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 02:19:10 INFO - Return code: 0 02:19:10 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')]} 02:19:10 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:19:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:19:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:19:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:11 INFO - Downloaded 14405245 bytes. 02:19:11 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'] 02:19:11 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 02:19:12 INFO - Return code: 0 02:19:12 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')]} 02:19:12 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:19:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:17 INFO - Downloaded 60319705 bytes. 02:19:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:17 INFO - mkdir: /builds/slave/test/properties 02:19:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:17 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:17 INFO - Contents: 02:19:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:17 INFO - Running post-action listener: _resource_record_post_action 02:19:17 INFO - Running post-action listener: set_extra_try_arguments 02:19:17 INFO - ##### 02:19:17 INFO - ##### Finished download-and-extract step (success) 02:19:17 INFO - ##### 02:19:17 INFO - ##### 02:19:17 INFO - ##### Running populate-webroot step. 02:19:17 INFO - ##### 02:19:17 INFO - Running pre-action listener: _resource_record_pre_action 02:19:17 INFO - Running main action method: populate_webroot 02:19:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:17 INFO - '--tppagecycles', 02:19:17 INFO - '7'], 02:19:17 INFO - 'tests': ['tsvgm']}}, 02:19:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:17 INFO - 'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:17 INFO - 'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['damp', 'tps']}, 02:19:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:17 INFO - 'tests': ['damp', 'tps']}, 02:19:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['dromaeo_dom']}, 02:19:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['basic_compositor_video']}, 02:19:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:19:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['a11yr', 02:19:17 INFO - 'ts_paint', 02:19:17 INFO - 'tpaint', 02:19:17 INFO - 'sessionrestore', 02:19:17 INFO - 'sessionrestore_no_auto_restore', 02:19:17 INFO - 'tabpaint']}, 02:19:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:17 INFO - 'ts_paint', 02:19:17 INFO - 'tpaint', 02:19:17 INFO - 'sessionrestore', 02:19:17 INFO - 'sessionrestore_no_auto_restore', 02:19:17 INFO - 'tabpaint']}, 02:19:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:17 INFO - 'ts_paint', 02:19:17 INFO - 'tpaint', 02:19:17 INFO - 'sessionrestore', 02:19:17 INFO - 'sessionrestore_no_auto_restore', 02:19:17 INFO - 'tabpaint']}, 02:19:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:17 INFO - 'ts_paint', 02:19:17 INFO - 'tpaint', 02:19:17 INFO - 'sessionrestore', 02:19:17 INFO - 'sessionrestore_no_auto_restore', 02:19:17 INFO - 'tabpaint']}, 02:19:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['a11yr', 02:19:17 INFO - 'ts_paint', 02:19:17 INFO - 'tpaint', 02:19:17 INFO - 'sessionrestore', 02:19:17 INFO - 'sessionrestore_no_auto_restore', 02:19:17 INFO - 'tabpaint']}, 02:19:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['a11yr', 02:19:17 INFO - 'ts_paint', 02:19:17 INFO - 'tpaint', 02:19:17 INFO - 'sessionrestore', 02:19:17 INFO - 'sessionrestore_no_auto_restore', 02:19:17 INFO - 'tabpaint']}, 02:19:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['tsvgx', 02:19:17 INFO - 'tsvgr_opacity', 02:19:17 INFO - 'tart', 02:19:17 INFO - 'tscrollx', 02:19:17 INFO - 'cart']}, 02:19:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:17 INFO - 'tsvgr_opacity', 02:19:17 INFO - 'tart', 02:19:17 INFO - 'tscrollx', 02:19:17 INFO - 'cart']}, 02:19:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:17 INFO - 'talos_options': ['--disable-e10s'], 02:19:17 INFO - 'tests': ['tp5o']}, 02:19:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:17 INFO - 'tests': ['tp5o']}, 02:19:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:17 INFO - 'talos_options': ['--disable-e10s', 02:19:17 INFO - '--xperf_path', 02:19:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:17 INFO - 'tests': ['tp5n']}, 02:19:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:17 INFO - 'talos_options': ['--xperf_path', 02:19:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:17 INFO - 'tests': ['tp5n']}}, 02:19:17 INFO - 'talos.zip': {'path': '', 02:19:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:17 INFO - Running post-action listener: _resource_record_post_action 02:19:17 INFO - ##### 02:19:17 INFO - ##### Finished populate-webroot step (success) 02:19:17 INFO - ##### 02:19:17 INFO - ##### 02:19:17 INFO - ##### Running create-virtualenv step. 02:19:17 INFO - ##### 02:19:17 INFO - Running pre-action listener: _resource_record_pre_action 02:19:17 INFO - Running main action method: create_virtualenv 02:19:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:17 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 02:19:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:18 INFO - Using real prefix '/usr' 02:19:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:20 INFO - Installing pip.................done. 02:19:20 INFO - Return code: 0 02:19:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:20 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 0x133e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, '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': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', '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 02:19:20 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 02:19:20 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 02:19:20 INFO - Using env: {'DISPLAY': ':0', 02:19:20 INFO - 'HOME': '/home/cltbld', 02:19:20 INFO - 'LANG': 'en_US.UTF-8', 02:19:20 INFO - 'LANGUAGE': 'en_US:en', 02:19:20 INFO - 'LOGNAME': 'cltbld', 02:19:20 INFO - 'MAIL': '/var/mail/cltbld', 02:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:20 INFO - 'MOZ_NO_REMOTE': '1', 02:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:20 INFO - 'NO_EM_RESTART': '1', 02:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:20 INFO - 'PWD': '/builds/slave/test', 02:19:20 INFO - 'SHELL': '/bin/bash', 02:19:20 INFO - 'SHLVL': '1', 02:19:20 INFO - 'TERM': 'linux', 02:19:20 INFO - 'TMOUT': '86400', 02:19:20 INFO - 'USER': 'cltbld', 02:19:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:20 INFO - '_': '/tools/buildbot/bin/python'} 02:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:20 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 02:19:20 INFO - Cleaning up... 02:19:20 INFO - Return code: 0 02:19:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:20 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 0x133e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, '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': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', '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 02:19:20 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 02:19:20 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 02:19:20 INFO - Using env: {'DISPLAY': ':0', 02:19:20 INFO - 'HOME': '/home/cltbld', 02:19:20 INFO - 'LANG': 'en_US.UTF-8', 02:19:20 INFO - 'LANGUAGE': 'en_US:en', 02:19:20 INFO - 'LOGNAME': 'cltbld', 02:19:20 INFO - 'MAIL': '/var/mail/cltbld', 02:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:20 INFO - 'MOZ_NO_REMOTE': '1', 02:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:20 INFO - 'NO_EM_RESTART': '1', 02:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:20 INFO - 'PWD': '/builds/slave/test', 02:19:20 INFO - 'SHELL': '/bin/bash', 02:19:20 INFO - 'SHLVL': '1', 02:19:20 INFO - 'TERM': 'linux', 02:19:20 INFO - 'TMOUT': '86400', 02:19:20 INFO - 'USER': 'cltbld', 02:19:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:20 INFO - '_': '/tools/buildbot/bin/python'} 02:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:20 INFO - Downloading/unpacking psutil>=3.1.1 02:19:20 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 02:19:20 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 02:19:20 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 02:19:20 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 02:19:20 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 02:19:20 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 02:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:22 INFO - Installing collected packages: psutil 02:19:22 INFO - Running setup.py install for psutil 02:19:23 INFO - building 'psutil._psutil_linux' extension 02:19:23 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 02:19:23 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 02:19:23 INFO - building 'psutil._psutil_posix' extension 02:19:23 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 02:19:23 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 02:19:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:23 INFO - Successfully installed psutil 02:19:23 INFO - Cleaning up... 02:19:23 INFO - Return code: 0 02:19:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19:23 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')]} 02:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:23 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')]} 02:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:23 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 0x133e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, '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': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', '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 02:19:23 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 02:19:23 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 02:19:23 INFO - Using env: {'DISPLAY': ':0', 02:19:23 INFO - 'HOME': '/home/cltbld', 02:19:23 INFO - 'LANG': 'en_US.UTF-8', 02:19:23 INFO - 'LANGUAGE': 'en_US:en', 02:19:23 INFO - 'LOGNAME': 'cltbld', 02:19:23 INFO - 'MAIL': '/var/mail/cltbld', 02:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:23 INFO - 'MOZ_NO_REMOTE': '1', 02:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:23 INFO - 'NO_EM_RESTART': '1', 02:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:23 INFO - 'PWD': '/builds/slave/test', 02:19:23 INFO - 'SHELL': '/bin/bash', 02:19:23 INFO - 'SHLVL': '1', 02:19:23 INFO - 'TERM': 'linux', 02:19:23 INFO - 'TMOUT': '86400', 02:19:23 INFO - 'USER': 'cltbld', 02:19:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:23 INFO - '_': '/tools/buildbot/bin/python'} 02:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:23 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 02:19:23 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 02:19:23 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 02:19:23 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 02:19:23 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 02:19:23 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 02:19:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:25 INFO - Installing collected packages: mozsystemmonitor 02:19:25 INFO - Running setup.py install for mozsystemmonitor 02:19:25 INFO - Successfully installed mozsystemmonitor 02:19:25 INFO - Cleaning up... 02:19:25 INFO - Return code: 0 02:19:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x133e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, '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': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', '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 02:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:19:25 INFO - Using env: {'DISPLAY': ':0', 02:19:25 INFO - 'HOME': '/home/cltbld', 02:19:25 INFO - 'LANG': 'en_US.UTF-8', 02:19:25 INFO - 'LANGUAGE': 'en_US:en', 02:19:25 INFO - 'LOGNAME': 'cltbld', 02:19:25 INFO - 'MAIL': '/var/mail/cltbld', 02:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:25 INFO - 'MOZ_NO_REMOTE': '1', 02:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:25 INFO - 'NO_EM_RESTART': '1', 02:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:25 INFO - 'PWD': '/builds/slave/test', 02:19:25 INFO - 'SHELL': '/bin/bash', 02:19:25 INFO - 'SHLVL': '1', 02:19:25 INFO - 'TERM': 'linux', 02:19:25 INFO - 'TMOUT': '86400', 02:19:25 INFO - 'USER': 'cltbld', 02:19:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:25 INFO - '_': '/tools/buildbot/bin/python'} 02:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:26 INFO - Downloading/unpacking jsonschema==2.5.1 02:19:26 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 02:19:26 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 02:19:26 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 02:19:26 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 02:19:26 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 02:19:26 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 02:19:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:19:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:28 INFO - Downloading functools32-3.2.3-2.tar.gz 02:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:19:28 INFO - warning: no files found matching '*.txt' 02:19:28 INFO - no previously-included directories found matching 'build' 02:19:28 INFO - no previously-included directories found matching 'dist' 02:19:28 INFO - no previously-included directories found matching '.git*' 02:19:28 INFO - Installing collected packages: jsonschema, functools32 02:19:28 INFO - Running setup.py install for functools32 02:19:28 INFO - warning: no files found matching '*.txt' 02:19:28 INFO - no previously-included directories found matching 'build' 02:19:28 INFO - no previously-included directories found matching 'dist' 02:19:28 INFO - no previously-included directories found matching '.git*' 02:19:28 INFO - Successfully installed jsonschema functools32 02:19:28 INFO - Cleaning up... 02:19:28 INFO - Return code: 0 02:19:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x133e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, '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': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', '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 02:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:19:28 INFO - Using env: {'DISPLAY': ':0', 02:19:28 INFO - 'HOME': '/home/cltbld', 02:19:28 INFO - 'LANG': 'en_US.UTF-8', 02:19:28 INFO - 'LANGUAGE': 'en_US:en', 02:19:28 INFO - 'LOGNAME': 'cltbld', 02:19:28 INFO - 'MAIL': '/var/mail/cltbld', 02:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:28 INFO - 'MOZ_NO_REMOTE': '1', 02:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:28 INFO - 'NO_EM_RESTART': '1', 02:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:28 INFO - 'PWD': '/builds/slave/test', 02:19:28 INFO - 'SHELL': '/bin/bash', 02:19:28 INFO - 'SHLVL': '1', 02:19:28 INFO - 'TERM': 'linux', 02:19:28 INFO - 'TMOUT': '86400', 02:19:28 INFO - 'USER': 'cltbld', 02:19:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:28 INFO - '_': '/tools/buildbot/bin/python'} 02:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:19:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:19:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19:31 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 02:19:31 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 02:19:31 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 02:19:31 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 02:19:31 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 02:19:31 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 02:19:31 INFO - Downloading docopt-0.6.1.tar.gz 02:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:31 INFO - Running setup.py install for blobuploader 02:19:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:31 INFO - Running setup.py install for requests 02:19:31 INFO - Running setup.py install for docopt 02:19:31 INFO - Successfully installed blobuploader requests docopt 02:19:31 INFO - Cleaning up... 02:19:31 INFO - Return code: 0 02:19:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:31 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')]} 02:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:31 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')]} 02:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:31 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 0x133e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, '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': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', '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 02:19:31 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 02:19:31 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 02:19:31 INFO - Using env: {'DISPLAY': ':0', 02:19:31 INFO - 'HOME': '/home/cltbld', 02:19:31 INFO - 'LANG': 'en_US.UTF-8', 02:19:31 INFO - 'LANGUAGE': 'en_US:en', 02:19:31 INFO - 'LOGNAME': 'cltbld', 02:19:31 INFO - 'MAIL': '/var/mail/cltbld', 02:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:31 INFO - 'MOZ_NO_REMOTE': '1', 02:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:31 INFO - 'NO_EM_RESTART': '1', 02:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:31 INFO - 'PWD': '/builds/slave/test', 02:19:31 INFO - 'SHELL': '/bin/bash', 02:19:31 INFO - 'SHLVL': '1', 02:19:31 INFO - 'TERM': 'linux', 02:19:31 INFO - 'TMOUT': '86400', 02:19:31 INFO - 'USER': 'cltbld', 02:19:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:31 INFO - '_': '/tools/buildbot/bin/python'} 02:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:32 INFO - Running setup.py (path:/tmp/pip-E5NJPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:32 INFO - Running setup.py (path:/tmp/pip-upuszX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:32 INFO - Running setup.py (path:/tmp/pip-aXee0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:32 INFO - Running setup.py (path:/tmp/pip-to1eYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:32 INFO - Running setup.py (path:/tmp/pip-RzftWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:32 INFO - Running setup.py (path:/tmp/pip-Gihc25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:32 INFO - Running setup.py (path:/tmp/pip-ayMmdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:32 INFO - Running setup.py (path:/tmp/pip-ar8PtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:32 INFO - Running setup.py (path:/tmp/pip-NidLTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:32 INFO - Running setup.py (path:/tmp/pip-pqM1D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:32 INFO - Running setup.py (path:/tmp/pip-KmBhF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:33 INFO - Running setup.py (path:/tmp/pip-mJO_li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:33 INFO - Running setup.py (path:/tmp/pip-7BYNM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:33 INFO - Running setup.py (path:/tmp/pip-wTdCEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:33 INFO - Running setup.py (path:/tmp/pip-9hqVs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:33 INFO - Running setup.py (path:/tmp/pip-DWpYWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:33 INFO - Running setup.py (path:/tmp/pip-c0H5u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:33 INFO - Running setup.py install for manifestparser 02:19:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:33 INFO - Running setup.py install for mozcrash 02:19:33 INFO - Running setup.py install for mozdebug 02:19:33 INFO - Running setup.py install for mozdevice 02:19:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:19:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:19:33 INFO - Running setup.py install for mozfile 02:19:33 INFO - Running setup.py install for mozhttpd 02:19:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Running setup.py install for mozinfo 02:19:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Running setup.py install for mozInstall 02:19:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Running setup.py install for mozleak 02:19:34 INFO - Running setup.py install for mozlog 02:19:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Running setup.py install for moznetwork 02:19:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Running setup.py install for mozprocess 02:19:34 INFO - Running setup.py install for mozprofile 02:19:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Running setup.py install for mozrunner 02:19:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:19:34 INFO - Running setup.py install for mozscreenshot 02:19:35 INFO - Running setup.py install for moztest 02:19:35 INFO - Running setup.py install for mozversion 02:19:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:19:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:19:35 INFO - Cleaning up... 02:19:35 INFO - Return code: 0 02:19:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:35 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 0x133e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, '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': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', '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 02:19:35 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 02:19:35 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 02:19:35 INFO - Using env: {'DISPLAY': ':0', 02:19:35 INFO - 'HOME': '/home/cltbld', 02:19:35 INFO - 'LANG': 'en_US.UTF-8', 02:19:35 INFO - 'LANGUAGE': 'en_US:en', 02:19:35 INFO - 'LOGNAME': 'cltbld', 02:19:35 INFO - 'MAIL': '/var/mail/cltbld', 02:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:35 INFO - 'MOZ_NO_REMOTE': '1', 02:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:35 INFO - 'NO_EM_RESTART': '1', 02:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:35 INFO - 'PWD': '/builds/slave/test', 02:19:35 INFO - 'SHELL': '/bin/bash', 02:19:35 INFO - 'SHLVL': '1', 02:19:35 INFO - 'TERM': 'linux', 02:19:35 INFO - 'TMOUT': '86400', 02:19:35 INFO - 'USER': 'cltbld', 02:19:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:35 INFO - '_': '/tools/buildbot/bin/python'} 02:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:35 INFO - Running setup.py (path:/tmp/pip-elGpFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:35 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)) 02:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:35 INFO - Running setup.py (path:/tmp/pip-f6AxBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:35 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)) 02:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:35 INFO - Running setup.py (path:/tmp/pip-i_pxVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:35 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)) 02:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:35 INFO - Running setup.py (path:/tmp/pip-wFQGxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:35 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)) 02:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:35 INFO - Running setup.py (path:/tmp/pip-bYZsmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:35 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)) 02:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:35 INFO - Running setup.py (path:/tmp/pip-L3OCfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:35 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)) 02:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:35 INFO - Running setup.py (path:/tmp/pip-zaCoTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:35 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)) 02:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:35 INFO - Running setup.py (path:/tmp/pip-zCKl_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:36 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)) 02:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:36 INFO - Running setup.py (path:/tmp/pip-q11iHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:36 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)) 02:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:36 INFO - Running setup.py (path:/tmp/pip-h6qRmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:36 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)) 02:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:36 INFO - Running setup.py (path:/tmp/pip-GAE_12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:36 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)) 02:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:36 INFO - Running setup.py (path:/tmp/pip-fBqSd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:36 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)) 02:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:36 INFO - Running setup.py (path:/tmp/pip-iOtIOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:36 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)) 02:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:36 INFO - Running setup.py (path:/tmp/pip-KHhFlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:36 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)) 02:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:36 INFO - Running setup.py (path:/tmp/pip-ctLO_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:36 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)) 02:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:36 INFO - Running setup.py (path:/tmp/pip-uQeHa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:36 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)) 02:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:36 INFO - Running setup.py (path:/tmp/pip-YIOO7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:36 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)) 02:19:36 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)) 02:19:36 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)) 02:19:36 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)) 02:19:36 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)) 02:19:36 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)) 02:19:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:19:36 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 02:19:36 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 02:19:36 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 02:19:36 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 02:19:36 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 02:19:36 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 02:19:38 INFO - Downloading blessings-1.6.tar.gz 02:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:19:38 INFO - Installing collected packages: blessings 02:19:38 INFO - Running setup.py install for blessings 02:19:38 INFO - Successfully installed blessings 02:19:38 INFO - Cleaning up... 02:19:38 INFO - Return code: 0 02:19:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:39 INFO - Reading from file tmpfile_stdout 02:19:39 INFO - Current package versions: 02:19:39 INFO - argparse == 1.2.1 02:19:39 INFO - blessings == 1.6 02:19:39 INFO - blobuploader == 1.2.4 02:19:39 INFO - docopt == 0.6.1 02:19:39 INFO - functools32 == 3.2.3-2 02:19:39 INFO - jsonschema == 2.5.1 02:19:39 INFO - manifestparser == 1.1 02:19:39 INFO - mozInstall == 1.12 02:19:39 INFO - mozcrash == 0.17 02:19:39 INFO - mozdebug == 0.1 02:19:39 INFO - mozdevice == 0.48 02:19:39 INFO - mozfile == 1.2 02:19:39 INFO - mozhttpd == 0.7 02:19:39 INFO - mozinfo == 0.9 02:19:39 INFO - mozleak == 0.1 02:19:39 INFO - mozlog == 3.2 02:19:39 INFO - moznetwork == 0.27 02:19:39 INFO - mozprocess == 0.22 02:19:39 INFO - mozprofile == 0.28 02:19:39 INFO - mozrunner == 6.11 02:19:39 INFO - mozscreenshot == 0.1 02:19:39 INFO - mozsystemmonitor == 0.3 02:19:39 INFO - moztest == 0.7 02:19:39 INFO - mozversion == 1.4 02:19:39 INFO - psutil == 3.1.1 02:19:39 INFO - requests == 1.2.3 02:19:39 INFO - wsgiref == 0.1.2 02:19:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:39 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 0x133e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, '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': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', '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 02:19:39 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 02:19:39 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 02:19:39 INFO - Using env: {'DISPLAY': ':0', 02:19:39 INFO - 'HOME': '/home/cltbld', 02:19:39 INFO - 'LANG': 'en_US.UTF-8', 02:19:39 INFO - 'LANGUAGE': 'en_US:en', 02:19:39 INFO - 'LOGNAME': 'cltbld', 02:19:39 INFO - 'MAIL': '/var/mail/cltbld', 02:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:39 INFO - 'MOZ_NO_REMOTE': '1', 02:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:39 INFO - 'NO_EM_RESTART': '1', 02:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:39 INFO - 'PWD': '/builds/slave/test', 02:19:39 INFO - 'SHELL': '/bin/bash', 02:19:39 INFO - 'SHLVL': '1', 02:19:39 INFO - 'TERM': 'linux', 02:19:39 INFO - 'TMOUT': '86400', 02:19:39 INFO - 'USER': 'cltbld', 02:19:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:39 INFO - '_': '/tools/buildbot/bin/python'} 02:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:39 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)) 02:19:39 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)) 02:19:39 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)) 02:19:39 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)) 02:19:39 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)) 02:19:39 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)) 02:19:39 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)) 02:19:39 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)) 02:19:39 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)) 02:19:39 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)) 02:19:39 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)) 02:19:39 INFO - Cleaning up... 02:19:39 INFO - Return code: 0 02:19:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, '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': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', '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 02:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:19:39 INFO - Using env: {'DISPLAY': ':0', 02:19:39 INFO - 'HOME': '/home/cltbld', 02:19:39 INFO - 'LANG': 'en_US.UTF-8', 02:19:39 INFO - 'LANGUAGE': 'en_US:en', 02:19:39 INFO - 'LOGNAME': 'cltbld', 02:19:39 INFO - 'MAIL': '/var/mail/cltbld', 02:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:39 INFO - 'MOZ_NO_REMOTE': '1', 02:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:39 INFO - 'NO_EM_RESTART': '1', 02:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:39 INFO - 'PWD': '/builds/slave/test', 02:19:39 INFO - 'SHELL': '/bin/bash', 02:19:39 INFO - 'SHLVL': '1', 02:19:39 INFO - 'TERM': 'linux', 02:19:39 INFO - 'TMOUT': '86400', 02:19:39 INFO - 'USER': 'cltbld', 02:19:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:39 INFO - '_': '/tools/buildbot/bin/python'} 02:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:19:39 INFO - Cleaning up... 02:19:39 INFO - Return code: 0 02:19:39 INFO - Running post-action listener: _resource_record_post_action 02:19:39 INFO - Running post-action listener: _start_resource_monitoring 02:19:39 INFO - Starting resource monitoring. 02:19:39 INFO - ##### 02:19:39 INFO - ##### Finished create-virtualenv step (success) 02:19:39 INFO - ##### 02:19:39 INFO - ##### 02:19:39 INFO - ##### Running install step. 02:19:39 INFO - ##### 02:19:39 INFO - Running pre-action listener: _resource_record_pre_action 02:19:39 INFO - Running main action method: install 02:19:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:39 INFO - Reading from file tmpfile_stdout 02:19:39 INFO - Detecting whether we're running mozinstall >=1.0... 02:19:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:19:39 INFO - Reading from file tmpfile_stdout 02:19:39 INFO - Output received: 02:19:39 INFO - Usage: mozinstall [options] installer 02:19:39 INFO - Options: 02:19:39 INFO - -h, --help show this help message and exit 02:19:39 INFO - -d DEST, --destination=DEST 02:19:39 INFO - Directory to install application into. [default: 02:19:39 INFO - "/builds/slave/test"] 02:19:39 INFO - --app=APP Application being installed. [default: firefox] 02:19:39 INFO - mkdir: /builds/slave/test/build/application 02:19:39 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'] 02:19:39 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 02:19:56 INFO - Reading from file tmpfile_stdout 02:19:56 INFO - Output received: 02:19:56 INFO - /builds/slave/test/build/application/firefox/firefox 02:19:56 INFO - Running post-action listener: _resource_record_post_action 02:19:56 INFO - ##### 02:19:56 INFO - ##### Finished install step (success) 02:19:56 INFO - ##### 02:19:56 INFO - ##### 02:19:56 INFO - ##### Running run-tests step. 02:19:56 INFO - ##### 02:19:56 INFO - Running pre-action listener: _resource_record_pre_action 02:19:56 INFO - Running main action method: run_tests 02:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:19:56 INFO - Python 2.7.3 02:19:56 INFO - Return code: 0 02:19:56 INFO - grabbing minidump binary from tooltool 02:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:56 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 0x15fd3b0>, '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 0x15fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fe740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:19:56 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 02:19:56 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 02:19:56 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 02:19:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:19:57 INFO - Return code: 0 02:19:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:19:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:19:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:19:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:19:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:19:57 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/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:19:57 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/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 02:19:57 INFO - Using env: {'DISPLAY': ':0', 02:19:57 INFO - 'HOME': '/home/cltbld', 02:19:57 INFO - 'LANG': 'en_US.UTF-8', 02:19:57 INFO - 'LANGUAGE': 'en_US:en', 02:19:57 INFO - 'LOGNAME': 'cltbld', 02:19:57 INFO - 'MAIL': '/var/mail/cltbld', 02:19:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:57 INFO - 'MOZ_NO_REMOTE': '1', 02:19:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:57 INFO - 'NO_EM_RESTART': '1', 02:19:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:57 INFO - 'PWD': '/builds/slave/test', 02:19:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:57 INFO - 'SHELL': '/bin/bash', 02:19:57 INFO - 'SHLVL': '1', 02:19:57 INFO - 'TERM': 'linux', 02:19:57 INFO - 'TMOUT': '86400', 02:19:57 INFO - 'USER': 'cltbld', 02:19:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200', 02:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:57 INFO - '_': '/tools/buildbot/bin/python'} 02:19:57 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/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:19:57 INFO - mozversion application_buildid: 20160628233029 02:19:57 INFO - mozversion application_changeset: e1af8a633527ae1c95bf0e630a75f9810be3995d 02:19:57 INFO - mozversion application_display_name: Nightly 02:19:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:19:57 INFO - mozversion application_name: Firefox 02:19:57 INFO - mozversion application_remotingname: firefox 02:19:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:19:57 INFO - mozversion application_vendor: Mozilla 02:19:57 INFO - mozversion application_version: 50.0a1 02:19:57 INFO - mozversion platform_buildid: 20160628233029 02:19:57 INFO - mozversion platform_changeset: e1af8a633527ae1c95bf0e630a75f9810be3995d 02:19:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:19:57 INFO - mozversion platform_version: 50.0a1 02:19:57 INFO - using testdate: 1467191997 02:19:57 INFO - actual date: 1467191997 02:19:57 INFO - starting webserver on 'localhost:42915' 02:19:57 INFO - SUITE-START | Running 2 tests 02:19:57 INFO - TEST-START | dromaeo_css 02:19:57 INFO - operating with platform_type : linux_ 02:19:57 INFO - Initialising browser for dromaeo_css test... 02:19:57 INFO - TEST-INFO | started process 19441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmf_Lhp/profile http://localhost:42915/getInfo.html) 02:20:01 INFO - PROCESS | 19441 | __metrics Screen width/height:1600/1200 02:20:01 INFO - PROCESS | 19441 | colorDepth:24 02:20:01 INFO - PROCESS | 19441 | Browser inner width/height: 1024/697 02:20:01 INFO - PROCESS | 19441 | __metrics 02:20:02 ERROR - PROCESS | 19441 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 02:20:03 INFO - TEST-INFO | 19441: exit 0 02:20:03 INFO - Browser initialized. 02:20:03 INFO - Running cycle 1/1 for dromaeo_css test... 02:20:03 INFO - TEST-INFO | started process 19561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmf_Lhp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:14 INFO - PROCESS | 19561 | RSS: Main: 167858176 02:20:14 INFO - PROCESS | 19561 | 02:21:04 INFO - PROCESS | 19561 | 1467192064463 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] 02:23:12 INFO - PROCESS | 19561 | Cycle 1(1): loaded http://localhost:42915/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42915/tests/dromaeo/cssquery-ext.html) 02:23:13 INFO - PROCESS | 19561 | RSS: Main: 171208704 02:23:13 INFO - PROCESS | 19561 | 02:26:15 INFO - PROCESS | 19561 | Cycle 1(1): loaded http://localhost:42915/tests/dromaeo/cssquery-ext.html (next: http://localhost:42915/tests/dromaeo/cssquery-jquery.html) 02:26:15 INFO - PROCESS | 19561 | RSS: Main: 169955328 02:26:15 INFO - PROCESS | 19561 | 02:29:17 INFO - PROCESS | 19561 | Cycle 1(1): loaded http://localhost:42915/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42915/tests/dromaeo/cssquery-mootools.html) 02:29:18 INFO - PROCESS | 19561 | RSS: Main: 171671552 02:29:18 INFO - PROCESS | 19561 | 02:32:20 INFO - PROCESS | 19561 | Cycle 1(1): loaded http://localhost:42915/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42915/tests/dromaeo/cssquery-prototype.html) 02:32:20 INFO - PROCESS | 19561 | RSS: Main: 169717760 02:32:20 INFO - PROCESS | 19561 | 02:35:23 INFO - PROCESS | 19561 | Cycle 1(1): loaded http://localhost:42915/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42915/tests/dromaeo/cssquery-yui.html) 02:35:23 INFO - PROCESS | 19561 | RSS: Main: 171130880 02:35:23 INFO - PROCESS | 19561 | 02:38:26 INFO - PROCESS | 19561 | Cycle 1(1): loaded http://localhost:42915/tests/dromaeo/cssquery-yui.html (next: http://localhost:42915/tests/dromaeo/cssquery-dojo.html) 02:38:26 INFO - PROCESS | 19561 | RSS: Main: 172761088 02:38:26 INFO - PROCESS | 19561 | 02:38:26 INFO - PROCESS | 19561 | __start_tp_report 02:38:26 INFO - PROCESS | 19561 | _x_x_mozilla_page_load 02:38:26 INFO - PROCESS | 19561 | _x_x_mozilla_page_load_details 02:38:26 INFO - PROCESS | 19561 | |i|pagename|runs| 02:38:26 INFO - PROCESS | 19561 | |0;dojo.html;3064.9540256896144;3081.2604974806054;3101.9534706979384;3115.2056225662454;3129.499280115182;5276.86807829804;5284.577233821295;5298.655587386822;5300.867478313044;5332.866678333044;5170.638055336128;5210.19242017487;5255.08036093683;5271.710055946931;5302.469753024705;4720.480747117823;4749.76251187441;4822.373091498101;4884.926726099111;4922.237053256733;777.5195155404193;4799.784009719571;4846.1034708578845;4870.025994801036;4880.902381952376;4743.667943243974;4762.952370476286;4781.402324709411;4782.0435912817575;4809.086273608021;4722.8110875564935;4767.380240568704;4788.377510923592;4796;4842.201036828919;4746;4767.332573439721;4771.16504611695;4774.4509381420885;4792.041591681643;5228.2680424740565;5231.895362092737;5293.894122117575;5318.388385335697;5344.599155063347;5590.636608620467;5637.323521177444;5683.886322273532;5689.943100568983;5694.9715251423895;5636.943630563683;5637.323521177444;5670.773169073233;5673.23411339468;5720.485156335908;5291.259223708684;5325.893482130375;5337.839864804062;5364.678119312854;5417.079096553595;5644.125160600113;5707.34365547959;5722.54219662426;5742.971285143631;5781.103928891029;5536.833894983157;5562.471565201299;5564.33228012641;5574.136008918624;5592.99326121294;5639.548836093103;5643.830685079372;5645.181448689999;5658.292713410824;5664.830055098354;5522.91715624266;5532.917006244909;5534.335879694382;5576.553875690016;5647.491725744702;5523.337199536081;5564.86087847799;5566.832995010156;5608.242887210175;5635.098384258499;4265.083007153415;4308.138372325548;4314.266574682311;4316.158349121891;4348.130373925164;3775.2826962876966;3821.464994900716;3851.67260782831;3861.343571592836;3880.6507414332846;5425.213344065089;5429;5431.348238211361;5435.483629055233;5481.5340696041285;5516.062269414209;5643.548516118783;5662.716864156776;5694.316681998187;5697.4302569742695;5426.348838139448;5452.6183167177915;5468.425815289417;5471.6169868108855;5497.175423686479;4877.6341774367065;4918.434380046269;4919.212925931905;4923.335349727812;4962.503749625009;5743.54051675865;5787.508061814793;5920.2303700519515;5944.3164036136395;5955.880882382415;5603.215549822947;5638.9436105638415;5662.235598194356;5668.178114173339;5698.202251684685;5823.970880145572;5826.184334193301;5827.650340979555;5838.416158384128;5850.736716847837;5460.26286451324;5519.3652729936575;5538.030844602259;5550.666959982414;5570.19232211319;5652.915206271827;5660.264165658438;5661.773529058792;5663.546916246608;5693.117566777156;5473.31583552056;5488.121900495901;5494.80768173112;5500.22996780443;5506.201600767786;5385.3268341457315;5437.483439073281;5457.235986961908;5501.202325662676;5529.198266251291;5339.359276886798;5414.756335964812;5446.509814116748;5448.56411487088;5464;5548.056830338772;5550.722463876871;5571.944280557304;5626.8464964681325;5628.127640215773;5259.21111833228;5418.07892658257;5482.890342193214;5500.449955004628;5509.090999984957 02:38:26 INFO - PROCESS | 19561 | |1;ext.html;588.5056552495903;600.6756351570152;628.981130566083;649.619972316195;651.2803352295715;42199.57800421995;43801.78099109508;43861.78069109654;43937;48061;46355.30467042997;46759.53240467594;46791.532084679144;46883.29675054877;47019.76490117545;9048.864267036;9051.547422628842;9157.313201509913;9203.95398023009;9251.491167985758;8928.508932008737;9000.504972226558;9027.187553120219;9044.321675874337;9045.095490450967;9095.499747513884;9140.405873618227;9158.587863546156;9168.449893006407;9196.034416386283;9110.635574577009;9162.725118246462;9163.770905727344;9169.495677737721;9172.770680732969;8972.147645973622;8973.327000474925;8975.820483590356;9033.77415564616;9046.638134474679;44497.77751111224;44668;44706.32940505895;44883;44972.3254151188;3686.981565092184;3798.772073675588;3909.4526766252748;3941.6452519273403;4336.197803406349;33193.336133277444;33279.833600832084;33646.831765841016;33669.32661346784;35020.47469287963;4421.889452763675;4519.435070616173;4524.954750452486;4532.773361331953;4554.180247555439;350462;352151;353479.2326038379;353659;354184;59979;60235.69882150649;60286.39713602896;60663.09005364923;60762.696186518784;64448.35551644424;64574.677126614064;64606.38484037843;64819.35180648228;64829;16482.75275870863;16686.58283542921;16741.83258167403;16745.16274186286;16840.07379594134;12886.742265154644;12890.226586404846;12891.613251602466;12918.612441626767;12925.28910909909;17493.26321482184;18636.34772782946;18648.81351186498;18667.626647466976;19031.714524282146;6507.934920650733;6656.400923916871;6767.323267673193;6778.3221677831825;6865.382115609619;1014.4826138669184;1035.9689209323733;1078.827024417918;1143.3025854228913;1171.2679575265458;33246.8337658315;33346.16634584155;33391.83304083464;33484.665153348156;33499;1098.4837126550508;1147.254284714942;1154.3535620052796;1181.0669571038784;1202.6812894582943;17455.476335709947;17492.91253543724;17624;17674.204660790296;17804.91097544504;138844;139310.30344848413;139757;140278;140400;60099.39900601025;61167.388326117056;61300.38699612947;61369;61383;1349.7772867476954;1374.3471850870956;1375.8830499407663;1388.5001399496173;1388.5140200929795;31033.534496983015;32528.51207231941;32736;32948.01155965325;33081.17297067593;53783.73108134434;54211.72894135504;54295;54333.45666543284;54361.18458223209;428283;428894;429820;431358;432216;43964.78017609892;44136.77931610322;44362.55637443713;44578.3313250295;46229.45737984443;48771.268430974276;48868.2669759961;49666.751666241435;50463.49536504588;50611.74694126506;42254;42410.93972650585;42420.36369454522;42576.787116064224;43771;42351;42415.7879210602;42754.57245427506;42783.3582496269;42903;41114.588854111076;41781.37327940023;42847.35728964006;42884;42890.78554607207;35932;37458.812705936296;37799.62200377961;38337.0466179205;38722.80638596789;28438.573421398283;28765.56851647269;29163.7083629161;29294.41411171722;29487.410251795274 02:38:26 INFO - PROCESS | 19561 | |2;jquery.html;381.11391015888057;389.17883266308087;395.44440061713306;395.7674330192865;405.29681003458995;14436.350364233609;18721.81278187221;19340.51648708783;19905.203791848344;20000.699989500168;18748.718769218438;19185.23259069639;19338.903305483487;19363.903180484114;19957.201711931506;5745.827625171241;6027.758889644431;7200.639968001605;7635.809104772369;7639;6967.233604303523;7316.670749816271;7581.507202031878;7714.961425192866;7776.7666969990705;7400.444966627524;7404.629768511553;7425.294597013275;7428.777136685908;7436.628168591576;7078.646067696594;7385.778426647183;7402.7038918443195;7403.185649578542;7419.480636355457;6962.164540255151;7068.18715847679;7084.220735719066;7241.5293005954445;7268.890966635505;21155.788442115536;21413.036413361435;23971.880140599358;24506.142285020116;25597.872010640014;2564.525562770875;2659.973400266011;2680.67831860178;2838.9290267743263;3154.68453154685;15562;15897.1256580888;15979.680406391923;16125.677486450206;16532.173391330507;2120.3980099502487;2129.882856442895;2171.359448962544;2205.3383984804495;2245.6856040154394;86389;93419.53290233505;94823.52588237084;95032;96125.51937240339;17570.736438953427;17650;17812.643747124985;17999.55001124956;18324.617799685955;31565;31814.204644884063;31833;31871.609629277435;32043.679563204536;10076.848847267296;10422.739431514121;10484.790304193873;10561.788764224826;10578.788424231472;8619.267362274151;8700.34747393948;8897.688580899638;8945.06076861933;9057.18485336323;8895.4662720237;8976.281897448189;9024.729258122266;9053.954730226307;9085.636574537077;3572.7499075064497;3646.744727869024;3648.872289469856;3666.4133738601695;3687.9815600921825;939.6617217801586;989.7970915962211;1015.7308313296983;1036.124474818777;1057.0486562094177;18973.810261897204;18984.525386865163;19208.71186932197;19570;19622.607547848962;1001.6944831826363;1015.5328548867603;1021.1116328793848;1026.3687831983277;1034.1416624202045;10464.372137671764;10925.508352124174;10931.18016148792;10959.232853700323;11006.669799906016;438555;438876;439708;441113;444273;81207;85540.57229713812;91342.54328728447;91694;93054;993.1409330928694;1024.774549599087;1053.2890299048113;1059.0838924330553;1061.5223149582564;17319.3938212167;17452;17804.10979451048;17851.553711157325;17901.910490447466;39539.80230098831;39948.80025599853;41030.38454423127;41556.37665435082;41942.16115677731;56048.719756400955;56073.43926560845;56194;56407;56724;7977.401694872791;8375.413721039713;8396.874046889423;8413.411061225655;8472.237498625153;12824.679383015498;12886.033547484163;13129.73740525165;13182.670433239246;13197.604071877859;11585.362805045803;11696.122790790554;11716.17986740954;11811.527538898692;12201.08491863096;11158.721031974266;11226.438678066228;11389.373584452935;11406.600768973047;11465;11944.940275298568;12137.635870923887;12207.328596927255;12266.38668066611;12355.814662779885;8450.619722112397;8513.95743021281;8547.40168188221;8666.22004019616;8762;11234.932681395581;11953.342566158944;12005.699857503632;12041;12047.638570842888 02:38:26 INFO - PROCESS | 19561 | |3;mootools.html;1435.3038776193548;1461.6565107199808;1545.4668139491878;1748.27446609657;1754.6841568517661;7788.571628560427;8112.269895709385;8365.58172091396;8676.436031657939;8682.088380720028;8538.10349913258;8703.129687031294;8845.115488451152;8853.070427605106;8881.689140880071;2197.9890100549515;2211.8562293450955;2232.6092933736613;2242.024719247133;2246.5282290718887;2201.1305534313938;2203.294945617403;2233.039792889057;2246.853954492961;2251.966220506694;2207;2217.024509215948;2219.678146668732;2224.0992398078806;2227.0201111510964;2128.31893793986;2137.337425398116;2145.6245157097524;2160.3842904772223;2164.0802658870075;2170.4573856535867;2185.519185779142;2196.835237357189;2196.9231076912392;2205.162038425388;8740.431871928367;8806.339524535686;8851.690190843354;8852;8884.600192991331;4915.992221594564;5004.224345226496;5007.649464537484;5010.599152067826;5014.448410674823;2985.462616728988;3082.445159871222;3154.747620190379;3172.0642410488963;3186.76099292554;991.8512223166583;1019.7807471393612;1023.5752162852407;1025.2361990317188;1040.6513817871023;11644.592439264585;11650;11661.941690291578;11691.590794322157;11697.23967942081;4254.255505286563;4398.846040388571;4479.260921947907;4481.932771008437;4525.796339164745;9938.055884690943;9951.054649808257;9959.804823421237;9983.500824958723;10012.098911098035;5129.384473863161;5142.434332223453;5142.71715055668;5148.4851514848215;5149.2791009258735;4226.387173859773;4508.413906192174;4577.5193604671695;4657.767111644404;4684.461286952044;3999.6400323970984;4002;4091.85678501251;4131.173765246963;4137.77242251673;1214.3017764785284;1233.5497543396596;1240.342618412243;1246.8316777235138;1247.2828123828654;971.9028097190366;988.9208863290919;989.7723523589615;1000.8148492528906;1009.3136667066466;6130.601510901777;6134.6625935573975;6180.721867515973;6192.566520343533;6256.937430625636;395.80803310394435;403.86672398108556;407.22423782693426;407.76349717164567;411.31310711112513;4083.734557253769;4177.49870015594;4184.790760461965;4213.536510983789;4215.325547912381;10057.34627249241;10249.282550221562;10298.794024119476;10322.690319290434;10344.275900687031;10137.087662110445;10159.034891685278;10250.38497690141;10252.38485690846;10256.641017564349;7893.092294386219;7953;7962.442629016029;7968.681252749941;8001.039875215011;5667.688277144796;5754.683492407958;5769.192313076089;5858.443447872445;5880.9708301048;9499;9505.239580833655;9566.56950437218;9584.472853993097;9675.129238368581;9546.331756777237;9620.230381569318;9770;9820.45987470696;9826.263030272616;7189.173245076674;7374.926250737424;7444.478886477895;7877.251661092187;8330.333573314;8261.793455163668;8586.82826343457;8631.309495240492;8646.82706345882;8670.653173872974;7592.126905405949;7759.107702614272;7765.0681918170185;7783.883241751265;7874.803129921798;7344.779656610311;7592.582407967615;7692.92307076922;7730.652120654471;7751.069871615442;7034.366906978396;7108.715651373887;7137.85724285501;7150.570965742072;7168;4990.700557966534;5125.74371281427;5308.203769434615;5430.565554755689;5436.7281635918835;5226.712530810842;5239.659422137549;5261.346118347878;5281.57747380201;5366.7584958677735 02:38:26 INFO - PROCESS | 19561 | |4;prototype.html;290.33078753473245;293.9250491124763;305.9816411015338;316.552078808486;319.62603753608306;5387.218853266284;5433.8369848904495;5630.211770352149;5691.9999999999945;5710.029295019852;5389.137737961927;5432.782688692458;5457.508824205821;5498.1752737089355;5528.861778455531;4286.464191976003;4332.155229730204;4333.58830911063;4346.9347959780625;4355.433793606842;4144.689148313873;4284.564670835259;4314.223439780838;4330.588594083572;4335.9566404335865;4274.123804620045;4276.102018576103;4277.721948073381;4287.121140166274;4289.978550107245;4282.807273672676;4288.742675439484;4291.249031419505;4294.592013758688;4300.333448315516;3687.6128006559193;3828.674562662177;3846.0961674006585;3849;3864.420336949452;5329.280547126127;5368.30212072432;5394.433584473652;5408.810691625814;5415.702136382497;4899.8040078396825;4908.337374454474;4924.80300787968;4927;4929.482404347527;5602.1596760485845;5753.568482363839;5771.220885180489;5775.191473193756;5806.5645076619;4172.415861779354;4191.559886211934;4200.768957707325;4206.810693518799;4220.620144187038;5962.999999999956;6011.458968692795;6030.698465076729;6042.848928776772;6055.5761096723245;4105.568915263914;4243.915121697549;4272;4272.551382104896;4282.293421585466;4286.507051689034;4328.783560822009;4333.414988976511;4335.284678028153;4346.565343465628;4913.828016019422;4916.3362946001835;4929.373306808745;4931.753412329369;4945.1346014448045;5579.19101730255;5844.772597754434;5849.5027922626205;5856.677882716406;5876.676782776903;1473.6168596165073;1491.135141617859;1497.139144991634;1499.8725108365911;1500.0999400359915;911.4212475078373;934.6495064350869;935.1443429262149;941.3551717073826;946.2288235088519;4951.306817045616;4958.479359667255;5020.924686129711;5078.847634570969;5160.7419629018395;5287.259783630295;5314.5748340132695;5355.973874760748;5381.354237491526;5399.865003374947;5084.703400632815;5092.745362731848;5117.181250999822;5349.705766182898;5763.924987004675;3121.4248245197805;3183.777135600532;3200.6319273283407;3210.165357007148;3220.935581288361;6129;6260.593061450991;6265.342139075423;6272.372762723691;6274.560780745304;6048.274207095177;6085.513158947274;6090.634561926298;6093.725782339717;6129.540284478682;6207.720652570645;6224.37756224374;6253.468455181361;6271.31015588294;6287.2140982377205;5779.942200577941;5979.312379076462;5987.550933679904;5997.640141591519;6024.246969128859;5892.734826932712;5910.143029260647;5973.223480947449;6023.45788879003;6037.18498002764;6057.303410107894;6236.563440559117;6252.3122456530655;6344.492440604648;6345.365463453618;3916.706247031541;3999.960000399959;4090.877273681794;4093.8157782899243;4096.774677392653;5891.882162356815;5907.911381329198;5941.494972927177;5961.374055724086;5965.313988891333;5508.008558459515;5740.622250659728;5766.250387449605;5769.798057067983;5796.3190674703865;5795.362510123968;5822.621529600562;5835.358110607915;5888.882222355443;5901.704914754159;5750.482456578928;5784.739686714024;5796.275465566804;5805.506531944832;5829.883402332014;5695.373508913934;5866.266716660418;5879.647221166743;5899.882002360015;5909.8227053188475;5802.65184088956;5808.15781711641;5812.593118481665;5819.4180581943165;5857.882842343044 02:38:26 INFO - PROCESS | 19561 | |5;yui.html;776.5845272779064;788.4048737755834;801.5711594297052;840.3361344537816;840.9957950210248;14695.41218351266;15760.211989400514;15763.21183940804;15775.0534967902;15856.762148567781;14710.117392956403;14738.557843264693;14744.705105897876;14771.409143634242;14819;650.4763665249473;770.3721467004374;781.8905353250535;798.3573223555036;801.2548330053078;770.5684816502749;772.8647486689807;774.1909704358958;774.9690012399525;775.9689612415525;839.353697652807;839.5508403004394;839.5550358310105;839.7984483723893;842.616609442702;830.2859540794911;835.761807884756;836.2014276366117;838.1241602525345;839.8992120945526;609.1411110334451;612.996935015322;613.8557439001876;614.988344173836;615.5783288447383;14487.71024579513;14573.12561246318;14573.198474083922;14597.562073137822;14619.63450913725;14645.340959656842;15111.924440377838;15151.166685832275;15468.922655386763;15566.610834729108;12286.631401057894;12404;12493.500259989589;12507.249565026128;12627.684307892376;3917.373220284741;3927.6268754468565;4036.4348991141264;4091.1204091120553;4092.7517107282265;74332.62833685851;74504.6274768628;75381.24618753852;75738.24261757368;78502;10520.053195212467;10860.72848178786;11627.476763545661;11976.161668683282;12059.397030148457;20579.58840823205;20858.791412085684;20929.89535052315;20986.0556274968;20987.370378888656;7967.203279671987;8004.239597238253;8024.277814996562;8091.919080809116;8198.180181981754;4599.2871104978785;4629.837955671603;4663.906721865612;4667.463241727177;4848.781804818721;3368.4105281575626;3440.638732933056;3441.105312618737;3448.5516882805073;3449.292894956528;591.9230500035054;595.597971369324;604.5194070713793;615.0773839241139;617.6633734614646;563.7913971830449;614.0543562913064;671.1174805131237;681.7545683553917;692.5429216716942;8154.266116049584;9185.402948808307;9369.812603747887;9460.337776355727;9557.952210239044;598.1416667082664;606.757297081171;663.4692246203018;765.6248438265321;779.7387875061804;4550.749708765983;4705.741184234831;4707.62339012885;4943.134951383494;5019.573336266459;62031.379686203465;63590;64049.35950640434;64358;114060;91674.54162729143;93626.53186734022;95527.52236238774;96325;96728.51635741776;62333;85108.57445712732;85415.99999999876;87364;88343;8911.376203665941;9172.724818255463;9781.269866497129;10056.69829905104;10220.182385409;37183.81408092942;37430.6256937438;40416.79791601023;44925.87685307893;47757.283640746115;49509.75245123752;73261.63369183333;73739.63130184315;73849;74374.62812685902;13234.801477978031;13237.536686215935;13255.867441325463;13314.334283285603;13360.331983400985;13852.86147138556;13968.19371466249;14108.082974606617;14343.139411635335;14737.263136843329;14102.153870767786;14185.503507377192;14303.141811491343;14448.783268250774;14890.404383824525;13034.217946923214;13510.93244533771;13559.932200338935;13705.794413084011;14343.56969290923;11622.476988535705;13124.803127953279;13199.340032998503;13967.720645587235;14365.569032929028;10873.238873279111;10875.673729788119;10975.451227438756;11300.94349528247;11393.658190254306;11233.213675042669;11548.711282218012;11644.825327619923;11685.824712629148;11722.296662200295 02:38:26 INFO - PROCESS | 19561 | __end_tp_report 02:38:26 INFO - PROCESS | 19561 | __start_cc_report 02:38:26 INFO - PROCESS | 19561 | _x_x_mozilla_cycle_collect,367 02:38:26 INFO - PROCESS | 19561 | __end_cc_report 02:38:26 INFO - PROCESS | 19561 | __startTimestamp1467193106921__endTimestamp 02:38:26 INFO - PROCESS | 19561 | 02:38:26 INFO - PROCESS | 19561 | ------- Summary: start ------- 02:38:26 INFO - PROCESS | 19561 | Number of tests: 6 02:38:26 INFO - PROCESS | 19561 | 02:38:26 INFO - PROCESS | 19561 | [#0] dojo.html Cycles:165 Average:5224.95 Median:5471.62 stddev:683.76 (12.5%) stddev-sans-first:664.52 02:38:26 INFO - PROCESS | 19561 | Values: 3065.0 3081.3 3102.0 3115.2 3129.5 5276.9 5284.6 5298.7 5300.9 5332.9 5170.6 5210.2 5255.1 5271.7 5302.5 4720.5 4749.8 4822.4 4884.9 4922.2 777.5 4799.8 4846.1 4870.0 4880.9 4743.7 4763.0 4781.4 4782.0 4809.1 4722.8 4767.4 4788.4 4796.0 4842.2 4746.0 4767.3 4771.2 4774.5 4792.0 5228.3 5231.9 5293.9 5318.4 5344.6 5590.6 5637.3 5683.9 5689.9 5695.0 5636.9 5637.3 5670.8 5673.2 5720.5 5291.3 5325.9 5337.8 5364.7 5417.1 5644.1 5707.3 5722.5 5743.0 5781.1 5536.8 5562.5 5564.3 5574.1 5593.0 5639.5 5643.8 5645.2 5658.3 5664.8 5522.9 5532.9 5534.3 5576.6 5647.5 5523.3 5564.9 5566.8 5608.2 5635.1 4265.1 4308.1 4314.3 4316.2 4348.1 3775.3 3821.5 3851.7 3861.3 3880.7 5425.2 5429.0 5431.3 5435.5 5481.5 5516.1 5643.5 5662.7 5694.3 5697.4 5426.3 5452.6 5468.4 5471.6 5497.2 4877.6 4918.4 4919.2 4923.3 4962.5 5743.5 5787.5 5920.2 5944.3 5955.9 5603.2 5638.9 5662.2 5668.2 5698.2 5824.0 5826.2 5827.7 5838.4 5850.7 5460.3 5519.4 5538.0 5550.7 5570.2 5652.9 5660.3 5661.8 5663.5 5693.1 5473.3 5488.1 5494.8 5500.2 5506.2 5385.3 5437.5 5457.2 5501.2 5529.2 5339.4 5414.8 5446.5 5448.6 5464.0 5548.1 5550.7 5571.9 5626.8 5628.1 5259.2 5418.1 5482.9 5500.4 5509.1 02:38:26 INFO - PROCESS | 19561 | 02:38:26 INFO - PROCESS | 19561 | [#1] ext.html Cycles:180 Average:50489.90 Median:236361.50 stddev:87632.93 (37.1%) stddev-sans-first:87798.66 02:38:26 INFO - PROCESS | 19561 | Values: 588.5 600.7 629.0 649.6 651.3 42199.6 43801.8 43861.8 43937.0 48061.0 46355.3 46759.5 46791.5 46883.3 47019.8 9048.9 9051.5 9157.3 9204.0 9251.5 8928.5 9000.5 9027.2 9044.3 9045.1 9095.5 9140.4 9158.6 9168.4 9196.0 9110.6 9162.7 9163.8 9169.5 9172.8 8972.1 8973.3 8975.8 9033.8 9046.6 44497.8 44668.0 44706.3 44883.0 44972.3 3687.0 3798.8 3909.5 3941.6 4336.2 33193.3 33279.8 33646.8 33669.3 35020.5 4421.9 4519.4 4525.0 4532.8 4554.2 350462.0 352151.0 353479.2 353659.0 354184.0 59979.0 60235.7 60286.4 60663.1 60762.7 64448.4 64574.7 64606.4 64819.4 64829.0 16482.8 16686.6 16741.8 16745.2 16840.1 12886.7 12890.2 12891.6 12918.6 12925.3 17493.3 18636.3 18648.8 18667.6 19031.7 6507.9 6656.4 6767.3 6778.3 6865.4 1014.5 1036.0 1078.8 1143.3 1171.3 33246.8 33346.2 33391.8 33484.7 33499.0 1098.5 1147.3 1154.4 1181.1 1202.7 17455.5 17492.9 17624.0 17674.2 17804.9 138844.0 139310.3 139757.0 140278.0 140400.0 60099.4 61167.4 61300.4 61369.0 61383.0 1349.8 1374.3 1375.9 1388.5 1388.5 31033.5 32528.5 32736.0 32948.0 33081.2 53783.7 54211.7 54295.0 54333.5 54361.2 428283.0 428894.0 429820.0 431358.0 432216.0 43964.8 44136.8 44362.6 44578.3 46229.5 48771.3 48868.3 49666.8 50463.5 50611.7 42254.0 42410.9 42420.4 42576.8 43771.0 42351.0 42415.8 42754.6 42783.4 42903.0 41114.6 41781.4 42847.4 42884.0 42890.8 35932.0 37458.8 37799.6 38337.0 38722.8 28438.6 28765.6 29163.7 29294.4 29487.4 02:38:26 INFO - PROCESS | 19561 | 02:38:26 INFO - PROCESS | 19561 | [#2] jquery.html Cycles:180 Average:29100.85 Median:2996.81 stddev:72858.43 (2431.2%) stddev-sans-first:73030.91 02:38:26 INFO - PROCESS | 19561 | Values: 381.1 389.2 395.4 395.8 405.3 14436.4 18721.8 19340.5 19905.2 20000.7 18748.7 19185.2 19338.9 19363.9 19957.2 5745.8 6027.8 7200.6 7635.8 7639.0 6967.2 7316.7 7581.5 7715.0 7776.8 7400.4 7404.6 7425.3 7428.8 7436.6 7078.6 7385.8 7402.7 7403.2 7419.5 6962.2 7068.2 7084.2 7241.5 7268.9 21155.8 21413.0 23971.9 24506.1 25597.9 2564.5 2660.0 2680.7 2838.9 3154.7 15562.0 15897.1 15979.7 16125.7 16532.2 2120.4 2129.9 2171.4 2205.3 2245.7 86389.0 93419.5 94823.5 95032.0 96125.5 17570.7 17650.0 17812.6 17999.6 18324.6 31565.0 31814.2 31833.0 31871.6 32043.7 10076.8 10422.7 10484.8 10561.8 10578.8 8619.3 8700.3 8897.7 8945.1 9057.2 8895.5 8976.3 9024.7 9054.0 9085.6 3572.7 3646.7 3648.9 3666.4 3688.0 939.7 989.8 1015.7 1036.1 1057.0 18973.8 18984.5 19208.7 19570.0 19622.6 1001.7 1015.5 1021.1 1026.4 1034.1 10464.4 10925.5 10931.2 10959.2 11006.7 438555.0 438876.0 439708.0 441113.0 444273.0 81207.0 85540.6 91342.5 91694.0 93054.0 993.1 1024.8 1053.3 1059.1 1061.5 17319.4 17452.0 17804.1 17851.6 17901.9 39539.8 39948.8 41030.4 41556.4 41942.2 56048.7 56073.4 56194.0 56407.0 56724.0 7977.4 8375.4 8396.9 8413.4 8472.2 12824.7 12886.0 13129.7 13182.7 13197.6 11585.4 11696.1 11716.2 11811.5 12201.1 11158.7 11226.4 11389.4 11406.6 11465.0 11944.9 12137.6 12207.3 12266.4 12355.8 8450.6 8514.0 8547.4 8666.2 8762.0 11234.9 11953.3 12005.7 12041.0 12047.6 02:38:26 INFO - PROCESS | 19561 | 02:38:26 INFO - PROCESS | 19561 | [#3] mootools.html Cycles:180 Average:5643.51 Median:5009.12 stddev:3195.73 (63.8%) stddev-sans-first:3189.05 02:38:26 INFO - PROCESS | 19561 | Values: 1435.3 1461.7 1545.5 1748.3 1754.7 7788.6 8112.3 8365.6 8676.4 8682.1 8538.1 8703.1 8845.1 8853.1 8881.7 2198.0 2211.9 2232.6 2242.0 2246.5 2201.1 2203.3 2233.0 2246.9 2252.0 2207.0 2217.0 2219.7 2224.1 2227.0 2128.3 2137.3 2145.6 2160.4 2164.1 2170.5 2185.5 2196.8 2196.9 2205.2 8740.4 8806.3 8851.7 8852.0 8884.6 4916.0 5004.2 5007.6 5010.6 5014.4 2985.5 3082.4 3154.7 3172.1 3186.8 991.9 1019.8 1023.6 1025.2 1040.7 11644.6 11650.0 11661.9 11691.6 11697.2 4254.3 4398.8 4479.3 4481.9 4525.8 9938.1 9951.1 9959.8 9983.5 10012.1 5129.4 5142.4 5142.7 5148.5 5149.3 4226.4 4508.4 4577.5 4657.8 4684.5 3999.6 4002.0 4091.9 4131.2 4137.8 1214.3 1233.5 1240.3 1246.8 1247.3 971.9 988.9 989.8 1000.8 1009.3 6130.6 6134.7 6180.7 6192.6 6256.9 395.8 403.9 407.2 407.8 411.3 4083.7 4177.5 4184.8 4213.5 4215.3 10057.3 10249.3 10298.8 10322.7 10344.3 10137.1 10159.0 10250.4 10252.4 10256.6 7893.1 7953.0 7962.4 7968.7 8001.0 5667.7 5754.7 5769.2 5858.4 5881.0 9499.0 9505.2 9566.6 9584.5 9675.1 9546.3 9620.2 9770.0 9820.5 9826.3 7189.2 7374.9 7444.5 7877.3 8330.3 8261.8 8586.8 8631.3 8646.8 8670.7 7592.1 7759.1 7765.1 7783.9 7874.8 7344.8 7592.6 7692.9 7730.7 7751.1 7034.4 7108.7 7137.9 7150.6 7168.0 4990.7 5125.7 5308.2 5430.6 5436.7 5226.7 5239.7 5261.3 5281.6 5366.8 02:38:26 INFO - PROCESS | 19561 | 02:38:26 INFO - PROCESS | 19561 | [#4] prototype.html Cycles:180 Average:4858.78 Median:5424.24 stddev:1443.24 (26.6%) stddev-sans-first:1405.97 02:38:26 INFO - PROCESS | 19561 | Values: 290.3 293.9 306.0 316.6 319.6 5387.2 5433.8 5630.2 5692.0 5710.0 5389.1 5432.8 5457.5 5498.2 5528.9 4286.5 4332.2 4333.6 4346.9 4355.4 4144.7 4284.6 4314.2 4330.6 4336.0 4274.1 4276.1 4277.7 4287.1 4290.0 4282.8 4288.7 4291.2 4294.6 4300.3 3687.6 3828.7 3846.1 3849.0 3864.4 5329.3 5368.3 5394.4 5408.8 5415.7 4899.8 4908.3 4924.8 4927.0 4929.5 5602.2 5753.6 5771.2 5775.2 5806.6 4172.4 4191.6 4200.8 4206.8 4220.6 5963.0 6011.5 6030.7 6042.8 6055.6 4105.6 4243.9 4272.0 4272.6 4282.3 4286.5 4328.8 4333.4 4335.3 4346.6 4913.8 4916.3 4929.4 4931.8 4945.1 5579.2 5844.8 5849.5 5856.7 5876.7 1473.6 1491.1 1497.1 1499.9 1500.1 911.4 934.6 935.1 941.4 946.2 4951.3 4958.5 5020.9 5078.8 5160.7 5287.3 5314.6 5356.0 5381.4 5399.9 5084.7 5092.7 5117.2 5349.7 5763.9 3121.4 3183.8 3200.6 3210.2 3220.9 6129.0 6260.6 6265.3 6272.4 6274.6 6048.3 6085.5 6090.6 6093.7 6129.5 6207.7 6224.4 6253.5 6271.3 6287.2 5779.9 5979.3 5987.6 5997.6 6024.2 5892.7 5910.1 5973.2 6023.5 6037.2 6057.3 6236.6 6252.3 6344.5 6345.4 3916.7 4000.0 4090.9 4093.8 4096.8 5891.9 5907.9 5941.5 5961.4 5965.3 5508.0 5740.6 5766.3 5769.8 5796.3 5795.4 5822.6 5835.4 5888.9 5901.7 5750.5 5784.7 5796.3 5805.5 5829.9 5695.4 5866.3 5879.6 5899.9 5909.8 5802.7 5808.2 5812.6 5819.4 5857.9 02:38:26 INFO - PROCESS | 19561 | 02:38:26 INFO - PROCESS | 19561 | [#5] yui.html Cycles:180 Average:18967.45 Median:4665.68 stddev:25950.02 (556.2%) stddev-sans-first:25986.87 02:38:26 INFO - PROCESS | 19561 | Values: 776.6 788.4 801.6 840.3 841.0 14695.4 15760.2 15763.2 15775.1 15856.8 14710.1 14738.6 14744.7 14771.4 14819.0 650.5 770.4 781.9 798.4 801.3 770.6 772.9 774.2 775.0 776.0 839.4 839.6 839.6 839.8 842.6 830.3 835.8 836.2 838.1 839.9 609.1 613.0 613.9 615.0 615.6 14487.7 14573.1 14573.2 14597.6 14619.6 14645.3 15111.9 15151.2 15468.9 15566.6 12286.6 12404.0 12493.5 12507.2 12627.7 3917.4 3927.6 4036.4 4091.1 4092.8 74332.6 74504.6 75381.2 75738.2 78502.0 10520.1 10860.7 11627.5 11976.2 12059.4 20579.6 20858.8 20929.9 20986.1 20987.4 7967.2 8004.2 8024.3 8091.9 8198.2 4599.3 4629.8 4663.9 4667.5 4848.8 3368.4 3440.6 3441.1 3448.6 3449.3 591.9 595.6 604.5 615.1 617.7 563.8 614.1 671.1 681.8 692.5 8154.3 9185.4 9369.8 9460.3 9558.0 598.1 606.8 663.5 765.6 779.7 4550.7 4705.7 4707.6 4943.1 5019.6 62031.4 63590.0 64049.4 64358.0 114060.0 91674.5 93626.5 95527.5 96325.0 96728.5 62333.0 85108.6 85416.0 87364.0 88343.0 8911.4 9172.7 9781.3 10056.7 10220.2 37183.8 37430.6 40416.8 44925.9 47757.3 49509.8 73261.6 73739.6 73849.0 74374.6 13234.8 13237.5 13255.9 13314.3 13360.3 13852.9 13968.2 14108.1 14343.1 14737.3 14102.2 14185.5 14303.1 14448.8 14890.4 13034.2 13510.9 13559.9 13705.8 14343.6 11622.5 13124.8 13199.3 13967.7 14365.6 10873.2 10875.7 10975.5 11300.9 11393.7 11233.2 11548.7 11644.8 11685.8 11722.3 02:38:26 INFO - PROCESS | 19561 | -------- Summary: end -------- 02:38:26 INFO - PROCESS | 19561 | 02:38:27 INFO - TEST-INFO | 19561: exit 0 02:38:27 INFO - TEST-OK | dromaeo_css | took 1110320ms 02:38:27 INFO - TEST-START | kraken 02:38:27 INFO - operating with platform_type : linux_ 02:38:27 INFO - Initialising browser for kraken test... 02:38:27 INFO - TEST-INFO | started process 19795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoI8jje/profile http://localhost:42915/getInfo.html) 02:38:31 INFO - PROCESS | 19795 | __metrics Screen width/height:1600/1200 02:38:31 INFO - PROCESS | 19795 | colorDepth:24 02:38:31 INFO - PROCESS | 19795 | Browser inner width/height: 1024/697 02:38:31 INFO - PROCESS | 19795 | __metrics 02:38:32 ERROR - PROCESS | 19795 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 02:38:33 INFO - TEST-INFO | 19795: exit 0 02:38:33 INFO - Browser initialized. 02:38:33 INFO - Running cycle 1/1 for kraken test... 02:38:33 INFO - TEST-INFO | started process 19918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoI8jje/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:45 INFO - PROCESS | 19918 | RSS: Main: 168460288 02:38:45 INFO - PROCESS | 19918 | 02:38:47 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42915/tests/kraken/driver.html?testName=audio-beat-detection) 02:38:48 INFO - PROCESS | 19918 | RSS: Main: 173785088 02:38:48 INFO - PROCESS | 19918 | 02:38:51 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42915/tests/kraken/driver.html?testName=audio-dft) 02:38:51 INFO - PROCESS | 19918 | RSS: Main: 173273088 02:38:51 INFO - PROCESS | 19918 | 02:38:54 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42915/tests/kraken/driver.html?testName=audio-fft) 02:38:55 INFO - PROCESS | 19918 | RSS: Main: 167653376 02:38:55 INFO - PROCESS | 19918 | 02:38:57 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42915/tests/kraken/driver.html?testName=audio-oscillator) 02:38:58 INFO - PROCESS | 19918 | RSS: Main: 168730624 02:38:58 INFO - PROCESS | 19918 | 02:39:00 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42915/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:39:00 INFO - PROCESS | 19918 | RSS: Main: 168714240 02:39:00 INFO - PROCESS | 19918 | 02:39:04 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42915/tests/kraken/driver.html?testName=imaging-darkroom) 02:39:04 INFO - PROCESS | 19918 | RSS: Main: 168751104 02:39:04 INFO - PROCESS | 19918 | 02:39:08 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42915/tests/kraken/driver.html?testName=imaging-desaturate) 02:39:08 INFO - PROCESS | 19918 | RSS: Main: 170094592 02:39:08 INFO - PROCESS | 19918 | 02:39:11 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42915/tests/kraken/driver.html?testName=json-parse-financial) 02:39:12 INFO - PROCESS | 19918 | RSS: Main: 169754624 02:39:12 INFO - PROCESS | 19918 | 02:39:13 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42915/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:39:14 INFO - PROCESS | 19918 | RSS: Main: 169742336 02:39:14 INFO - PROCESS | 19918 | 02:39:16 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42915/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:39:16 INFO - PROCESS | 19918 | RSS: Main: 169611264 02:39:16 INFO - PROCESS | 19918 | 02:39:18 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42915/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:39:19 INFO - PROCESS | 19918 | RSS: Main: 170078208 02:39:19 INFO - PROCESS | 19918 | 02:39:22 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:39:22 INFO - PROCESS | 19918 | RSS: Main: 170147840 02:39:22 INFO - PROCESS | 19918 | 02:39:25 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:39:26 INFO - PROCESS | 19918 | RSS: Main: 169906176 02:39:26 INFO - PROCESS | 19918 | 02:39:27 INFO - PROCESS | 19918 | Cycle 1(1): loaded http://localhost:42915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42915/tests/kraken/driver.html?testName=ai-astar) 02:39:28 INFO - PROCESS | 19918 | RSS: Main: 170774528 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | __start_tp_report 02:39:28 INFO - PROCESS | 19918 | _x_x_mozilla_page_load 02:39:28 INFO - PROCESS | 19918 | _x_x_mozilla_page_load_details 02:39:28 INFO - PROCESS | 19918 | |i|pagename|runs| 02:39:28 INFO - PROCESS | 19918 | |0;ai-astar;103;111;107;113;111;113;113;112;111;112 02:39:28 INFO - PROCESS | 19918 | |1;audio-beat-detection;149;125;160;178;133;150;153;129;183;128 02:39:28 INFO - PROCESS | 19918 | |2;audio-dft;162;166;162;162;161;164;177;163;162;162 02:39:28 INFO - PROCESS | 19918 | |3;audio-fft;75;76;80;175;77;75;77;75;169;77 02:39:28 INFO - PROCESS | 19918 | |4;audio-oscillator;85;84;150;84;86;85;150;84;84;140 02:39:28 INFO - PROCESS | 19918 | |5;imaging-gaussian-blur;117;118;117;120;117;118;116;117;118;119 02:39:28 INFO - PROCESS | 19918 | |6;imaging-darkroom;146;146;146;147;147;147;148;146;146;147 02:39:28 INFO - PROCESS | 19918 | |7;imaging-desaturate;95;97;96;95;95;96;95;96;105;96 02:39:28 INFO - PROCESS | 19918 | |8;json-parse-financial;55;55;54;57;54;54;53;56;54;53 02:39:28 INFO - PROCESS | 19918 | |9;json-stringify-tinderbox;61;61;61;61;61;61;60;62;61;63 02:39:28 INFO - PROCESS | 19918 | |10;stanford-crypto-aes;83;79;83;85;80;80;80;79;140;80 02:39:28 INFO - PROCESS | 19918 | |11;stanford-crypto-ccm;126;131;127;119;128;126;130;123;126;123 02:39:28 INFO - PROCESS | 19918 | |12;stanford-crypto-pbkdf2;159;160;162;160;162;162;162;160;158;158 02:39:28 INFO - PROCESS | 19918 | |13;stanford-crypto-sha256-iterative;64;64;68;65;63;64;62;69;63;71 02:39:28 INFO - PROCESS | 19918 | __end_tp_report 02:39:28 INFO - PROCESS | 19918 | __start_cc_report 02:39:28 INFO - PROCESS | 19918 | _x_x_mozilla_cycle_collect,885 02:39:28 INFO - PROCESS | 19918 | __end_cc_report 02:39:28 INFO - PROCESS | 19918 | __startTimestamp1467193168013__endTimestamp 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | ------- Summary: start ------- 02:39:28 INFO - PROCESS | 19918 | Number of tests: 14 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.20 (2.9%) stddev-sans-first:1.88 02:39:28 INFO - PROCESS | 19918 | Values: 103.0 111.0 107.0 113.0 111.0 113.0 113.0 112.0 111.0 112.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:151.50 stddev:20.57 (13.6%) stddev-sans-first:21.82 02:39:28 INFO - PROCESS | 19918 | Values: 149.0 125.0 160.0 178.0 133.0 150.0 153.0 129.0 183.0 128.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#2] audio-dft Cycles:10 Average:164.10 Median:162.50 stddev:4.75 (2.9%) stddev-sans-first:4.97 02:39:28 INFO - PROCESS | 19918 | Values: 162.0 166.0 162.0 162.0 161.0 164.0 177.0 163.0 162.0 162.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.50 stddev:40.32 (52.7%) stddev-sans-first:42.07 02:39:28 INFO - PROCESS | 19918 | Values: 75.0 76.0 80.0 175.0 77.0 75.0 77.0 75.0 169.0 77.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:84.00 stddev:30.12 (35.9%) stddev-sans-first:31.22 02:39:28 INFO - PROCESS | 19918 | Values: 85.0 84.0 150.0 84.0 86.0 85.0 150.0 84.0 84.0 140.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:1.16 (1.0%) stddev-sans-first:1.20 02:39:28 INFO - PROCESS | 19918 | Values: 117.0 118.0 117.0 120.0 117.0 118.0 116.0 117.0 118.0 119.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 02:39:28 INFO - PROCESS | 19918 | Values: 146.0 146.0 146.0 147.0 147.0 147.0 148.0 146.0 146.0 147.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:3.03 (3.2%) stddev-sans-first:3.15 02:39:28 INFO - PROCESS | 19918 | Values: 95.0 97.0 96.0 95.0 95.0 96.0 95.0 96.0 105.0 96.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.27 (2.3%) stddev-sans-first:1.33 02:39:28 INFO - PROCESS | 19918 | Values: 55.0 55.0 54.0 57.0 54.0 54.0 53.0 56.0 54.0 53.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 02:39:28 INFO - PROCESS | 19918 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 60.0 62.0 61.0 63.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:80.00 stddev:18.76 (23.5%) stddev-sans-first:19.85 02:39:28 INFO - PROCESS | 19918 | Values: 83.0 79.0 83.0 85.0 80.0 80.0 80.0 79.0 140.0 80.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:126.50 stddev:3.54 (2.8%) stddev-sans-first:3.76 02:39:28 INFO - PROCESS | 19918 | Values: 126.0 131.0 127.0 119.0 128.0 126.0 130.0 123.0 126.0 123.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.00 stddev:1.64 (1.0%) stddev-sans-first:1.67 02:39:28 INFO - PROCESS | 19918 | Values: 159.0 160.0 162.0 160.0 162.0 162.0 162.0 160.0 158.0 158.0 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - PROCESS | 19918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:64.50 stddev:2.98 (4.6%) stddev-sans-first:3.13 02:39:28 INFO - PROCESS | 19918 | Values: 64.0 64.0 68.0 65.0 63.0 64.0 62.0 69.0 63.0 71.0 02:39:28 INFO - PROCESS | 19918 | -------- Summary: end -------- 02:39:28 INFO - PROCESS | 19918 | 02:39:28 INFO - TEST-INFO | 19918: exit 0 02:39:28 INFO - TEST-OK | kraken | took 61355ms 02:39:28 INFO - SUITE-END | took 1171s 02:39:29 INFO - Completed test suite (00:19:31) 02:39:29 INFO - javascript benchmark 02:39:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7343.897801930281, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.9540256896144, 3081.2604974806054, 3101.9534706979384, 3115.2056225662454, 3129.499280115182, 5276.86807829804, 5284.577233821295, 5298.655587386822, 5300.867478313044, 5332.866678333044, 5170.638055336128, 5210.19242017487, 5255.08036093683, 5271.710055946931, 5302.469753024705, 4720.480747117823, 4749.76251187441, 4822.373091498101, 4884.926726099111, 4922.237053256733, 777.5195155404193, 4799.784009719571, 4846.1034708578845, 4870.025994801036, 4880.902381952376, 4743.667943243974, 4762.952370476286, 4781.402324709411, 4782.0435912817575, 4809.086273608021, 4722.8110875564935, 4767.380240568704, 4788.377510923592, 4796.0, 4842.201036828919, 4746.0, 4767.332573439721, 4771.16504611695, 4774.4509381420885, 4792.041591681643, 5228.2680424740565, 5231.895362092737, 5293.894122117575, 5318.388385335697, 5344.599155063347, 5590.636608620467, 5637.323521177444, 5683.886322273532, 5689.943100568983, 5694.9715251423895, 5636.943630563683, 5637.323521177444, 5670.773169073233, 5673.23411339468, 5720.485156335908, 5291.259223708684, 5325.893482130375, 5337.839864804062, 5364.678119312854, 5417.079096553595, 5644.125160600113, 5707.34365547959, 5722.54219662426, 5742.971285143631, 5781.103928891029, 5536.833894983157, 5562.471565201299, 5564.33228012641, 5574.136008918624, 5592.99326121294, 5639.548836093103, 5643.830685079372, 5645.181448689999, 5658.292713410824, 5664.830055098354, 5522.91715624266, 5532.917006244909, 5534.335879694382, 5576.553875690016, 5647.491725744702, 5523.337199536081, 5564.86087847799, 5566.832995010156, 5608.242887210175, 5635.098384258499, 4265.083007153415, 4308.138372325548, 4314.266574682311, 4316.158349121891, 4348.130373925164, 3775.2826962876966, 3821.464994900716, 3851.67260782831, 3861.343571592836, 3880.6507414332846, 5425.213344065089, 5429.0, 5431.348238211361, 5435.483629055233, 5481.5340696041285, 5516.062269414209, 5643.548516118783, 5662.716864156776, 5694.316681998187, 5697.4302569742695, 5426.348838139448, 5452.6183167177915, 5468.425815289417, 5471.6169868108855, 5497.175423686479, 4877.6341774367065, 4918.434380046269, 4919.212925931905, 4923.335349727812, 4962.503749625009, 5743.54051675865, 5787.508061814793, 5920.2303700519515, 5944.3164036136395, 5955.880882382415, 5603.215549822947, 5638.9436105638415, 5662.235598194356, 5668.178114173339, 5698.202251684685, 5823.970880145572, 5826.184334193301, 5827.650340979555, 5838.416158384128, 5850.736716847837, 5460.26286451324, 5519.3652729936575, 5538.030844602259, 5550.666959982414, 5570.19232211319, 5652.915206271827, 5660.264165658438, 5661.773529058792, 5663.546916246608, 5693.117566777156, 5473.31583552056, 5488.121900495901, 5494.80768173112, 5500.22996780443, 5506.201600767786, 5385.3268341457315, 5437.483439073281, 5457.235986961908, 5501.202325662676, 5529.198266251291, 5339.359276886798, 5414.756335964812, 5446.509814116748, 5448.56411487088, 5464.0, 5548.056830338772, 5550.722463876871, 5571.944280557304, 5626.8464964681325, 5628.127640215773, 5259.21111833228, 5418.07892658257, 5482.890342193214, 5500.449955004628, 5509.090999984957], "value": 5181.369579785507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.5056552495903, 600.6756351570152, 628.981130566083, 649.619972316195, 651.2803352295715, 42199.57800421995, 43801.78099109508, 43861.78069109654, 43937.0, 48061.0, 46355.30467042997, 46759.53240467594, 46791.532084679144, 46883.29675054877, 47019.76490117545, 9048.864267036, 9051.547422628842, 9157.313201509913, 9203.95398023009, 9251.491167985758, 8928.508932008737, 9000.504972226558, 9027.187553120219, 9044.321675874337, 9045.095490450967, 9095.499747513884, 9140.405873618227, 9158.587863546156, 9168.449893006407, 9196.034416386283, 9110.635574577009, 9162.725118246462, 9163.770905727344, 9169.495677737721, 9172.770680732969, 8972.147645973622, 8973.327000474925, 8975.820483590356, 9033.77415564616, 9046.638134474679, 44497.77751111224, 44668.0, 44706.32940505895, 44883.0, 44972.3254151188, 3686.981565092184, 3798.772073675588, 3909.4526766252748, 3941.6452519273403, 4336.197803406349, 33193.336133277444, 33279.833600832084, 33646.831765841016, 33669.32661346784, 35020.47469287963, 4421.889452763675, 4519.435070616173, 4524.954750452486, 4532.773361331953, 4554.180247555439, 350462.0, 352151.0, 353479.2326038379, 353659.0, 354184.0, 59979.0, 60235.69882150649, 60286.39713602896, 60663.09005364923, 60762.696186518784, 64448.35551644424, 64574.677126614064, 64606.38484037843, 64819.35180648228, 64829.0, 16482.75275870863, 16686.58283542921, 16741.83258167403, 16745.16274186286, 16840.07379594134, 12886.742265154644, 12890.226586404846, 12891.613251602466, 12918.612441626767, 12925.28910909909, 17493.26321482184, 18636.34772782946, 18648.81351186498, 18667.626647466976, 19031.714524282146, 6507.934920650733, 6656.400923916871, 6767.323267673193, 6778.3221677831825, 6865.382115609619, 1014.4826138669184, 1035.9689209323733, 1078.827024417918, 1143.3025854228913, 1171.2679575265458, 33246.8337658315, 33346.16634584155, 33391.83304083464, 33484.665153348156, 33499.0, 1098.4837126550508, 1147.254284714942, 1154.3535620052796, 1181.0669571038784, 1202.6812894582943, 17455.476335709947, 17492.91253543724, 17624.0, 17674.204660790296, 17804.91097544504, 138844.0, 139310.30344848413, 139757.0, 140278.0, 140400.0, 60099.39900601025, 61167.388326117056, 61300.38699612947, 61369.0, 61383.0, 1349.7772867476954, 1374.3471850870956, 1375.8830499407663, 1388.5001399496173, 1388.5140200929795, 31033.534496983015, 32528.51207231941, 32736.0, 32948.01155965325, 33081.17297067593, 53783.73108134434, 54211.72894135504, 54295.0, 54333.45666543284, 54361.18458223209, 428283.0, 428894.0, 429820.0, 431358.0, 432216.0, 43964.78017609892, 44136.77931610322, 44362.55637443713, 44578.3313250295, 46229.45737984443, 48771.268430974276, 48868.2669759961, 49666.751666241435, 50463.49536504588, 50611.74694126506, 42254.0, 42410.93972650585, 42420.36369454522, 42576.787116064224, 43771.0, 42351.0, 42415.7879210602, 42754.57245427506, 42783.3582496269, 42903.0, 41114.588854111076, 41781.37327940023, 42847.35728964006, 42884.0, 42890.78554607207, 35932.0, 37458.812705936296, 37799.62200377961, 38337.0466179205, 38722.80638596789, 28438.573421398283, 28765.56851647269, 29163.7083629161, 29294.41411171722, 29487.410251795274], "value": 20198.035645747193, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.11391015888057, 389.17883266308087, 395.44440061713306, 395.7674330192865, 405.29681003458995, 14436.350364233609, 18721.81278187221, 19340.51648708783, 19905.203791848344, 20000.699989500168, 18748.718769218438, 19185.23259069639, 19338.903305483487, 19363.903180484114, 19957.201711931506, 5745.827625171241, 6027.758889644431, 7200.639968001605, 7635.809104772369, 7639.0, 6967.233604303523, 7316.670749816271, 7581.507202031878, 7714.961425192866, 7776.7666969990705, 7400.444966627524, 7404.629768511553, 7425.294597013275, 7428.777136685908, 7436.628168591576, 7078.646067696594, 7385.778426647183, 7402.7038918443195, 7403.185649578542, 7419.480636355457, 6962.164540255151, 7068.18715847679, 7084.220735719066, 7241.5293005954445, 7268.890966635505, 21155.788442115536, 21413.036413361435, 23971.880140599358, 24506.142285020116, 25597.872010640014, 2564.525562770875, 2659.973400266011, 2680.67831860178, 2838.9290267743263, 3154.68453154685, 15562.0, 15897.1256580888, 15979.680406391923, 16125.677486450206, 16532.173391330507, 2120.3980099502487, 2129.882856442895, 2171.359448962544, 2205.3383984804495, 2245.6856040154394, 86389.0, 93419.53290233505, 94823.52588237084, 95032.0, 96125.51937240339, 17570.736438953427, 17650.0, 17812.643747124985, 17999.55001124956, 18324.617799685955, 31565.0, 31814.204644884063, 31833.0, 31871.609629277435, 32043.679563204536, 10076.848847267296, 10422.739431514121, 10484.790304193873, 10561.788764224826, 10578.788424231472, 8619.267362274151, 8700.34747393948, 8897.688580899638, 8945.06076861933, 9057.18485336323, 8895.4662720237, 8976.281897448189, 9024.729258122266, 9053.954730226307, 9085.636574537077, 3572.7499075064497, 3646.744727869024, 3648.872289469856, 3666.4133738601695, 3687.9815600921825, 939.6617217801586, 989.7970915962211, 1015.7308313296983, 1036.124474818777, 1057.0486562094177, 18973.810261897204, 18984.525386865163, 19208.71186932197, 19570.0, 19622.607547848962, 1001.6944831826363, 1015.5328548867603, 1021.1116328793848, 1026.3687831983277, 1034.1416624202045, 10464.372137671764, 10925.508352124174, 10931.18016148792, 10959.232853700323, 11006.669799906016, 438555.0, 438876.0, 439708.0, 441113.0, 444273.0, 81207.0, 85540.57229713812, 91342.54328728447, 91694.0, 93054.0, 993.1409330928694, 1024.774549599087, 1053.2890299048113, 1059.0838924330553, 1061.5223149582564, 17319.3938212167, 17452.0, 17804.10979451048, 17851.553711157325, 17901.910490447466, 39539.80230098831, 39948.80025599853, 41030.38454423127, 41556.37665435082, 41942.16115677731, 56048.719756400955, 56073.43926560845, 56194.0, 56407.0, 56724.0, 7977.401694872791, 8375.413721039713, 8396.874046889423, 8413.411061225655, 8472.237498625153, 12824.679383015498, 12886.033547484163, 13129.73740525165, 13182.670433239246, 13197.604071877859, 11585.362805045803, 11696.122790790554, 11716.17986740954, 11811.527538898692, 12201.08491863096, 11158.721031974266, 11226.438678066228, 11389.373584452935, 11406.600768973047, 11465.0, 11944.940275298568, 12137.635870923887, 12207.328596927255, 12266.38668066611, 12355.814662779885, 8450.619722112397, 8513.95743021281, 8547.40168188221, 8666.22004019616, 8762.0, 11234.932681395581, 11953.342566158944, 12005.699857503632, 12041.0, 12047.638570842888], "value": 10532.144405464654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.3038776193548, 1461.6565107199808, 1545.4668139491878, 1748.27446609657, 1754.6841568517661, 7788.571628560427, 8112.269895709385, 8365.58172091396, 8676.436031657939, 8682.088380720028, 8538.10349913258, 8703.129687031294, 8845.115488451152, 8853.070427605106, 8881.689140880071, 2197.9890100549515, 2211.8562293450955, 2232.6092933736613, 2242.024719247133, 2246.5282290718887, 2201.1305534313938, 2203.294945617403, 2233.039792889057, 2246.853954492961, 2251.966220506694, 2207.0, 2217.024509215948, 2219.678146668732, 2224.0992398078806, 2227.0201111510964, 2128.31893793986, 2137.337425398116, 2145.6245157097524, 2160.3842904772223, 2164.0802658870075, 2170.4573856535867, 2185.519185779142, 2196.835237357189, 2196.9231076912392, 2205.162038425388, 8740.431871928367, 8806.339524535686, 8851.690190843354, 8852.0, 8884.600192991331, 4915.992221594564, 5004.224345226496, 5007.649464537484, 5010.599152067826, 5014.448410674823, 2985.462616728988, 3082.445159871222, 3154.747620190379, 3172.0642410488963, 3186.76099292554, 991.8512223166583, 1019.7807471393612, 1023.5752162852407, 1025.2361990317188, 1040.6513817871023, 11644.592439264585, 11650.0, 11661.941690291578, 11691.590794322157, 11697.23967942081, 4254.255505286563, 4398.846040388571, 4479.260921947907, 4481.932771008437, 4525.796339164745, 9938.055884690943, 9951.054649808257, 9959.804823421237, 9983.500824958723, 10012.098911098035, 5129.384473863161, 5142.434332223453, 5142.71715055668, 5148.4851514848215, 5149.2791009258735, 4226.387173859773, 4508.413906192174, 4577.5193604671695, 4657.767111644404, 4684.461286952044, 3999.6400323970984, 4002.0, 4091.85678501251, 4131.173765246963, 4137.77242251673, 1214.3017764785284, 1233.5497543396596, 1240.342618412243, 1246.8316777235138, 1247.2828123828654, 971.9028097190366, 988.9208863290919, 989.7723523589615, 1000.8148492528906, 1009.3136667066466, 6130.601510901777, 6134.6625935573975, 6180.721867515973, 6192.566520343533, 6256.937430625636, 395.80803310394435, 403.86672398108556, 407.22423782693426, 407.76349717164567, 411.31310711112513, 4083.734557253769, 4177.49870015594, 4184.790760461965, 4213.536510983789, 4215.325547912381, 10057.34627249241, 10249.282550221562, 10298.794024119476, 10322.690319290434, 10344.275900687031, 10137.087662110445, 10159.034891685278, 10250.38497690141, 10252.38485690846, 10256.641017564349, 7893.092294386219, 7953.0, 7962.442629016029, 7968.681252749941, 8001.039875215011, 5667.688277144796, 5754.683492407958, 5769.192313076089, 5858.443447872445, 5880.9708301048, 9499.0, 9505.239580833655, 9566.56950437218, 9584.472853993097, 9675.129238368581, 9546.331756777237, 9620.230381569318, 9770.0, 9820.45987470696, 9826.263030272616, 7189.173245076674, 7374.926250737424, 7444.478886477895, 7877.251661092187, 8330.333573314, 8261.793455163668, 8586.82826343457, 8631.309495240492, 8646.82706345882, 8670.653173872974, 7592.126905405949, 7759.107702614272, 7765.0681918170185, 7783.883241751265, 7874.803129921798, 7344.779656610311, 7592.582407967615, 7692.92307076922, 7730.652120654471, 7751.069871615442, 7034.366906978396, 7108.715651373887, 7137.85724285501, 7150.570965742072, 7168.0, 4990.700557966534, 5125.74371281427, 5308.203769434615, 5430.565554755689, 5436.7281635918835, 5226.712530810842, 5239.659422137549, 5261.346118347878, 5281.57747380201, 5366.7584958677735], "value": 4426.360611441473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.33078753473245, 293.9250491124763, 305.9816411015338, 316.552078808486, 319.62603753608306, 5387.218853266284, 5433.8369848904495, 5630.211770352149, 5691.9999999999945, 5710.029295019852, 5389.137737961927, 5432.782688692458, 5457.508824205821, 5498.1752737089355, 5528.861778455531, 4286.464191976003, 4332.155229730204, 4333.58830911063, 4346.9347959780625, 4355.433793606842, 4144.689148313873, 4284.564670835259, 4314.223439780838, 4330.588594083572, 4335.9566404335865, 4274.123804620045, 4276.102018576103, 4277.721948073381, 4287.121140166274, 4289.978550107245, 4282.807273672676, 4288.742675439484, 4291.249031419505, 4294.592013758688, 4300.333448315516, 3687.6128006559193, 3828.674562662177, 3846.0961674006585, 3849.0, 3864.420336949452, 5329.280547126127, 5368.30212072432, 5394.433584473652, 5408.810691625814, 5415.702136382497, 4899.8040078396825, 4908.337374454474, 4924.80300787968, 4927.0, 4929.482404347527, 5602.1596760485845, 5753.568482363839, 5771.220885180489, 5775.191473193756, 5806.5645076619, 4172.415861779354, 4191.559886211934, 4200.768957707325, 4206.810693518799, 4220.620144187038, 5962.999999999956, 6011.458968692795, 6030.698465076729, 6042.848928776772, 6055.5761096723245, 4105.568915263914, 4243.915121697549, 4272.0, 4272.551382104896, 4282.293421585466, 4286.507051689034, 4328.783560822009, 4333.414988976511, 4335.284678028153, 4346.565343465628, 4913.828016019422, 4916.3362946001835, 4929.373306808745, 4931.753412329369, 4945.1346014448045, 5579.19101730255, 5844.772597754434, 5849.5027922626205, 5856.677882716406, 5876.676782776903, 1473.6168596165073, 1491.135141617859, 1497.139144991634, 1499.8725108365911, 1500.0999400359915, 911.4212475078373, 934.6495064350869, 935.1443429262149, 941.3551717073826, 946.2288235088519, 4951.306817045616, 4958.479359667255, 5020.924686129711, 5078.847634570969, 5160.7419629018395, 5287.259783630295, 5314.5748340132695, 5355.973874760748, 5381.354237491526, 5399.865003374947, 5084.703400632815, 5092.745362731848, 5117.181250999822, 5349.705766182898, 5763.924987004675, 3121.4248245197805, 3183.777135600532, 3200.6319273283407, 3210.165357007148, 3220.935581288361, 6129.0, 6260.593061450991, 6265.342139075423, 6272.372762723691, 6274.560780745304, 6048.274207095177, 6085.513158947274, 6090.634561926298, 6093.725782339717, 6129.540284478682, 6207.720652570645, 6224.37756224374, 6253.468455181361, 6271.31015588294, 6287.2140982377205, 5779.942200577941, 5979.312379076462, 5987.550933679904, 5997.640141591519, 6024.246969128859, 5892.734826932712, 5910.143029260647, 5973.223480947449, 6023.45788879003, 6037.18498002764, 6057.303410107894, 6236.563440559117, 6252.3122456530655, 6344.492440604648, 6345.365463453618, 3916.706247031541, 3999.960000399959, 4090.877273681794, 4093.8157782899243, 4096.774677392653, 5891.882162356815, 5907.911381329198, 5941.494972927177, 5961.374055724086, 5965.313988891333, 5508.008558459515, 5740.622250659728, 5766.250387449605, 5769.798057067983, 5796.3190674703865, 5795.362510123968, 5822.621529600562, 5835.358110607915, 5888.882222355443, 5901.704914754159, 5750.482456578928, 5784.739686714024, 5796.275465566804, 5805.506531944832, 5829.883402332014, 5695.373508913934, 5866.266716660418, 5879.647221166743, 5899.882002360015, 5909.8227053188475, 5802.65184088956, 5808.15781711641, 5812.593118481665, 5819.4180581943165, 5857.882842343044], "value": 4384.211702027351, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.5845272779064, 788.4048737755834, 801.5711594297052, 840.3361344537816, 840.9957950210248, 14695.41218351266, 15760.211989400514, 15763.21183940804, 15775.0534967902, 15856.762148567781, 14710.117392956403, 14738.557843264693, 14744.705105897876, 14771.409143634242, 14819.0, 650.4763665249473, 770.3721467004374, 781.8905353250535, 798.3573223555036, 801.2548330053078, 770.5684816502749, 772.8647486689807, 774.1909704358958, 774.9690012399525, 775.9689612415525, 839.353697652807, 839.5508403004394, 839.5550358310105, 839.7984483723893, 842.616609442702, 830.2859540794911, 835.761807884756, 836.2014276366117, 838.1241602525345, 839.8992120945526, 609.1411110334451, 612.996935015322, 613.8557439001876, 614.988344173836, 615.5783288447383, 14487.71024579513, 14573.12561246318, 14573.198474083922, 14597.562073137822, 14619.63450913725, 14645.340959656842, 15111.924440377838, 15151.166685832275, 15468.922655386763, 15566.610834729108, 12286.631401057894, 12404.0, 12493.500259989589, 12507.249565026128, 12627.684307892376, 3917.373220284741, 3927.6268754468565, 4036.4348991141264, 4091.1204091120553, 4092.7517107282265, 74332.62833685851, 74504.6274768628, 75381.24618753852, 75738.24261757368, 78502.0, 10520.053195212467, 10860.72848178786, 11627.476763545661, 11976.161668683282, 12059.397030148457, 20579.58840823205, 20858.791412085684, 20929.89535052315, 20986.0556274968, 20987.370378888656, 7967.203279671987, 8004.239597238253, 8024.277814996562, 8091.919080809116, 8198.180181981754, 4599.2871104978785, 4629.837955671603, 4663.906721865612, 4667.463241727177, 4848.781804818721, 3368.4105281575626, 3440.638732933056, 3441.105312618737, 3448.5516882805073, 3449.292894956528, 591.9230500035054, 595.597971369324, 604.5194070713793, 615.0773839241139, 617.6633734614646, 563.7913971830449, 614.0543562913064, 671.1174805131237, 681.7545683553917, 692.5429216716942, 8154.266116049584, 9185.402948808307, 9369.812603747887, 9460.337776355727, 9557.952210239044, 598.1416667082664, 606.757297081171, 663.4692246203018, 765.6248438265321, 779.7387875061804, 4550.749708765983, 4705.741184234831, 4707.62339012885, 4943.134951383494, 5019.573336266459, 62031.379686203465, 63590.0, 64049.35950640434, 64358.0, 114060.0, 91674.54162729143, 93626.53186734022, 95527.52236238774, 96325.0, 96728.51635741776, 62333.0, 85108.57445712732, 85415.99999999876, 87364.0, 88343.0, 8911.376203665941, 9172.724818255463, 9781.269866497129, 10056.69829905104, 10220.182385409, 37183.81408092942, 37430.6256937438, 40416.79791601023, 44925.87685307893, 47757.283640746115, 49509.75245123752, 73261.63369183333, 73739.63130184315, 73849.0, 74374.62812685902, 13234.801477978031, 13237.536686215935, 13255.867441325463, 13314.334283285603, 13360.331983400985, 13852.86147138556, 13968.19371466249, 14108.082974606617, 14343.139411635335, 14737.263136843329, 14102.153870767786, 14185.503507377192, 14303.141811491343, 14448.783268250774, 14890.404383824525, 13034.217946923214, 13510.93244533771, 13559.932200338935, 13705.794413084011, 14343.56969290923, 11622.476988535705, 13124.803127953279, 13199.340032998503, 13967.720645587235, 14365.569032929028, 10873.238873279111, 10875.673729788119, 10975.451227438756, 11300.94349528247, 11393.658190254306, 11233.213675042669, 11548.711282218012, 11644.825327619923, 11685.824712629148, 11722.296662200295], "value": 7333.356695033745, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.3000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 107.0, 113.0, 111.0, 113.0, 113.0, 112.0, 111.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 160.0, 178.0, 133.0, 150.0, 153.0, 129.0, 183.0, 128.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 162.0, 162.0, 161.0, 164.0, 177.0, 163.0, 162.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 80.0, 175.0, 77.0, 75.0, 77.0, 75.0, 169.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 150.0, 84.0, 86.0, 85.0, 150.0, 84.0, 84.0, 140.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 120.0, 117.0, 118.0, 116.0, 117.0, 118.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 105.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 57.0, 54.0, 54.0, 53.0, 56.0, 54.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 62.0, 61.0, 63.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 83.0, 85.0, 80.0, 80.0, 80.0, 79.0, 140.0, 80.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 127.0, 119.0, 128.0, 126.0, 130.0, 123.0, 126.0, 123.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 162.0, 160.0, 162.0, 162.0, 162.0, 160.0, 158.0, 158.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 65.0, 63.0, 64.0, 62.0, 69.0, 63.0, 71.0], "value": 65.3, "unit": "score"}]}]} 02:39:29 INFO - Return code: 0 02:39:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:39:29 ERROR - # TBPL SUCCESS # 02:39:29 INFO - Running post-action listener: _resource_record_post_action 02:39:29 INFO - ##### 02:39:29 INFO - ##### Finished run-tests step (success) 02:39:29 INFO - ##### 02:39:29 INFO - Running post-run listener: _resource_record_post_run 02:39:29 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 567816192; Read time: 8; Write time: 505924 02:39:29 INFO - TinderboxPrint: CPU usage
13.5% 02:39:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:39:29 INFO - TinderboxPrint: I/O write bytes / time
567,816,192 / 505,924 02:39:29 INFO - TinderboxPrint: CPU idle
8,208.8 (86.5%) 02:39:29 INFO - TinderboxPrint: CPU user
1,223.2 (12.9%) 02:39:29 INFO - TinderboxPrint: Swap in / out
0 / 0 02:39:29 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 270299136; Read time: 0; Write time: 283324 02:39:29 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 297517056; Read time: 0; Write time: 222600 02:39:29 INFO - Running post-run listener: _upload_blobber_files 02:39:29 INFO - Blob upload gear active. 02:39:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:39:29 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 02:39:29 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'] 02:39:29 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 02:39:30 INFO - (blobuploader) - INFO - Open directory for files ... 02:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:31 INFO - (blobuploader) - INFO - Done attempting. 02:39:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:39:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:39:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:35 INFO - (blobuploader) - INFO - Done attempting. 02:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:36 INFO - (blobuploader) - INFO - Done attempting. 02:39:36 INFO - (blobuploader) - INFO - Iteration through files over. 02:39:36 INFO - Return code: 0 02:39:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:39:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:39:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4665e33be150e95e810de259bdbc8b111656318d5b466ebe7b1171130e2efe477bde8451a7823c7ea9a73385f9a6ab6b105a8f1379bfd5ddf745cccd41bc63f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba7584f9cc6d7c6c8efad3aa46e71f0630ad8dfde0fcbd1b94f9e125a86c3c80ed6dd0b018c8c7230c0922ef28dda4f3e63bfc67a22aabd73d96c35eaf24d318", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd0244a68fa920e3a1e8ba8936c1b366ce888587b201b41c735ed6ef37e7ee1381ecb21fa3e3ee6c717f259ef4e2f7cdb46fbe82bc38227e47599ae6ad49fa7a"} 02:39:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:39:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:39:36 INFO - Contents: 02:39:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4665e33be150e95e810de259bdbc8b111656318d5b466ebe7b1171130e2efe477bde8451a7823c7ea9a73385f9a6ab6b105a8f1379bfd5ddf745cccd41bc63f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba7584f9cc6d7c6c8efad3aa46e71f0630ad8dfde0fcbd1b94f9e125a86c3c80ed6dd0b018c8c7230c0922ef28dda4f3e63bfc67a22aabd73d96c35eaf24d318", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd0244a68fa920e3a1e8ba8936c1b366ce888587b201b41c735ed6ef37e7ee1381ecb21fa3e3ee6c717f259ef4e2f7cdb46fbe82bc38227e47599ae6ad49fa7a"} 02:39:36 INFO - Running post-run listener: copy_logs_to_upload_dir 02:39:36 INFO - Copying logs to upload dir... 02:39:36 INFO - mkdir: /builds/slave/test/build/upload/logs 02:39:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.575212 ========= master_lag: 246.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 40 secs) (at 2016-06-29 02:43:42.588401) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-06-29 02:43:42.591963) ========= 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=ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200 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/4665e33be150e95e810de259bdbc8b111656318d5b466ebe7b1171130e2efe477bde8451a7823c7ea9a73385f9a6ab6b105a8f1379bfd5ddf745cccd41bc63f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba7584f9cc6d7c6c8efad3aa46e71f0630ad8dfde0fcbd1b94f9e125a86c3c80ed6dd0b018c8c7230c0922ef28dda4f3e63bfc67a22aabd73d96c35eaf24d318", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd0244a68fa920e3a1e8ba8936c1b366ce888587b201b41c735ed6ef37e7ee1381ecb21fa3e3ee6c717f259ef4e2f7cdb46fbe82bc38227e47599ae6ad49fa7a"} build_url:https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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/4665e33be150e95e810de259bdbc8b111656318d5b466ebe7b1171130e2efe477bde8451a7823c7ea9a73385f9a6ab6b105a8f1379bfd5ddf745cccd41bc63f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba7584f9cc6d7c6c8efad3aa46e71f0630ad8dfde0fcbd1b94f9e125a86c3c80ed6dd0b018c8c7230c0922ef28dda4f3e63bfc67a22aabd73d96c35eaf24d318", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd0244a68fa920e3a1e8ba8936c1b366ce888587b201b41c735ed6ef37e7ee1381ecb21fa3e3ee6c717f259ef4e2f7cdb46fbe82bc38227e47599ae6ad49fa7a"}' ========= master_lag: 2.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-06-29 02:43:44.727708) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:43:44.728062) ========= 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=ed14279e38b05397cf4aa391000001a4-1467190191.417952-49337200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:43:44.941468) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 02:43:44.944831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 02:43:45.595970) ========= ========= Total master_lag: 249.02 =========